Occasional error doing live migrations
-
Hello,
We sometimes see a live-migration initiated through XOA fail. The failure is not immediately visible in XOA itself, but rather it looks like the task has cancelled.
We are migrating within the same pool and we also have local storage.
I've been digging through the xensource.log file (which is very very verbose) and I believe this is the relevant cause of the migration failure:Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||stunnel] stunnel start Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] stunnel pid: 14638 (cached = false) connected to 10.40.1.20:443 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=14638 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||stunnel] stunnel start Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] stunnel pid: 14646 (cached = false) connected to 10.40.1.20:443 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=14646 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||stunnel] stunnel start Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] stunnel pid: 14652 (cached = false) connected to 10.40.1.20:443 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=14652 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Registering mirror id 5c93fb03-318e-93cb-c16d-b0f8deca16f9/58a45bf4-10bc-4dca-a72b-f5cf3110ef80 with task OpaqueRef:ccd4b11a-75d2-4e16-b881-5fa9e6496071 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Waiting for task id=5 to finish Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 507 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 508 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 509 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 510 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 511 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 512 30 Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:52 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 513 30 Mar 7 15:15:56 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","4"] Mar 7 15:15:56 ede-vmh001 xapi: [debug||4350 ||storage_access] Calling UPDATES.get Async.VM.migrate_send R:ccd4b11a75d2 514 30 Mar 7 15:15:58 ede-vmh001 xapi: [debug||4350 ||storage_access] Received update: ["Task","5"] Mar 7 15:16:02 ede-vmh001 xapi: [debug||4350 ||stunnel] stunnel start Mar 7 15:16:02 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] stunnel pid: 15655 (cached = false) connected to 10.40.1.20:443 Mar 7 15:16:02 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=15655 Mar 7 15:16:02 ede-vmh001 xapi: [error||4350 ||xapi_vm_migrate] Failed to destroy remote VDI Mar 7 15:16:05 ede-vmh001 xapi: [debug||4350 ||stunnel] stunnel start Mar 7 15:16:05 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] stunnel pid: 16137 (cached = false) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh001 xapi: [debug||4350 ||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=16137 Mar 7 15:16:05 ede-vmh001 xapi: [error||4350 ||xapi_vm_migrate] Failed to destroy remote VDI Mar 7 15:16:05 ede-vmh001 xapi: [error||4350 ||xapi_vm_migrate] Caught Storage_error ([S(Internal_error);S(Storage_error ([S(Internal_error);S(Db_exn.Read_missing_uuid("VDI", "", "61f0bf5f-7519-4fa6-932c-429e2c58d36d"))]))]): cleaning up Mar 7 15:16:05 ede-vmh001 xapi: [debug||4350 ||xenops] suppressing xenops events on VM: e8c6913e-6aae-e486-571f-70d1791e4a97 Mar 7 15:16:05 ede-vmh001 xapi: [debug||4350 ||xenops] re-enabled xenops events on VM: e8c6913e-6aae-e486-571f-70d1791e4a97; refreshing VM Mar 7 15:16:06 ede-vmh001 xapi: [debug||4350 ||xenops] Client.UPDATES.inject_barrier 12 Mar 7 15:16:06 ede-vmh001 xapi: [ warn||4350 ||rbac_audit] cannot marshall arguments for the action VM.migrate_send: name and value list lengths don't match. str_names=[session_id,vm,dest,live,vdi_map,vif_map,options,vgpu_map,], xml_values=[S(OpaqueRef:fa6be910-d4bd-4992-898b-78018a664b96),S(OpaqueRef:e8b18063-0391-411c-8541-9617e463359b),{SM:S(http://10.40.4.42/services/SM?session_id=OpaqueRef:16db6288-f24f-4f3a-9a08-e25a0871b384);host:S(OpaqueRef:0b95600a-f71c-4acb-b9f4-5fc8ad718f3b);xenops:S(http://10.40.4.42/services/xenops?session_id=OpaqueRef:16db6288-f24f-4f3a-9a08-e25a0871b384);session_id:S(OpaqueRef:16db6288-f24f-4f3a-9a08-e25a0871b384);master:S(http://10.40.1.20/)},B(true),{OpaqueRef:7fc71b20-c2e1-40aa-ac5e-69926cc82a74:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:a9c86b75-7486-43ee-b78f-289b722008dd:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:79234722-e12b-40d6-92d0-692d4bf0e622:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:d2678008-101e-4815-88f6-7800d3dc4259:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:58e643f1-ea92-4100-a25c-cb4e30cd04c0:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:b8528695-c177-44cc-b730-cc047f568815:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:cb2276ab-a046-4152-ab41-7f653db26125:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561);OpaqueRef:fbc37694-1d57-4b64-b7e7-9fe772219f21:S(OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561)},{},{force:S(false)},] Mar 7 15:16:06 ede-vmh001 xapi: [error||4350 ||backtrace] Async.VM.migrate_send R:ccd4b11a75d2 failed with exception Storage_error ([S(Internal_error);S(Storage_error ([S(Internal_error);S(Db_exn.Read_missing_uuid("VDI", "", "61f0bf5f-7519-4fa6-932c-429e2c58d36d"))]))]) Mar 7 15:16:06 ede-vmh001 xapi: [error||4350 ||backtrace] Raised Storage_error ([S(Internal_error);S(Storage_error ([S(Internal_error);S(Db_exn.Read_missing_uuid("VDI", "", "61f0bf5f-7519-4fa6-932c-429e2c58d36d"))]))]) Mar 7 15:16:06 ede-vmh001 xapi: [error||4350 ||backtrace] 1/1 xapi Raised at file (Thread 4350 has no backtrace table. Was with_backtraces called?, line 0
Looking at the destination hypervisor, I can see this in the logs:
Mar 7 15:16:05 ede-vmh023 xapi: [debug||3160 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 23989 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3160 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=23989 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3160 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 23989 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [debug||3161 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 30802 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3161 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=30802 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3161 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 30802 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [debug||3162 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 22558 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3162 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=22558 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3162 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 22558 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [ info||3133 |sm_exec D:ee93e87f13ab|xapi_session] Session.destroy trackid=772a4b57ee6ac04bcb859460339b70a1 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3132 HTTP 127.0.0.1->:::80|Querying services D:e386332a6ca6|storage_impl] dbg:Async.VM.migrate_send R:ccd4b11a75d2 dp:fe0ede4a-7fa3-2d79-2cbb-ef7631557dad sr:20df4650-1ccd-6b78-e41d-a2fabf17385b vdi:287325ca-b764-4c9c-930d-e94c24e99b81 superstate:attached RW Mar 7 15:16:05 ede-vmh023 xapi: [debug||3163 ||dummytaskhelper] task VDI.detach D:743c1af42d91 created by task O:Async.VM.mig Mar 7 15:16:05 ede-vmh023 xapi: [debug||3163 |VDI.detach D:743c1af42d91|sm] SM ext vdi_detach sr=OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561 vdi=OpaqueRef:8a61f43e-64c7-4643-88d0-81cc460f79c1 Mar 7 15:16:05 ede-vmh023 xapi: [ info||3163 |sm_exec D:4765aa6c267e|xapi_session] Session.create trackid=078dcc14e422e2a605c04ba9b0b9366e pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3163 |sm_exec D:4765aa6c267e|xmlrpc_client] stunnel pid: 23989 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3163 |sm_exec D:4765aa6c267e|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=23989 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3163 |sm_exec D:4765aa6c267e|xmlrpc_client] stunnel pid: 23989 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [debug||3164 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 30802 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3164 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=30802 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3164 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 30802 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [debug||3165 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 22558 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3165 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=22558 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3165 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 22558 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [ info||3163 |sm_exec D:4765aa6c267e|xapi_session] Session.destroy trackid=078dcc14e422e2a605c04ba9b0b9366e Mar 7 15:16:05 ede-vmh023 xapi: [debug||3163 ||dummytaskhelper] task VDI.detach D:6439806fd8cd created by task O:Async.VM.mig Mar 7 15:16:05 ede-vmh023 xapi: [debug||3132 HTTP 127.0.0.1->:::80|Querying services D:e386332a6ca6|storage_impl] dbg:Async.VM.migrate_send R:ccd4b11a75d2 dp:fe0ede4a-7fa3-2d79-2cbb-ef7631557dad sr:20df4650-1ccd-6b78-e41d-a2fabf17385b vdi:287325ca-b764-4c9c-930d-e94c24e99b81 superstate:detached Mar 7 15:16:05 ede-vmh023 xapi: [debug||3132 :::80||stunnel] stunnel start Mar 7 15:16:05 ede-vmh023 xapi: [debug||3132 :::80||xmlrpc_client] stunnel pid: 32024 (cached = false) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3132 :::80||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=32024 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3166 :::80||stunnel] stunnel start Mar 7 15:16:05 ede-vmh023 xapi: [debug||3166 :::80||xmlrpc_client] stunnel pid: 32026 (cached = false) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3166 :::80||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=32026 Mar 7 15:16:05 ede-vmh023 xapi: [ info||3166 HTTP 127.0.0.1->:::80|Querying services D:5003e7b1fbce|storage_impl] VDI.destroy dbg:Async.VM.migrate_send R:ccd4b11a75d2 sr:20df4650-1ccd-6b78-e41d-a2fabf17385b vdi:2d5b73c9-8560-4d2a-884f-c445565735df Mar 7 15:16:05 ede-vmh023 xapi: [debug||3167 ||dummytaskhelper] task VDI.destroy D:8fe82e3398a0 created by task O:Async.VM.mig Mar 7 15:16:05 ede-vmh023 xapi: [error||3167 ||backtrace] VDI.destroy D:8fe82e3398a0 failed with exception Storage_access.No_VDI Mar 7 15:16:05 ede-vmh023 xapi: [error||3167 ||backtrace] Raised Storage_access.No_VDI Mar 7 15:16:05 ede-vmh023 xapi: [error||3167 ||backtrace] 1/1 xapi Raised at file (Thread 3167 has no backtrace table. Was with_backtraces called?, line 0 Mar 7 15:16:05 ede-vmh023 xapi: [error||3167 ||backtrace] Mar 7 15:16:05 ede-vmh023 xapi: [error||3167 ||storage_interface] Storage_error ([S(Vdi_does_not_exist);S(2d5b73c9-8560-4d2a-884f-c445565735df)]) (File "storage/storage_interface.ml", line 436, characters 51-58) Mar 7 15:16:05 ede-vmh023 xapi: [error||3166 HTTP 127.0.0.1->:::80|Querying services D:5003e7b1fbce|storage_interface] Storage_error ([S(Vdi_does_not_exist);S(2d5b73c9-8560-4d2a-884f-c445565735df)]) (File "storage/storage_interface.ml", line 431, characters 49-56) Mar 7 15:16:05 ede-vmh023 xapi: [error||3166 HTTP 127.0.0.1->:::80|Querying services D:5003e7b1fbce|storage_interface] Storage_error ([S(Vdi_does_not_exist);S(2d5b73c9-8560-4d2a-884f-c445565735df)]) (File "storage/storage_interface.ml", line 436, characters 51-58) Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|storage_utils] Got failure: checking for redirect, call was: -> VDI.destroy({vdi:S(2d5b73c9-8560-4d2a-884f-c445565735df);sr:S(20df4650-1ccd-6b78-e41d-a2fabf17385b);dbg:S(Async.VM.migrate_send R:ccd4b11a75d2)}), results.contents: ["Vdi_does_not_exist","2d5b73c9-8560-4d2a-884f-c445565735df"] Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|storage_utils] Not a redirect: -> VDI.destroy({vdi:S(2d5b73c9-8560-4d2a-884f-c445565735df);sr:S(20df4650-1ccd-6b78-e41d-a2fabf17385b);dbg:S(Async.VM.migrate_send R:ccd4b11a75d2)}) Mar 7 15:16:05 ede-vmh023 xapi: [error||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|storage_interface] Storage_error ([S(Vdi_does_not_exist);S(2d5b73c9-8560-4d2a-884f-c445565735df)]) (File "storage/storage_interface.ml", line 431, characters 49-56) Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|backtrace] Raised Storage_error ([S(Vdi_does_not_exist);S(2d5b73c9-8560-4d2a-884f-c445565735df)]) Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|backtrace] 1/3 xapi Raised at file storage/storage_interface.ml, line 432 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|backtrace] 2/3 xapi Called from file src/lib/idl.ml, line 558 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|backtrace] 3/3 xapi Called from file lib/debug.ml, line 310 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3131 HTTP 10.40.4.20->:::80|Querying services D:7f3ffc1a6e5f|backtrace] Mar 7 15:16:05 ede-vmh023 xapi: [debug||3166 :::80||stunnel] stunnel start Mar 7 15:16:05 ede-vmh023 xapi: [debug||3166 :::80||xmlrpc_client] stunnel pid: 32033 (cached = false) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3166 :::80||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=32033 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3168 :::80||stunnel] stunnel start Mar 7 15:16:05 ede-vmh023 xapi: [debug||3168 :::80||xmlrpc_client] stunnel pid: 32036 (cached = false) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3168 :::80||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=32036 Mar 7 15:16:05 ede-vmh023 xapi: [ info||3168 HTTP 127.0.0.1->:::80|Querying services D:58b5d0abbacb|storage_impl] VDI.destroy dbg:Async.VM.migrate_send R:ccd4b11a75d2 sr:20df4650-1ccd-6b78-e41d-a2fabf17385b vdi:287325ca-b764-4c9c-930d-e94c24e99b81 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3169 ||dummytaskhelper] task VDI.destroy D:059771f03d0a created by task O:Async.VM.mig Mar 7 15:16:05 ede-vmh023 xapi: [debug||3169 |VDI.destroy D:059771f03d0a|sm] SM ext vdi_delete sr=OpaqueRef:44ae5260-b2f3-4b79-849d-40d3ee497561 vdi=OpaqueRef:8a61f43e-64c7-4643-88d0-81cc460f79c1 Mar 7 15:16:05 ede-vmh023 xapi: [ info||3169 |sm_exec D:07c441429744|xapi_session] Session.create trackid=67cec2a98474155b4800921bb5683d73 pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3169 |sm_exec D:07c441429744|xmlrpc_client] stunnel pid: 23989 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3169 |sm_exec D:07c441429744|xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=23989 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3169 |sm_exec D:07c441429744|xmlrpc_client] stunnel pid: 23989 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [debug||3170 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 30802 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3170 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=30802 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3170 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 30802 (cached = true) returned stunnel to cache Mar 7 15:16:05 ede-vmh023 xapi: [debug||3171 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 22558 (cached = true) connected to 10.40.1.20:443 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3171 /var/lib/xcp/xapi||xmlrpc_client] with_recorded_stunnelpid task_opt=None s_pid=22558 Mar 7 15:16:05 ede-vmh023 xapi: [debug||3171 /var/lib/xcp/xapi||xmlrpc_client] stunnel pid: 22558 (cached = true) returned stunnel to cache
It doesn´t consistently happen, i.e. I can just retry the migration and it will work, but we aren't sure why it happens.
Does anyone have any idea? -