Migration error 9.5.4 to 10.3.1

[Red Paint]

Hello,

We are trying to migrate from Plesk 9.5 to Plesk 10.3 and we keep getting the following error in pmmcli.log:

23048: 2011-10-11 12:11:38,766 DEBUG --> <pmmcli.MigrationGetObjectsListAction object at 0xe5df10>
23048: 2011-10-11 12:11:38,766 INFO parameters: ['20111011121136184']
23048: 2011-10-11 12:11:38,766 INFO stdin: <agent-to-use>PleskX</agent-to-use>
23048: 2011-10-11 12:11:38,769 INFO Packet succesfully validated.
23048: 2011-10-11 12:11:38,770 DEBUG <pmmcli.ActionRunner object at 0xe5ded0>: doActivity
23048: 2011-10-11 12:11:38,772 INFO Executing <subprocess[23049] '/usr/local/psa/admin/bin/migration-handler --migration-get-objects-list 20111011121136184'>
23048: 2011-10-11 12:11:55,914 INFO Subprocess raised ExecuteException: Subprocess <subprocess[23049] '/usr/local/psa/admin/bin/migration-handler --migration-get-objects-list 20111011121136184'> was finished with exit code 1
== STDOUT ====================
<?xml version="1.0" encoding="UTF-8"?>
<response>
<errcode>1001</errcode>
<errmsg>Runtime error in migration handler:
&lt;class 'xml.sax._exceptions.SAXParseException'&gt; /usr/local/psa/PMM/msessions/20111011121136184/dump.xml:1:0: no element found
Traceback (most recent call last):
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 1624, in main
data_action_response, errcode_response, error_message = actions.get(sys.argv[1][2:])(parameters)
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 1423, in migration_get_objects_list
return MigrationHandlerActionRunner(MigrationGetObjectsListAction, agent_to_use, migration_session_id).doActivity()
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 100, in doActivity
result = self.processor.doActivity()
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 344, in doActivity
objects_list_object = service.getObjectsList(self.__agent_to_use, agent_dir)
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service_impl.py", line 108, in getObjectsList
objects_list = self.makeObjectsListFromDump(agent_name)
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service_impl.py", line 118, in makeObjectsListFromDump
parser.parse(dump_path)
File "/usr/lib64/python2.6/xml/sax/expatreader.py", line 107, in parse
xmlreader.IncrementalParser.parse(self, source)
File "/usr/lib64/python2.6/xml/sax/xmlreader.py", line 125, in parse
self.close()
File "/usr/lib64/python2.6/xml/sax/expatreader.py", line 217, in close
self.feed("", isFinal = 1)
File "/usr/lib64/python2.6/xml/sax/expatreader.py", line 211, in feed
self._err_handler.fatalError(exc)
File "/usr/lib64/python2.6/xml/sax/handler.py", line 38, in fatalError
raise exception
SAXParseException: /usr/local/psa/PMM/msessions/20111011121136184/dump.xml:1:0: no element found
</errmsg>
</response>

== STDERR ====================

23048: 2011-10-11 12:11:55,915 CRITICAL PMMUtility exception:
Subprocess <subprocess[23049] '/usr/local/psa/admin/bin/migration-handler --migration-get-objects-list 20111011121136184'> was finished with exit code 1
== STDOUT ====================
<?xml version="1.0" encoding="UTF-8"?>
<response>
<errcode>1001</errcode>
<errmsg>Runtime error in migration handler:
&lt;class 'xml.sax._exceptions.SAXParseException'&gt; /usr/local/psa/PMM/msessions/20111011121136184/dump.xml:1:0: no element found
Traceback (most recent call last):
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 1624, in main
data_action_response, errcode_response, error_message = actions.get(sys.argv[1][2:])(parameters)
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 1423, in migration_get_objects_list
return MigrationHandlerActionRunner(MigrationGetObjectsListAction, agent_to_use, migration_session_id).doActivity()
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 100, in doActivity
result = self.processor.doActivity()
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 344, in doActivity
objects_list_object = service.getObjectsList(self.__agent_to_use, agent_dir)
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service_impl.py", line 108, in getObjectsList
objects_list = self.makeObjectsListFromDump(agent_name)
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service_impl.py", line 118, in makeObjectsListFromDump
parser.parse(dump_path)
File "/usr/lib64/python2.6/xml/sax/expatreader.py", line 107, in parse
xmlreader.IncrementalParser.parse(self, source)
File "/usr/lib64/python2.6/xml/sax/xmlreader.py", line 125, in parse
self.close()
File "/usr/lib64/python2.6/xml/sax/expatreader.py", line 217, in close
self.feed("", isFinal = 1)
File "/usr/lib64/python2.6/xml/sax/expatreader.py", line 211, in feed
self._err_handler.fatalError(exc)
File "/usr/lib64/python2.6/xml/sax/handler.py", line 38, in fatalError
raise exception
SAXParseException: /usr/local/psa/PMM/msessions/20111011121136184/dump.xml:1:0: no element found
</errmsg>
</response>

== STDERR ====================

== STDERR ====================

Traceback (most recent call last):
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 2118, in main
data_action_response, errcode_response, error_message = actions.get(sys.argv[1][2:])(parameters)
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 2022, in migration_get_objects_list
return ActionRunner(MigrationGetObjectsListAction, migration_task_description, migration_session_id).doActivity()
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 150, in doActivity
result = self.processor.doActivity()
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 1587, in doActivity
return pmm_migration_handler.MigrationHandler.migrationGetObjectsList( self.__migration_session_id ,self.__agent_to_use.getValueOf_() )
File "/usr/local/psa/admin/share/pmmcli/pmm_migration_handler.py", line 211, in migrationGetObjectsList
return MigrationHandler.callMigrationHandlerWithResponse('--migration-get-objects-list', session_id = migration_session_id, input_str = agent_to_use)
File "/usr/local/psa/admin/share/pmmcli/pmm_migration_handler.py", line 511, in callMigrationHandlerWithResponse
raise PMMUtilityException('migration_handler', x)
PMMUtilityException: was finished with exit code 1

23048: 2011-10-11 12:11:55,916 INFO Outgoing packet:
<?xml version="1.0" encoding="UTF-8"?>
<response>
<errcode>1000</errcode>
<errmsg>pmm utility 'migration_handler' raised an exception. Error code is: 1
See pmmcli.log to find out detailed information on this</errmsg>
</response>

I've searched through the forums and can't find anything that relates to this issue. What could the problem be and does anyone have any ideas on how we can fix it?

Many thanks

 

[Red Paint]

Looking at the logs in more detail it seems the migration scripts are buggy. This is a FreeBSD system.

Specifically

ulimit: Command not found.

and more importantly

df: illegal option -- B

portion of the log:

[04:00:00|DEBG:24945.Ssh] remote stderr -> [27542]: 03:00:02 INFO FileFinder: pwd resolved to /bin/pwd
ulimit: Command not found.
[27542]: 03:00:02 INFO ------------------------------------------------------------
[27542]: 03:00:02 INFO FILE storage initialized.
[27542]: 03:00:02 INFO Base directory: /var/cache/20111012035941853
[27542]: 03:00:02 INFO Space reserved: 10485760
[27542]: 03:00:02 INFO Gzip bundles: yes
[27542]: 03:00:02 INFO Bundle split size: do not split
[27542]: 03:00:02 INFO ------------------------------------------------------------
df: illegal option -- B
usage: df [-b | -g | -H | -h | -k | -m | -P] [-aciln] [-t type] [file | filesystem ...]
[27542]: 03:00:02 DEBUG Unable to create dump: Died at HelpFuncs.pm line 213, <VERSION> line 1.
at HelpFuncs.pm line 213
HelpFuncs::getMountSpace('/var/cache/20111012035941853') called at Storage/FileStorage.pm line 58
Storage::FileStorage::reserveSpace('Storage::FileStorage=HASH(0x8a319b0)') called at Storage/FileStorage.pm line 44
Storage::FileStorage::_init('Storage::FileStorage=HASH(0x8a319b0)', 'gzip_bundle', 1, 'output_dir', '/var/cache/20111012035941853', 'split_size', undef, 'sign', undef, ...) called at Storage/Storage.pm line 9
Storage::Storage::new('Storage::FileStorage', 'gzip_bundle', 1, 'output_dir', '/var/cache/20111012035941853', 'split_size', undef, 'sign', undef, ...) called at Storage/Storage.pm line 126
Storage::Storage::createFileStorage(1, '/var/cache/20111012035941853', undef, undef, 10485760) called at /var/cache/20111012035941853/PleskX.pl line 145
eval {...} called at /var/cache/20111012035941853/PleskX.pl line 143
main::main() called at /var/cache/20111012035941853/PleskX.pl line 274

[27542]: 03:00:02 ERROR ea71f689-a462-4b86-862f-78236e4a2d26 Unable to create dump:
at Logging.pm line 84
Logging::error('Unable to create dump', 'fatal') called at /var/cache/20111012035941853/PleskX.pl line 260
main::main() called at /var/cache/20111012035941853/PleskX.pl line 274


[04:00:00|DEBG:24945.Ssh] Execution finished with return code 0
[04:00:00|DEBG:24945.libssh2pp.Channel] Closed
[04:00:00|DEBG:24945.Ssh] Reading data to the file /usr/local/psa/PMM/msessions/20111012035941853/dump.xml
[04:00:00|DEBG:24945.Ssh] Reading data from the remote file /var/cache/20111012035941853/dump.xml
[04:00:00|DEBG:24945.Ssh] Executing cat /var/cache/20111012035941853/dump.xml on the remote host
[04:00:00|DEBG:24945.libssh2pp.Session] Opening SSH channel for command 'cat /var/cache/20111012035941853/dump.xml'
[04:00:00|DEBG:24945.Ssh] Execution finished with return code 1
[04:00:00|DEBG:24945.libssh2pp.Channel] Closed
[04:00:00|DEBG:24945.libssh2pp.Session] SSH session finished
[04:00:00|INFO:24945.log] Launchpad finished. Exit code: 0

Does anyone from Parallels read these forums?

 

[IgorG]

Try to replace /usr/local/psa/PMM/agents/shared/HelpFuncs.pm on destination server with attached file.

 

[Red Paint]

Hello Igor,

I've replaced /usr/local/psa/PMM/agents/shared/HelpFuncs.pm on the destination server but each new attempt seems to be using the old HelpFuncs.pm (verified by looking at the source code for line 213). Is this cached somewhere or should I be replacing HelpFuncs.pm on the source server as well??

Thanks
Andy

 

[IgorG]

No, replacing only on destination server should be enough.

 

[Red Paint]

Is there a cache or other source of HelpFuncs.pm that could be preventing the modified file from taking affect?

 

[IgorG]

Do not understand what do you mean? This file is a part of psa-backup-manager package and there is no any cache or something else. For example:

# rpm -qf /usr/local/psa/PMM/agents/shared/HelpFuncs.pm
psa-backup-manager-10.12.0-cos5.build1012110629.18

 

[Red Paint]

Sorry, my mistake, got mixed up between source and destination on SSH.

 

[IgorG]

And how it goes on?

 

[Red Paint]

I'm just waiting for another rsync operation to end before I can run this. I've tried but it comes back with Error: Rsync is not available on the source host ... this is definitely better than the previous error and seems to suggest it might just work. I'll update this post later today once rsync is freed up to test.

Thank you for your help so far; it's very much appreciated.

 

[Red Paint]

Hello Igor,

We had to upgrade the version of rsync on the source server but the migration wizard is now running. However it's been sitting at 0% for 44 minutes and I think that perhaps something has gone wrong.

I've had a look at the following posts: http://forum.parallels.com/showthread.php?t=91450 AND http://forum.parallels.com/showthread.php?t=101083 but neither applies. However the second post did make me think that perhaps our licence key could be an issue(?). We are migrating from our 9.5.4 licence key over to a trial licence key ... could this cause the migration to hang?

Many thanks
Andy

 

[Red Paint]

Hello,

Quick update, the migration manager seems to be running correctly now. After making a clean install of rsync on the source server we also needed to open up the appropriate ports on the firewall and modify the SSH settings in /etc/ssh/sshd_config to allow for a longer timeout and ensure all other settings were correct.

Will update this thread if migration fails for any reason.

Thanks for your help Igor.

 

[Red Paint]

Hello Igor,

Migration is stalling at 55% and looking at the log we have several errors, one of which is this:

[18:51:50|DEBG:15362.Ssh] Reading data to the file /usr/local/psa/PMM/msessions/20111013183634673/dumping-status.xml.tmp
[18:51:50|DEBG:15362.Ssh] Reading data from the remote file /var/cache/20111013183634673/dumping-status.xml
[18:51:50|DEBG:15362.Ssh] Executing cat /var/cache/20111013183634673/dumping-status.xml on the remote host
[18:51:50|DEBG:15362.libssh2pp.Session] Opening SSH channel for command 'cat /var/cache/20111013183634673/dumping-status.xml'
[18:51:50|DEBG:15362.Ssh] Execution finished with return code 0
[18:51:50|DEBG:15362.libssh2pp.Channel] Closed
[18:51:55|DEBG:15362.Ssh] remote stderr -> du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
[80955]: 17:51:50 TRACE SQL: SELECT * FROM sys_users WHERE id=159
[80955]: 17:51:50 TRACE Making system user node: work_jamie
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]
du: illegal option -- b
usage: du [-H | -L | -P] [-a | -s | -d depth] [-c] [-h | -k | -m] [-n] [-x] [-I mask] [file ...]

I'm not sure where du --b is specified .. any thoughts?

Also there is an illegal operation at the start of the migration log:

grep: /etc/cron.d: No such file or directory

in FreeBSD the equivalent should be

/etc/rc.d/cron

could this be causing problems?

 

[yusuf1990]

help please


Error: Runtime error in pmmcli:
exceptions.AttributeError 'ExportDumpAsFileAction' object has no attribute 'unsetProcess'
Traceback (most recent call last):
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 1423, in main
data_action_response, errcode_response, error_message = actions.get(sys.argv[1][2:])(parameters)
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 1305, in export_dump_as_file
return ActionRunner(ExportDumpAsFileAction, src_dst_files_specification, None).doActivity()
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 67, in doActivity
result = self.processor.doActivity()
File "/usr/local/psa/admin/share/pmmcli/pmmcli.py", line 287, in doActivity
proc = cmd.spawn()
File "/usr/local/psa/admin/lib/python/subproc.py", line 246, in spawn
self.process_handler.unsetProcess(self.proc)
AttributeError: 'ExportDumpAsFileAction' object has no attribute 'unsetProcess'