Plesk Migration Fails: 9.5.4 -> 10.4.4

[A.P]

I'm getting frustrated by the Plesk migration function. You'd think that it should be straightforward to migrate between two versions as close as 9.5.4 and 10.4.4. Not so. It seems to run fine until it reaches about the 7% or so mark and then it just stops with a 'Failed' status update. The error I found in the migration log file seems to indicate that execution stopped due to---

. . . . .

<response>
<errcode>1001</errcode>
<errmsg>Runtime error in migration handler:
subproc.NonzeroExitException was finished with exit code 2
Traceback (most recent call last):
File "/usr/local/psa/admin/share/migration-handler/migration_handler.py", line 1682, 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 1582, in migration_start
return MigrationHandlerActionRunner(MigrationStartAction, None, 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 916, in doActivity
service.backup(migration_session.getValue('agent_name'), migration_session.getValue('agent_dir'))
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service.py", line 97, in backup
self.backupImpl(agent_name, agent_dir)
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service_impl.py", line 83, in backupImpl
self.runCmdLine(cmd)
File "/usr/local/psa/admin/share/migration-handler/pmm_migr_remote_service.py", line 55, in runCmdLine
self.session.runWorker(cmd)
File "/usr/local/psa/admin/share/migration-handler/migration_handler_session.py", line 322, in runWorker
cmd.spawn()
File "/usr/local/psa/admin/lib/python/subproc.py", line 240, in spawn
self.proc.run()
File "/usr/local/psa/admin/lib/python/subproc.py", line 185, in run
BaseSubprocess.run(self)
File "/usr/local/psa/admin/lib/python/subproc.py", line 169, in run
self.wait()
File "/usr/local/psa/admin/lib/python/subproc.py", line 193, in wait
BaseSubprocess.wait(self)
File "/usr/local/psa/admin/lib/python/subproc.py", line 179, in wait
raise NonzeroExitException(self, self.__retcode)
NonzeroExitException: was finished with exit code 2
</errmsg>
</response>

6659: 2012-04-17 00:49:06,489 DEBUG --> <migration_handler.MigrationGetTaskStatusAction object at 0xb7acf78c>
6659: 2012-04-17 00:49:06,489 INFO parameters: ['20120417004602861']
6659: 2012-04-17 00:49:06,492 DEBUG <migration_handler.MigrationHandlerActionRunner object at 0xb7acf9ec>: doActivity
6659: 2012-04-17 00:49:06,498 WARNING Session data object file '/usr/local/psa/PMM/msessions/20120417004602861/status_mixed' does not exist
6659: 2012-04-17 00:49:06,498 WARNING Session data value file '/usr/local/psa/PMM/msessions/20120417004602861/migration-result-name' does not exist
6659: 2012-04-17 00:49:06,498 WARNING Session data object file '/usr/local/psa/PMM/msessions/20120417004602861/transfer_status' does not exist
6659: 2012-04-17 00:49:06,498 WARNING Session data object file '/usr/local/psa/PMM/msessions/20120417004602861/restore_task_status' does not exist
6659: 2012-04-17 00:49:06,499 WARNING Session data value file '/usr/local/psa/PMM/msessions/20120417004602861/restore_task_id' does not exist
6659: 2012-04-17 00:49:06,516 DEBUG <migration_handler.MigrationGetTaskStatusAction object at 0xb7acf78c>: response
6659: 2012-04-17 00:49:06,517 INFO Outgoing packet:


. . . .

From the log, it appears that it's failing specifically due to the error:

File "/usr/local/psa/admin/lib/python/subproc.py", line 179, in wait
raise NonzeroExitException(self, self.__retcode)
NonzeroExitException: was finished with exit code 2

I'm not sure where to begin to resolve the problem, so, any and all help will be mostly appreciated! Help, please!

Thanks!
..a.

 

[IgorG]

You can try to debug it more deeply with help of following KB article http://kb.parallels.com/en/9679
Also look at article http://kb.parallels.com/en/6349

 

[A.P]

Thanks, Igor,

I ran the tool suggested in the link, and from one of the files generated (migration.log) it seems the root authentication succeeds. However when it attempt to remotely execute 'cat', it fails:

. . . .
[01:05:14|DEBG: 7212:p.libssh2pp.Socket] Connected
[01:05:14|DEBG: 7212:p.libssh2pp.Session] Trying to start SSH session
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Selected aes256-cbc encryption method
[01:05:15|DEBG: 7212:p.libssh2pp.Session] SSH session started successfully
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Requested authorization for user root
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Getting userauth methods for user 'root'
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Got the following allowed userauth methods: publickey,password,keyboard-interactive
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Trying 'password' authentication
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Authenticated succesfully
[01:05:15|DEBG: 7212:p.Ssh] Reading data from the remote file /var/cache/20120417005929136/dumping-status.xml
[01:05:15|DEBG: 7212:p.Ssh] Executing cat /var/cache/20120417005929136/dumping-status.xml on the remote host
[01:05:15|DEBG: 7212:p.libssh2pp.Session] Opening SSH channel for command 'cat /var/cache/20120417005929136/dumping-status.xml'
[01:05:16|DEBG: 7212:p.Ssh] Execution finished with return code 0
[01:05:16|DEBG: 7212:p.libssh2pp.Channel] Closed
[01:05:16|DEBG: 7212:p.libssh2pp.Session] SSH session finished
[01:05:16|INFO: 7212:p.log] Launchpad finished. Exit code: 0
[01:05:19|DEBG: 7051:p.Ssh] Reading data to the file /usr/local/psa/PMM/msessions/20120417005929136/dumping-status.xml.tmp
[01:05:19|DEBG: 7051:p.Ssh] Reading data from the remote file /var/cache/20120417005929136/dumping-status.xml
[01:05:19|DEBG: 7051:p.Ssh] Executing cat /var/cache/20120417005929136/dumping-status.xml on the remote host
[01:05:19|DEBG: 7051:p.libssh2pp.Session] Opening SSH channel for command 'cat /var/cache/20120417005929136/dumping-status.xml'
[01:05:19|DEBG: 7051:p.Ssh] Execution finished with return code 0
[01:05:19|DEBG: 7051:p.libssh2pp.Channel] Closed
[01:05:22|DEBG: 7051:p.libssh2pp.Channel] Closed
[01:05:22|DEBG: 7051:p.libssh2pp.Session] SSH session finished
[01:05:22|INFO: 7051:p.log] CantRetrieveDump[c5ea7abc-15e4-4c62-83ed-48736b004aa8^@]: Error during dump retrieval [./actions.cpp:331]
virtual void plesk::RetrieveDumpAction::execute()
Inner exception:
SshConnectionFault[11e2c057-a137-48e7-88b0-a9fd4da9a94c^@]: Lost connection with the remote host [./libssh2pp.h:100]
int plesk::libssh2pp::Channel::poll(int)
[01:05:22|INFO: 7051:p.log] Launchpad finished. Exit code: 2

Any idea on how to resolve this?

Thanks,
...a.

 

[IgorG]

SshConnectionFault[11e2c057-a137-48e7-88b0-a9fd4da9a94c^@]: Lost connection with the remote host

Looks like some network problems... Try to check it from this side?

 

[A.P]

Thanks, Igor.

And, do you mean you can check the connectivity from your side? If so, that'll be great! Or, if I'm not quite understanding you, then can you please explain what "check it from this side?" means?

Alternatively, is it likely that the connection wait timeout is too short? If so, how do I increase it to make it wait longer before timing out?

Best,
...a.

 

[IgorG]

Sorry for misunderstanding. I meant that you may check network connection between servers. Actually, it can be related to some timeouts or routing rules or something else.

 

[A.P]

I tried running the commands that fail in the log file manually, and there was no problem connecting by ssh from the new to the old server, and no problem executing the 'cat' command where the connection failure occurs. So, what now? Any tips on how to proceed from here?

Thanks,
...a.

 

[A.P]

I hope you're still there, Igor ... or anyone else with advice --

I've given on using the migration manager since, from the manual tests I ran, there's no connection problem I can find between the old and new server. In short ssh and wget, etc. all work fine without a hitch ... except when I try to use the plesk migration function.

So, I'm now trying to do a manual migration per the article I found at http://www.parallels.com/fileadmin/parallels/documents/support/plesk/plesk-10-migration-guide.pdf (page 41)

For starters, I'm testing it for one client only to see if it proceeds to completion. I successfully did a dump of the client information on the old server and successfully copied the dump.xml (listed in content-list.xml) to the new server.

However, when I try the next step listed which is, from the destination server, start a new migration with the option of 'Transfer data already processed by the migration agent and located on the local host'. It goes nowhere and I get this error message instead:

Error: Dump does not exist in repository

I know the directory and the files do exist on the destination. So, this error message is completely unhelpful. Any ideas what the problem is now, or how to debug it?

Thanks,
...a.

 

[A.P]

An update -- I've just found out that "Migration data file location" field wants the file name, not just the directory (i.e. not {dump_file_dir} but {dump_file_fir}/dump.xml)

With that, the error message is gone, but now it does not display anything at all. It seems to execute and then jumps back to the home screen of the Plesk console without any message whatsoever. And a check shows that nothing was done or migrated. This is a most frustrating console software! Any and all help appreciated.

...a.