XCP-ng's dom0 configuration is tuned for performance and reliability. Configuration changes which are not explicitly documented or approved by XCP-ng's technical support, may not have been tested, are therefore not supported, and may not persist after a system update or upgrade. Please consult XCP-ng's technical support for advice regarding configuration changes or the installation of specific tools. Type "xsconsole" for access to the management console. [15:29 r530-n1 ~]# bash -c "$(wget -qO- https://xoa.io/deploy)" 👋 Welcome to the XOA auto-deploy script! ⚙️ STEP 1: XOA configuration Network settings: IP address? [dhcp] Your XOA will be started using DHCP xoa SSH account: Password? (disabled if empty) xoa account is disabled, to enable it later see https://xen-orchestra.com/docs/troubleshooting.html#set-or-recover-xoa-vm-password 📥 STEP 2: XOA Download Importing XOA VM: this might take a while... % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 100 30301 100 30301 0 0 134k 0 --:--:-- --:--:-- --:--:-- 134k Auto deploy failed. Please contact us on help@vates.fr for assistance. Error: The VM could not be imported; the end of the file was reached prematurely. [15:35 r530-n1 ~]# Oct 4 15:33:10 r530-n1 xapi: [ info||2176 /var/lib/xcp/xapi|post_cli|cli] xe vm-import url=(omitted) username=root password=(omitted) Oct 4 15:33:10 r530-n1 xapi: [ info||2176 /var/lib/xcp/xapi|session.login_with_password D:cfdd983d9165|xapi_session] Session.create trackid=2d0b97841ac361d7c0b3e38d2364f310 pool=false uname=root originator=cli is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:10 r530-n1 xapi: [debug||2177 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:977ef39820b1 created by task D:cfdd983d9165 Oct 4 15:33:10 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|audit] VM.import: url = '(url filtered)' sr='OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88' force='false' Oct 4 15:33:10 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Failed to directly open the archive; trying gzip Oct 4 15:33:10 r530-n1 xapi: [debug||2178 ||import] Writing initial buffer Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Got XML Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 host(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 SR(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 VDI(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2179 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.create D:4ba3e179f1d8 created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [ info||2179 /var/lib/xcp/xapi|dispatch:VDI.create D:4ba3e179f1d8|taskhelper] task VDI.create R:301e8d0b4eab (uuid:748bc637-72bd-85f1-29f9-0b1bb18efa59) created (trackid=2d0b97841ac361d7c0b3e38d2364f310) by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2179 /var/lib/xcp/xapi|VDI.create R:301e8d0b4eab|audit] VDI.create: SR = 'be4e8362-f4e1-b5eb-2122-2930b2c6371d (Local storage)'; name label = 'xoa root' Oct 4 15:33:11 r530-n1 xapi: [debug||2179 /var/lib/xcp/xapi|VDI.create R:301e8d0b4eab|message_forwarding] Marking SR for VDI.create (task=OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8) Oct 4 15:33:11 r530-n1 xapi: [ info||2179 /var/lib/xcp/xapi|OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8|mux] VDI.create dbg:OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8 sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi_info:{"sm_config":{"import_task":"OpaqueRef:a0a41b4c-07c1-3652-8c6c-58163abfb520"},"sharable":false,"persistent":true,"physical_utilisation":0,"virtual_size":21474836480,"cbt_enabled":false,"read_only":false,"snapshot_of":"","snapshot_time":"19700101T00:00:00Z","is_a_snapshot":false,"metadata_of_pool":"","ty":"user","name_description":"","name_label":"xoa root","content_id":"","vdi":""} Oct 4 15:33:11 r530-n1 xapi: [ info||2180 |OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8|Storage_smapiv1_wrapper] VDI.create dbg:OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8 sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi_info:{"sm_config":{"import_task":"OpaqueRef:a0a41b4c-07c1-3652-8c6c-58163abfb520"},"sharable":false,"persistent":true,"physical_utilisation":0,"virtual_size":21474836480,"cbt_enabled":false,"read_only":false,"snapshot_of":"","snapshot_time":"19700101T00:00:00Z","is_a_snapshot":false,"metadata_of_pool":"","ty":"user","name_description":"","name_label":"xoa root","content_id":"","vdi":""} Oct 4 15:33:11 r530-n1 xapi: [debug||2180 |OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8|dummytaskhelper] task VDI.create D:d27f34727c20 created by task R:301e8d0b4eab Oct 4 15:33:11 r530-n1 xapi: [debug||2180 |VDI.create D:d27f34727c20|sm] SM ext vdi_create sr=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 sm_config=[import_task=OpaqueRef:a0a41b4c-07c1-3652-8c6c-58163abfb520] type=[user] size=21474836480 Oct 4 15:33:11 r530-n1 xapi: [ info||2180 |sm_exec D:c4054d679e48|xapi_session] Session.create trackid=dcc409169c2e1332b3cc8d366f87e0a5 pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:11 r530-n1 xapi: [debug||2181 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:558de9a46315 created by task D:c4054d679e48 Oct 4 15:33:11 r530-n1 xapi: [debug||2182 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_other_config D:3f31007704c1 created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2183 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:89db08f66eb2 created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2184 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.db_introduce D:f77ec28f087d created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [ info||2184 /var/lib/xcp/xapi|dispatch:VDI.db_introduce D:f77ec28f087d|taskhelper] task VDI.db_introduce R:210eaaf13623 (uuid:7d1b9740-0a2c-4f67-6510-2be85e9724f4) created (trackid=dcc409169c2e1332b3cc8d366f87e0a5) by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2184 /var/lib/xcp/xapi|VDI.db_introduce R:210eaaf13623|xapi_vdi] {pool,db}_introduce uuid=550123a8-bce5-483c-bd87-1f37697990d0 name_label=xoa root Oct 4 15:33:11 r530-n1 xapi: [debug||2184 /var/lib/xcp/xapi|VDI.db_introduce R:210eaaf13623|xapi_vdi] VDI.introduce read_only = false Oct 4 15:33:11 r530-n1 xapi: [debug||2185 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_virtual_allocation D:e350c30b2c6c created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2186 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_by_uuid D:13a50bb4a709 created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2187 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.set_virtual_allocation D:b5445d216569 created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2188 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.set_physical_size D:94e9a85c304f created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [debug||2189 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.set_physical_utilisation D:66f9925153f3 created by task D:d27f34727c20 Oct 4 15:33:11 r530-n1 xapi: [ info||2180 |sm_exec D:c4054d679e48|xapi_session] Session.destroy trackid=dcc409169c2e1332b3cc8d366f87e0a5 Oct 4 15:33:11 r530-n1 xapi: [debug||2179 /var/lib/xcp/xapi|VDI.create R:301e8d0b4eab|xapi_sr] OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d snapshot_of <- OpaqueRef:NULL Oct 4 15:33:11 r530-n1 xapi: [debug||2179 /var/lib/xcp/xapi|VDI.create R:301e8d0b4eab|message_forwarding] Unmarking SR after VDI.create (task=OpaqueRef:301e8d0b-4eab-2852-f1a6-e074db152cf8) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 VM_guest_metrics(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 VM(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2190 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VM.create D:4ed9e59517a6 created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [ info||2190 /var/lib/xcp/xapi|dispatch:VM.create D:4ed9e59517a6|taskhelper] task VM.create R:edce983f48c0 (uuid:f65880bd-bee6-51a8-d704-926e272c2f47) created (trackid=2d0b97841ac361d7c0b3e38d2364f310) by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2190 /var/lib/xcp/xapi|VM.create R:edce983f48c0|audit] VM.create: name_label = 'XOA' name_description = 'Xen Orchestra virtual Appliance' Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Created VM: OpaqueRef:954c127e-1d9e-92fa-284e-2c323911419d (was Ref:272) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 network(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2191 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:network.get_by_name_label D:8fb9bd78ac9e created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 GPU_group(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 VBD(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2192 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.create D:34b6c9d27c58 created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [ info||2192 /var/lib/xcp/xapi|dispatch:VBD.create D:34b6c9d27c58|taskhelper] task VBD.create R:ebaa59a0e832 (uuid:8de39059-c307-c33a-57cd-23681d8d6fda) created (trackid=2d0b97841ac361d7c0b3e38d2364f310) by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2192 /var/lib/xcp/xapi|VBD.create R:ebaa59a0e832|audit] VBD.create: VM = 'aafb4349-e391-885d-221e-f23468dcd2b0 (XOA)'; VDI = '550123a8-bce5-483c-bd87-1f37697990d0' Oct 4 15:33:11 r530-n1 xapi: [debug||2192 /var/lib/xcp/xapi|VBD.create R:ebaa59a0e832|vbdops] Checking whether there's a migrate in progress... Oct 4 15:33:11 r530-n1 xapi: [debug||2192 /var/lib/xcp/xapi|VBD.create R:ebaa59a0e832|vbdops] VBD.create (device = 0; uuid = bdd7ca93-9e06-85ba-73f2-77ec1b0617b4; ref = OpaqueRef:741a04a9-bf11-facc-632d-7ce2071ffbf7) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 1 VIF(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2193 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VIF.create D:1f9fc986978b created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [ info||2193 /var/lib/xcp/xapi|dispatch:VIF.create D:1f9fc986978b|taskhelper] task VIF.create R:5a15444a87b2 (uuid:e1e0ef23-f143-a941-ce47-a8f791e25455) created (trackid=2d0b97841ac361d7c0b3e38d2364f310) by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2193 /var/lib/xcp/xapi|VIF.create R:5a15444a87b2|audit] VIF.create: VM = 'aafb4349-e391-885d-221e-f23468dcd2b0 (XOA)'; network = 'caf8439d-034d-b8d3-53f6-aa2adfc49c70' Oct 4 15:33:11 r530-n1 xapi: [debug||2193 /var/lib/xcp/xapi|VIF.create R:5a15444a87b2|xapi_vif_helpers] VIF.create running Oct 4 15:33:11 r530-n1 xapi: [debug||2193 /var/lib/xcp/xapi|VIF.create R:5a15444a87b2|xapi_vif_helpers] Found mac_seed on VM: supplied MAC parameter = '' Oct 4 15:33:11 r530-n1 xapi: [debug||2193 /var/lib/xcp/xapi|VIF.create R:5a15444a87b2|xapi_vif_helpers] VIF ref='OpaqueRef:fa46c4f3-f035-2e2f-68a8-05ccd041e098' created (VM = 'OpaqueRef:954c127e-1d9e-92fa-284e-2c323911419d'; MAC address = '6a:12:d5:0f:dc:d6') Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 VGPU_type(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 VGPU(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 PVS_site(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 PVS_proxy(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Importing 0 VTPM(s) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] lookup for parent = 'OpaqueRef:NULL' Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] no parent found Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type VIF: external ref: Ref:273 internal ref: OpaqueRef:fa46c4f3-f035-2e2f-68a8-05ccd041e098 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type VBD: external ref: Ref:275 internal ref: OpaqueRef:741a04a9-bf11-facc-632d-7ce2071ffbf7 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type network: external ref: Ref:274 internal ref: OpaqueRef:62d9a168-06e4-d5f7-5428-7c2cb9842634 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type VM: external ref: Ref:272 internal ref: OpaqueRef:954c127e-1d9e-92fa-284e-2c323911419d Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type VM_guest_metrics: external ref: Ref:278 internal ref: OpaqueRef:2b1ab2a1-c7a8-0337-bf60-0ca611945ae6 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type VDI: external ref: Ref:276 internal ref: OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Imported object type SR: external ref: Ref:277 internal ref: OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Expecting to import VDI Ref:276 into OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d (size=21474836480) Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] begun import of VDI preserving sparseness Oct 4 15:33:11 r530-n1 xapi: [debug||2194 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.create D:1b234912c6bc created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [ info||2194 /var/lib/xcp/xapi|dispatch:VBD.create D:1b234912c6bc|taskhelper] task VBD.create R:f178ad6e0aeb (uuid:bac73dd5-56f5-8cc0-be95-6a873185fd96) created (trackid=2d0b97841ac361d7c0b3e38d2364f310) by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2194 /var/lib/xcp/xapi|VBD.create R:f178ad6e0aeb|audit] VBD.create: VM = 'c0bae481-5d40-4447-8ea3-88933cda3223 (Control domain on host: r530-n1)'; VDI = '550123a8-bce5-483c-bd87-1f37697990d0' Oct 4 15:33:11 r530-n1 xapi: [debug||2194 /var/lib/xcp/xapi|VBD.create R:f178ad6e0aeb|vbdops] Checking whether there's a migrate in progress... Oct 4 15:33:11 r530-n1 xapi: [debug||2194 /var/lib/xcp/xapi|VBD.create R:f178ad6e0aeb|vbdops] VBD.create (device = 0; uuid = c61546e5-0625-df73-2c38-9bf56de506ee; ref = OpaqueRef:cb144bb0-494e-6462-9ec4-b56cfc18db57) Oct 4 15:33:11 r530-n1 xapi: [debug||2195 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.get_uuid D:948e26251c6a created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2196 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VM.get_uuid D:1a45b2e961d0 created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|attach_helpers] created VBD (uuid c61546e5-0625-df73-2c38-9bf56de506ee); attempting to hotplug to VM (uuid: c0bae481-5d40-4447-8ea3-88933cda3223) Oct 4 15:33:11 r530-n1 xapi: [debug||2197 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.plug D:af415e02b615 created by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [ info||2197 /var/lib/xcp/xapi|dispatch:VBD.plug D:af415e02b615|taskhelper] task VBD.plug R:decaedff2ac7 (uuid:d6dd34f1-7889-edcd-7bd1-421237f1ddaf) created (trackid=2d0b97841ac361d7c0b3e38d2364f310) by task R:a0a41b4c07c1 Oct 4 15:33:11 r530-n1 xapi: [debug||2197 /var/lib/xcp/xapi|VBD.plug R:decaedff2ac7|audit] VBD.plug: VBD = 'c61546e5-0625-df73-2c38-9bf56de506ee' Oct 4 15:33:11 r530-n1 xapi: [debug||2197 /var/lib/xcp/xapi|VBD.plug R:decaedff2ac7|vbdops] VBD.plug of loopback VBD 'OpaqueRef:cb144bb0-494e-6462-9ec4-b56cfc18db57' Oct 4 15:33:11 r530-n1 xapi: [ info||2197 /var/lib/xcp/xapi|OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|mux] VDI.attach3 dbg:OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 vm:0 read_write:true Oct 4 15:33:11 r530-n1 xapi: [ info||2199 |OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|Storage_smapiv1_wrapper] VDI.attach3 dbg:OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 vm:0 read_write:true Oct 4 15:33:11 r530-n1 xapi: [debug||2199 |OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|dummytaskhelper] task VDI.attach2 D:184d7da67c55 created by task R:decaedff2ac7 Oct 4 15:33:11 r530-n1 xapi: [debug||2199 |VDI.attach2 D:184d7da67c55|sm] SM ext vdi_attach sr=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 vdi=OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d writable=true Oct 4 15:33:11 r530-n1 xapi: [ info||2199 |sm_exec D:edb0c4cdefa1|xapi_session] Session.create trackid=92c6cff2756ac63a3cbbc5af7959b713 pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:11 r530-n1 xapi: [debug||2201 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:ce101fe1e5d4 created by task D:edb0c4cdefa1 Oct 4 15:33:11 r530-n1 xapi: [debug||2202 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:0a4e69577539 created by task D:defc7f3461a7 Oct 4 15:33:11 r530-n1 xapi: [ info||2202 /var/lib/xcp/xapi|session.logout D:2c189bb85318|xapi_session] Session.destroy trackid=0830acaf91685b5d9389ef7ab0ca8508 Oct 4 15:33:11 r530-n1 xapi: [debug||256 |watching networks for NBD-related changes D:defc7f3461a7|network_event_loop] Not updating the firewall, because the set of interfaces to use for NBD did not change: [] Oct 4 15:33:11 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|xenops] Event on VM c0bae481-5d40-4447-8ea3-88933cda3223; resident_here = true Oct 4 15:33:11 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|dummytaskhelper] task timeboxed_rpc D:a2125d9704ba created by task D:8b2bb83d909e Oct 4 15:33:11 r530-n1 xapi: [debug||2203 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:6b1c1404bd04 created by task D:8b2bb83d909e Oct 4 15:33:12 r530-n1 xapi: [debug||2204 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_other_config D:da6fbaa3b9c2 created by task D:184d7da67c55 Oct 4 15:33:12 r530-n1 xapi: [debug||2205 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:c250c039b2a0 created by task D:184d7da67c55 Oct 4 15:33:12 r530-n1 xapi: [debug||2206 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:c4206e656cf5 created by task D:184d7da67c55 Oct 4 15:33:12 r530-n1 xapi: [debug||2207 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_other_config D:098007adfa56 created by task D:184d7da67c55 Oct 4 15:33:12 r530-n1 xapi: [debug||2208 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all_records D:d93bc43942ff created by task D:184d7da67c55 Oct 4 15:33:12 r530-n1 xapi: [ info||2199 |sm_exec D:edb0c4cdefa1|xapi_session] Session.destroy trackid=92c6cff2756ac63a3cbbc5af7959b713 Oct 4 15:33:12 r530-n1 xapi: [debug||2199 |VDI.attach2 D:184d7da67c55|dummytaskhelper] task VDI.attach2 D:caea4e872e91 created by task R:decaedff2ac7 Oct 4 15:33:12 r530-n1 xapi: [debug||2199 |OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|Storage_smapiv1_wrapper] dbg:OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 superstate:attached RW Oct 4 15:33:12 r530-n1 xapi: [ info||2197 /var/lib/xcp/xapi|OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|mux] VDI.activate3 dbg:OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 vm:0 Oct 4 15:33:12 r530-n1 xapi: [ info||2197 /var/lib/xcp/xapi|OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|mux] The VDI was attached read/write: calling activate3 Oct 4 15:33:12 r530-n1 xapi: [ info||2209 |OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|Storage_smapiv1_wrapper] VDI.activate3 dbg:OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 vm:0 Oct 4 15:33:12 r530-n1 xapi: [debug||2209 |OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|dummytaskhelper] task VDI.activate D:249ab6437106 created by task R:decaedff2ac7 Oct 4 15:33:12 r530-n1 xapi: [debug||2209 |VDI.activate D:249ab6437106|dummytaskhelper] task VDI.activate D:67a60d5fbc3f created by task R:decaedff2ac7 Oct 4 15:33:12 r530-n1 xapi: [debug||2209 |VDI.activate D:249ab6437106|sm] SM ext vdi_activate sr=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 vdi=OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d Oct 4 15:33:12 r530-n1 xapi: [ info||2209 |sm_exec D:4fddc732068a|xapi_session] Session.create trackid=4ac5308bae02d464640db94ea0fceee3 pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:12 r530-n1 xapi: [debug||2210 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:fcdb92c6494b created by task D:4fddc732068a Oct 4 15:33:12 r530-n1 xapi: [debug||2211 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_other_config D:97e256e63611 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2212 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:fb887aa9ce1a created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2213 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:a9238f55b423 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2214 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:781f14bd8089 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2215 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_by_uuid D:3b46ccaf8cd6 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2216 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_sm_config D:1f53cbe1c72d created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2217 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.add_to_sm_config D:79d820026511 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2217 /var/lib/xcp/xapi|dispatch:VDI.add_to_sm_config D:79d820026511|api_effect] VDI.add_to_sm_config Oct 4 15:33:12 r530-n1 xapi: [debug||2218 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.add_to_sm_config D:dc51f0d850d9 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2218 /var/lib/xcp/xapi|dispatch:VDI.add_to_sm_config D:dc51f0d850d9|api_effect] VDI.add_to_sm_config Oct 4 15:33:12 r530-n1 xapi: [debug||2219 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_sm_config D:ba0e92a0028d created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2220 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:8899e4a59634 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2221 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_SR D:9b422c047e2d created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2222 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_uuid D:fda843036cbd created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2223 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_by_uuid D:ab25762fcf95 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2224 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_type D:79dfc61b2833 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2225 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SM.get_all_records_where D:6880a0603ca8 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2226 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SM.get_driver_filename D:8ea53cd26414 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2227 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VM.get_all_records_where D:0de21fe40ac6 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2228 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:PBD.get_all_records_where D:c7791bff044c created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2229 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:PBD.get_device_config D:16396cb737fc created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [ info||2234 /var/lib/xcp/xapi|session.login_with_password D:48d40eef7046|xapi_session] Session.create trackid=4cbe67fe640cce19dc1bd2c758d59720 pool=false uname=root originator=SM is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:12 r530-n1 xapi: [debug||2235 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:d83e07d14481 created by task D:48d40eef7046 Oct 4 15:33:12 r530-n1 xapi: [ info||2243 /var/lib/xcp/xapi|session.logout D:465a28ba3662|xapi_session] Session.destroy trackid=4cbe67fe640cce19dc1bd2c758d59720 Oct 4 15:33:12 r530-n1 xapi: [debug||2244 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all_records D:1b4286bee658 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2245 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:013d24677805 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2246 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_other_config D:36e4d71db500 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2247 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:b6b34c696487 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2248 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.remove_from_sm_config D:7782f0009360 created by task D:249ab6437106 Oct 4 15:33:12 r530-n1 xapi: [debug||2248 /var/lib/xcp/xapi|dispatch:VDI.remove_from_sm_config D:7782f0009360|api_effect] VDI.remove_from_sm_config Oct 4 15:33:13 r530-n1 xapi: [ info||2209 |sm_exec D:4fddc732068a|xapi_session] Session.destroy trackid=4ac5308bae02d464640db94ea0fceee3 Oct 4 15:33:13 r530-n1 xapi: [debug||2209 |OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e|Storage_smapiv1_wrapper] dbg:OpaqueRef:decaedff-2ac7-c2e8-6c25-6b9ee1891d4e dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 superstate:activated RW Oct 4 15:33:13 r530-n1 xapi: [debug||2197 /var/lib/xcp/xapi|VBD.plug R:decaedff2ac7|vbdops] device path: sm/backend/be4e8362-f4e1-b5eb-2122-2930b2c6371d/550123a8-bce5-483c-bd87-1f37697990d0 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] with_open_vdi opening: /dev/sm/backend/be4e8362-f4e1-b5eb-2122-2930b2c6371d/550123a8-bce5-483c-bd87-1f37697990d0 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00000065 last_suffix=00000001 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00000129 last_suffix=00000066 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00000194 last_suffix=00000130 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00000954 last_suffix=00000194 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00000990 last_suffix=00000960 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001006 last_suffix=00001002 Oct 4 15:33:13 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001014 last_suffix=00001009 Oct 4 15:33:14 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001082 last_suffix=00001068 Oct 4 15:33:14 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001086 last_suffix=00001082 Oct 4 15:33:16 r530-n1 xapi: [debug||2249 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:738fdc428711 created by task D:defc7f3461a7 Oct 4 15:33:16 r530-n1 xapi: [ info||2249 /var/lib/xcp/xapi|session.slave_login D:af10d2d3cb5f|xapi_session] Session.create trackid=69abd0863e9bc368d68e7286527a5f28 pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:16 r530-n1 xapi: [debug||2250 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:5605a7485c5a created by task D:af10d2d3cb5f Oct 4 15:33:16 r530-n1 xapi: [debug||2251 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:3502d2342e27 created by task D:defc7f3461a7 Oct 4 15:33:18 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001344 last_suffix=00001338 Oct 4 15:33:19 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001396 last_suffix=00001394 Oct 4 15:33:19 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001402 last_suffix=00001398 Oct 4 15:33:20 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001450 last_suffix=00001447 Oct 4 15:33:21 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001514 last_suffix=00001511 Oct 4 15:33:21 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001594 last_suffix=00001529 Oct 4 15:33:21 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00001850 last_suffix=00001594 Oct 4 15:33:21 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00002106 last_suffix=00001850 Oct 4 15:33:21 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00002874 last_suffix=00002106 Oct 4 15:33:23 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00003034 last_suffix=00003003 Oct 4 15:33:23 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00003130 last_suffix=00003036 Oct 4 15:33:28 r530-n1 xapi: [debug||2252 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:ec02010e91a8 created by task D:0da6eaffa36c Oct 4 15:33:28 r530-n1 xapi: [ info||2252 /var/lib/xcp/xapi|session.logout D:39f04734ab5e|xapi_session] Session.destroy trackid=4306845351aa1752b9341950ec206efb Oct 4 15:33:28 r530-n1 xapi: [debug||2253 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:6ed1255a2e29 created by task D:0da6eaffa36c Oct 4 15:33:28 r530-n1 xapi: [ info||2253 /var/lib/xcp/xapi|session.slave_login D:7d5811995229|xapi_session] Session.create trackid=7d8148af6da6f0aeb0a18dcd5cfaa5d2 pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:28 r530-n1 xapi: [debug||2254 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:1dd59e05895e created by task D:7d5811995229 Oct 4 15:33:28 r530-n1 xapi: [debug||2255 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:758f67343747 created by task D:0da6eaffa36c Oct 4 15:33:32 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00004154 last_suffix=00003641 Oct 4 15:33:32 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00004410 last_suffix=00004154 Oct 4 15:33:32 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00004794 last_suffix=00004410 Oct 4 15:33:38 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00005082 last_suffix=00005051 Oct 4 15:33:39 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00005146 last_suffix=00005112 Oct 4 15:33:39 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00005178 last_suffix=00005161 Oct 4 15:33:41 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00006680 last_suffix=00005305 Oct 4 15:33:41 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00006971 last_suffix=00006680 Oct 4 15:33:43 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00007131 last_suffix=00007099 Oct 4 15:33:43 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00007195 last_suffix=00007188 Oct 4 15:33:44 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00007231 last_suffix=00007227 Oct 4 15:33:46 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00008783 last_suffix=00007354 Oct 4 15:33:46 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00009148 last_suffix=00008783 Oct 4 15:33:46 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00009276 last_suffix=00009148 Oct 4 15:33:49 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00010904 last_suffix=00009403 Oct 4 15:33:49 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00011197 last_suffix=00010904 Oct 4 15:33:49 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00011229 last_suffix=00011197 Oct 4 15:33:49 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00011325 last_suffix=00011231 Oct 4 15:33:49 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00011329 last_suffix=00011325 Oct 4 15:33:56 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00012988 last_suffix=00011452 Oct 4 15:33:56 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00013118 last_suffix=00012988 Oct 4 15:33:59 r530-n1 xapi: [debug||2256 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:6e29b865a62c created by task D:0da6eaffa36c Oct 4 15:33:59 r530-n1 xapi: [ info||2256 /var/lib/xcp/xapi|session.logout D:4d4288276555|xapi_session] Session.destroy trackid=7d8148af6da6f0aeb0a18dcd5cfaa5d2 Oct 4 15:33:59 r530-n1 xapi: [debug||2257 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:66b8bdf7fe8a created by task D:0da6eaffa36c Oct 4 15:33:59 r530-n1 xapi: [ info||2257 /var/lib/xcp/xapi|session.slave_login D:bb212bfe4c35|xapi_session] Session.create trackid=1e7b6ad738d244671910a278e6ee27cb pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:33:59 r530-n1 xapi: [debug||2258 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:ed70c06750a3 created by task D:bb212bfe4c35 Oct 4 15:33:59 r530-n1 xapi: [debug||2259 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:1e61a72d0765 created by task D:0da6eaffa36c Oct 4 15:34:02 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00013278 last_suffix=00013246 Oct 4 15:34:02 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|stream_vdi] suffix=00013374 last_suffix=00013278 Oct 4 15:34:12 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|dummytaskhelper] task timeboxed_rpc D:52ada70711fa created by task D:8b2bb83d909e Oct 4 15:34:12 r530-n1 xapi: [debug||2260 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:c59be36fc024 created by task D:8b2bb83d909e Oct 4 15:34:14 r530-n1 xapi: [debug||2178 ||import] Written a total of 512 + 931871197 bytes Oct 4 15:34:14 r530-n1 xapi: [error||2178 ||xapi_compression] nice failed to decompress: exit code 1 Oct 4 15:34:29 r530-n1 xapi: [debug||2261 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:386e0321c82f created by task D:0da6eaffa36c Oct 4 15:34:29 r530-n1 xapi: [ info||2261 /var/lib/xcp/xapi|session.logout D:894b3db1ea81|xapi_session] Session.destroy trackid=1e7b6ad738d244671910a278e6ee27cb Oct 4 15:34:29 r530-n1 xapi: [debug||2262 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:336a4b2eade0 created by task D:0da6eaffa36c Oct 4 15:34:29 r530-n1 xapi: [ info||2262 /var/lib/xcp/xapi|session.slave_login D:ad4382831f14|xapi_session] Session.create trackid=0838d98b3e034789567907303157fbaa pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:34:29 r530-n1 xapi: [debug||2263 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:c443a8843173 created by task D:ad4382831f14 Oct 4 15:34:29 r530-n1 xapi: [debug||2264 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:72543250e3ba created by task D:0da6eaffa36c Oct 4 15:35:00 r530-n1 xapi: [debug||2267 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:86d52ccc9f86 created by task D:0da6eaffa36c Oct 4 15:35:00 r530-n1 xapi: [ info||2267 /var/lib/xcp/xapi|session.logout D:266473b1a746|xapi_session] Session.destroy trackid=0838d98b3e034789567907303157fbaa Oct 4 15:35:00 r530-n1 xapi: [debug||2268 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:56031b312f00 created by task D:0da6eaffa36c Oct 4 15:35:00 r530-n1 xapi: [ info||2268 /var/lib/xcp/xapi|session.slave_login D:ca0a9244fa7f|xapi_session] Session.create trackid=a9e40c9436f0cbeb27f4a2449b29445e pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:00 r530-n1 xapi: [debug||2269 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:e450b34ef86c created by task D:ca0a9244fa7f Oct 4 15:35:00 r530-n1 xapi: [debug||2270 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:00e75d83c4ce created by task D:0da6eaffa36c Oct 4 15:35:04 r530-n1 xapi: [debug||2271 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:fa4846e4bb36 created by task R:a0a41b4c07c1 Oct 4 15:35:04 r530-n1 xapi: [ info||2271 /var/lib/xcp/xapi|session.slave_login D:ab5c99d26474|xapi_session] Session.create trackid=b27a95a10bb5346d156adaa4ad871724 pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:04 r530-n1 xapi: [debug||2272 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:ba2df084d682 created by task D:ab5c99d26474 Oct 4 15:35:04 r530-n1 xapi: [debug||2273 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.unplug D:905fce6b0893 created by task R:a0a41b4c07c1 Oct 4 15:35:04 r530-n1 xapi: [ info||2273 /var/lib/xcp/xapi|dispatch:VBD.unplug D:905fce6b0893|taskhelper] task VBD.unplug R:fb0cf6cd662a (uuid:5c0189be-15fb-4166-83d5-d388cbc7a83a) created (trackid=b27a95a10bb5346d156adaa4ad871724) by task R:a0a41b4c07c1 Oct 4 15:35:04 r530-n1 xapi: [debug||2273 /var/lib/xcp/xapi|VBD.unplug R:fb0cf6cd662a|audit] VBD.unplug: VBD = 'c61546e5-0625-df73-2c38-9bf56de506ee' Oct 4 15:35:04 r530-n1 xapi: [debug||2273 /var/lib/xcp/xapi|VBD.unplug R:fb0cf6cd662a|vbdops] VBD.unplug of loopback VBD 'OpaqueRef:cb144bb0-494e-6462-9ec4-b56cfc18db57' Oct 4 15:35:04 r530-n1 xapi: [ info||2273 /var/lib/xcp/xapi|OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|mux] DP.destroy dbg:OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a dp:vbd/0/xvda allow_leak:false Oct 4 15:35:04 r530-n1 xapi: [ info||2273 /var/lib/xcp/xapi|OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|mux] DP.destroy2 dbg:OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 vm:0 allow_leak:false Oct 4 15:35:04 r530-n1 xapi: [ info||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] DP.destroy2 dbg:OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 vm:0 allow_leak:false Oct 4 15:35:04 r530-n1 xapi: [ info||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] DP.destroy dbg:OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a dp:vbd/0/xvda allow_leak:false Oct 4 15:35:04 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] [destroy_sr] Filtered VDI count:1 Oct 4 15:35:04 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] [destroy_sr] VDI found with the dp is 550123a8-bce5-483c-bd87-1f37697990d0 Oct 4 15:35:04 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|dummytaskhelper] task VDI.deactivate D:9ed88505c1d9 created by task R:fb0cf6cd662a Oct 4 15:35:04 r530-n1 xapi: [debug||2275 |VDI.deactivate D:9ed88505c1d9|dummytaskhelper] task VDI.deactivate D:4c321410518b created by task R:fb0cf6cd662a Oct 4 15:35:04 r530-n1 xapi: [debug||2275 |VDI.deactivate D:9ed88505c1d9|sm] SM ext vdi_deactivate sr=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 vdi=OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d Oct 4 15:35:04 r530-n1 xapi: [ info||2275 |sm_exec D:4038185b00b4|xapi_session] Session.create trackid=2bd6588fd0c9bc61f4e7257a1fb4de2a pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:04 r530-n1 xapi: [debug||2277 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:fbfe4f0c92de created by task D:4038185b00b4 Oct 4 15:35:04 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|xenops] Event on VM c0bae481-5d40-4447-8ea3-88933cda3223; resident_here = true Oct 4 15:35:04 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|dummytaskhelper] task timeboxed_rpc D:f26756810ad4 created by task D:8b2bb83d909e Oct 4 15:35:04 r530-n1 xapi: [debug||2278 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:a6973b2edb8c created by task D:8b2bb83d909e Oct 4 15:35:04 r530-n1 xapi: [debug||2279 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_other_config D:70edce83b010 created by task D:9ed88505c1d9 Oct 4 15:35:04 r530-n1 xapi: [debug||2280 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:f330ea253b48 created by task D:9ed88505c1d9 Oct 4 15:35:04 r530-n1 xapi: [debug||2281 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:983d480cca4c created by task D:9ed88505c1d9 Oct 4 15:35:04 r530-n1 xapi: [debug||2282 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_sm_config D:e1119b1b0ec6 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2283 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:eff503fa2284 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2284 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_SR D:5f0332db33f2 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2285 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_uuid D:787a555d3c10 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2286 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_by_uuid D:890fe60f225b created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2287 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_type D:912a11a94d1d created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2288 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SM.get_all_records_where D:85de16b744f5 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2289 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SM.get_driver_filename D:0973b738edca created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2290 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VM.get_all_records_where D:17fea166e974 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2291 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:PBD.get_all_records_where D:b5ff5ea03275 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2292 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:PBD.get_device_config D:da463df727d6 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [ info||2295 /var/lib/xcp/xapi|session.login_with_password D:20f5e3717a0e|xapi_session] Session.create trackid=3cfc4230a2c07508d488f5f729a7e72c pool=false uname=root originator=SM is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:05 r530-n1 xapi: [debug||2296 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:7f89b91666aa created by task D:20f5e3717a0e Oct 4 15:35:05 r530-n1 xapi: [ info||2304 /var/lib/xcp/xapi|session.logout D:da9293473bf5|xapi_session] Session.destroy trackid=3cfc4230a2c07508d488f5f729a7e72c Oct 4 15:35:05 r530-n1 xapi: [debug||2305 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:34004f7739b1 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2306 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_by_uuid D:0db0ef353176 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2307 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_sm_config D:53bd572cdcfa created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2308 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.remove_from_sm_config D:6afd56f48503 created by task D:9ed88505c1d9 Oct 4 15:35:05 r530-n1 xapi: [debug||2308 /var/lib/xcp/xapi|dispatch:VDI.remove_from_sm_config D:6afd56f48503|api_effect] VDI.remove_from_sm_config Oct 4 15:35:05 r530-n1 xapi: [ info||2275 |sm_exec D:4038185b00b4|xapi_session] Session.destroy trackid=2bd6588fd0c9bc61f4e7257a1fb4de2a Oct 4 15:35:05 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] dbg:OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 superstate:attached RW Oct 4 15:35:05 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|dummytaskhelper] task VDI.detach D:1cb91aeef0b7 created by task R:fb0cf6cd662a Oct 4 15:35:05 r530-n1 xapi: [debug||2275 |VDI.detach D:1cb91aeef0b7|sm] SM ext vdi_detach sr=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 vdi=OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d Oct 4 15:35:05 r530-n1 xapi: [ info||2275 |sm_exec D:4e84c2714c99|xapi_session] Session.create trackid=39a5ea39c229d29194cedbccb31ac819 pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:05 r530-n1 xapi: [debug||2309 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:6191526b646a created by task D:4e84c2714c99 Oct 4 15:35:05 r530-n1 xapi: [debug||2310 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_other_config D:1a89bc329941 created by task D:1cb91aeef0b7 Oct 4 15:35:05 r530-n1 xapi: [debug||2311 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:cc2b24bdda8d created by task D:1cb91aeef0b7 Oct 4 15:35:05 r530-n1 xapi: [ info||2275 |sm_exec D:4e84c2714c99|xapi_session] Session.destroy trackid=39a5ea39c229d29194cedbccb31ac819 Oct 4 15:35:05 r530-n1 xapi: [debug||2275 |VDI.detach D:1cb91aeef0b7|dummytaskhelper] task VDI.detach D:88a71a6a26b4 created by task R:fb0cf6cd662a Oct 4 15:35:05 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] dbg:OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a dp:vbd/0/xvda sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 superstate:detached Oct 4 15:35:05 r530-n1 xapi: [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] [destroy_sr] Filtered VDI count:0 Oct 4 15:35:05 r530-n1 xapi: message repeated 2 times: [ [debug||2275 |OpaqueRef:fb0cf6cd-662a-e67b-a1b3-998f524b4d6a|Storage_smapiv1_wrapper] [destroy_sr] Filtered VDI count:0] Oct 4 15:35:05 r530-n1 xapi: [debug||2312 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.destroy D:bd8885aaf6e6 created by task R:a0a41b4c07c1 Oct 4 15:35:05 r530-n1 xapi: [ info||2312 /var/lib/xcp/xapi|dispatch:VBD.destroy D:bd8885aaf6e6|taskhelper] task VBD.destroy R:aa427584bc3c (uuid:5e24b5c8-ee44-a9d4-8256-b0dfac97f052) created (trackid=b27a95a10bb5346d156adaa4ad871724) by task R:a0a41b4c07c1 Oct 4 15:35:05 r530-n1 xapi: [debug||2312 /var/lib/xcp/xapi|VBD.destroy R:aa427584bc3c|audit] VBD.destroy: VBD = 'c61546e5-0625-df73-2c38-9bf56de506ee' Oct 4 15:35:05 r530-n1 xapi: [debug||2312 /var/lib/xcp/xapi|VBD.destroy R:aa427584bc3c|xapi_vbd_helpers] VBD.destroy (uuid = c61546e5-0625-df73-2c38-9bf56de506ee; ref = OpaqueRef:cb144bb0-494e-6462-9ec4-b56cfc18db57) Oct 4 15:35:05 r530-n1 xapi: [debug||2313 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:ff6cf4b5c3fd created by task R:a0a41b4c07c1 Oct 4 15:35:05 r530-n1 xapi: [ info||2313 /var/lib/xcp/xapi|session.logout D:6012851d727a|xapi_session] Session.destroy trackid=b27a95a10bb5346d156adaa4ad871724 Oct 4 15:35:05 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Caught exception during import: INTERNAL_ERROR: [ End_of_file ] Oct 4 15:35:05 r530-n1 xapi: [debug||2176 /var/lib/xcp/xapi|VM.import R:a0a41b4c07c1|import] Cleaning up after import failure: INTERNAL_ERROR: [ End_of_file ] Oct 4 15:35:05 r530-n1 xapi: [debug||2314 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:27db50b2e32d created by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [ info||2314 /var/lib/xcp/xapi|session.slave_login D:c76402fb8dbe|xapi_session] Session.create trackid=eadb43dfc8a2da06c71ebb5af990c535 pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:05 r530-n1 xapi: [debug||2315 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:28582ed989c2 created by task D:c76402fb8dbe Oct 4 15:35:05 r530-n1 xapi: [debug||2316 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VIF.destroy D:581b6123eca3 created by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [ info||2316 /var/lib/xcp/xapi|dispatch:VIF.destroy D:581b6123eca3|taskhelper] task VIF.destroy R:f5d53d2c43ae (uuid:e88ffdd7-a59a-7c59-0e1d-fd71a240c66f) created (trackid=eadb43dfc8a2da06c71ebb5af990c535) by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [debug||2316 /var/lib/xcp/xapi|VIF.destroy R:f5d53d2c43ae|audit] VIF.destroy: VIF = '5fae00fb-e8d3-a647-b859-8eb4f597f0cc' Oct 4 15:35:05 r530-n1 xapi: [debug||2316 /var/lib/xcp/xapi|VIF.destroy R:f5d53d2c43ae|xapi_vif_helpers] VIF.destroy Oct 4 15:35:05 r530-n1 xapi: [debug||2317 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VBD.destroy D:57d00108d7e8 created by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [ info||2317 /var/lib/xcp/xapi|dispatch:VBD.destroy D:57d00108d7e8|taskhelper] task VBD.destroy R:5a7cd48272cf (uuid:a88eefcd-1b81-2f6d-6c85-728409febe63) created (trackid=eadb43dfc8a2da06c71ebb5af990c535) by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [debug||2317 /var/lib/xcp/xapi|VBD.destroy R:5a7cd48272cf|audit] VBD.destroy: VBD = 'bdd7ca93-9e06-85ba-73f2-77ec1b0617b4' Oct 4 15:35:05 r530-n1 xapi: [debug||2317 /var/lib/xcp/xapi|VBD.destroy R:5a7cd48272cf|xapi_vbd_helpers] VBD.destroy (uuid = bdd7ca93-9e06-85ba-73f2-77ec1b0617b4; ref = OpaqueRef:741a04a9-bf11-facc-632d-7ce2071ffbf7) Oct 4 15:35:05 r530-n1 xapi: [debug||2318 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VM.destroy D:2b0b64b16a10 created by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [ info||2318 /var/lib/xcp/xapi|dispatch:VM.destroy D:2b0b64b16a10|taskhelper] task VM.destroy R:6ccf517667fc (uuid:7a8450a4-3374-1882-fc9c-4fe50805986f) created (trackid=eadb43dfc8a2da06c71ebb5af990c535) by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [debug||2318 /var/lib/xcp/xapi|VM.destroy R:6ccf517667fc|audit] VM.destroy: VM = 'aafb4349-e391-885d-221e-f23468dcd2b0 (XOA)' Oct 4 15:35:05 r530-n1 xapi: [debug||2318 /var/lib/xcp/xapi|VM.destroy R:6ccf517667fc|xapi_vm_helpers] VM.destroy: deleting DB records Oct 4 15:35:05 r530-n1 xapi: [debug||2319 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.destroy D:c897c9b60a0d created by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [ info||2319 /var/lib/xcp/xapi|dispatch:VDI.destroy D:c897c9b60a0d|taskhelper] task VDI.destroy R:d9914cb9b5fe (uuid:bc9b8162-82e2-7071-748b-5b62c28fc82f) created (trackid=eadb43dfc8a2da06c71ebb5af990c535) by task R:eb1cf084c5f8 Oct 4 15:35:05 r530-n1 xapi: [debug||2319 /var/lib/xcp/xapi|VDI.destroy R:d9914cb9b5fe|audit] VDI.destroy: VDI = '550123a8-bce5-483c-bd87-1f37697990d0' Oct 4 15:35:05 r530-n1 xapi: [debug||2319 /var/lib/xcp/xapi|VDI.destroy R:d9914cb9b5fe|message_forwarding] Marking SR for VDI.destroy (task=OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d) Oct 4 15:35:05 r530-n1 xapi: [ info||2319 /var/lib/xcp/xapi|OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d|mux] VDI.destroy dbg:OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 Oct 4 15:35:05 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|xenops] Event on VM c0bae481-5d40-4447-8ea3-88933cda3223; resident_here = true Oct 4 15:35:05 r530-n1 xapi: [ info||2320 |OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d|Storage_smapiv1_wrapper] VDI.destroy dbg:OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d sr:be4e8362-f4e1-b5eb-2122-2930b2c6371d vdi:550123a8-bce5-483c-bd87-1f37697990d0 Oct 4 15:35:05 r530-n1 xapi: [debug||2320 |OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d|dummytaskhelper] task VDI.destroy D:2a458765592f created by task R:d9914cb9b5fe Oct 4 15:35:05 r530-n1 xapi: [debug||2320 |VDI.destroy D:2a458765592f|sm] SM ext vdi_delete sr=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88 vdi=OpaqueRef:13a0abd4-440b-efc5-96ed-9523c335bf0d Oct 4 15:35:05 r530-n1 xapi: [ info||2320 |sm_exec D:373515f49d8e|xapi_session] Session.create trackid=ff303c4739e24152f92b455e38acbea7 pool=false uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:05 r530-n1 xapi: [debug||2321 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:9bc57fb53bc1 created by task D:373515f49d8e Oct 4 15:35:05 r530-n1 xapi: [debug||255 |xapi events D:8b2bb83d909e|dummytaskhelper] task timeboxed_rpc D:a2b9e2618aea created by task D:8b2bb83d909e Oct 4 15:35:05 r530-n1 xapi: [debug||2322 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:9ea6560033b2 created by task D:8b2bb83d909e Oct 4 15:35:05 r530-n1 xapi: [debug||2323 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:85d86d06cc87 created by task D:defc7f3461a7 Oct 4 15:35:05 r530-n1 xapi: [ info||2323 /var/lib/xcp/xapi|session.logout D:1094624b3332|xapi_session] Session.destroy trackid=69abd0863e9bc368d68e7286527a5f28 Oct 4 15:35:05 r530-n1 xapi: [debug||256 |watching networks for NBD-related changes D:defc7f3461a7|network_event_loop] Not updating the firewall, because the set of interfaces to use for NBD did not change: [] Oct 4 15:35:06 r530-n1 xapi: [debug||2324 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:host.get_other_config D:95b50693f69f created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2325 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_other_config D:7a4140464fd6 created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [ info||2326 /var/lib/xcp/xapi|session.login_with_password D:f1bd557ad4b8|xapi_session] Session.create trackid=55ee3a7136295c1d9e81f30254a3c80f pool=false uname=root originator=SM is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:06 r530-n1 xapi: [debug||2327 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:5669a5afa748 created by task D:f1bd557ad4b8 Oct 4 15:35:06 r530-n1 xapi: [ info||2335 /var/lib/xcp/xapi|session.logout D:387f32206727|xapi_session] Session.destroy trackid=55ee3a7136295c1d9e81f30254a3c80f Oct 4 15:35:06 r530-n1 xapi: [debug||2336 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.get_by_uuid D:78891f5718d4 created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2337 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:VDI.db_forget D:69aa6164a83d created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [ info||2337 /var/lib/xcp/xapi|dispatch:VDI.db_forget D:69aa6164a83d|taskhelper] task VDI.db_forget R:c9e761e82431 (uuid:fee19212-b340-47e9-cffb-52897ae012c6) created (trackid=ff303c4739e24152f92b455e38acbea7) by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2337 /var/lib/xcp/xapi|VDI.db_forget R:c9e761e82431|xapi_vdi] db_forget uuid=550123a8-bce5-483c-bd87-1f37697990d0 Oct 4 15:35:06 r530-n1 xapi: [debug||2338 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_virtual_allocation D:5c82bea61f13 created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2339 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.get_by_uuid D:dc8bb873dd0c created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2340 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.set_virtual_allocation D:3f7aaf1ee6dc created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2341 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.set_physical_size D:034cbb885642 created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [debug||2342 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:SR.set_physical_utilisation D:3dd31c0028a4 created by task D:2a458765592f Oct 4 15:35:06 r530-n1 xapi: [ info||2343 /var/lib/xcp/xapi|session.login_with_password D:f51f361d44cb|xapi_session] Session.create trackid=86d3837e2f40e1fdc8e6c19d9211b84e pool=false uname=root originator=SM is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:06 r530-n1 xapi: [debug||2344 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:94e874b5f7c3 created by task D:f51f361d44cb Oct 4 15:35:06 r530-n1 xapi: [ info||2352 /var/lib/xcp/xapi|session.logout D:475645b6b6af|xapi_session] Session.destroy trackid=86d3837e2f40e1fdc8e6c19d9211b84e Oct 4 15:35:06 r530-n1 xapi: [ info||2320 |sm_exec D:373515f49d8e|xapi_session] Session.destroy trackid=ff303c4739e24152f92b455e38acbea7 Oct 4 15:35:06 r530-n1 xapi: [debug||2319 /var/lib/xcp/xapi|VDI.destroy R:d9914cb9b5fe|message_forwarding] Unmarking SR after VDI.destroy (task=OpaqueRef:d9914cb9-b5fe-4531-2308-b558ff22692d) Oct 4 15:35:06 r530-n1 xapi: [debug||2353 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:bfadd06dbaf0 created by task R:eb1cf084c5f8 Oct 4 15:35:06 r530-n1 xapi: [ info||2353 /var/lib/xcp/xapi|session.logout D:7f15c791fd4f|xapi_session] Session.destroy trackid=eadb43dfc8a2da06c71ebb5af990c535 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] VM.import R:a0a41b4c07c1 failed with exception End_of_file Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] Raised End_of_file Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 1/36 xapi Raised at file ocaml/libs/xapi-stdext/lib/xapi-stdext-unix/unixext.ml, line 518 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 2/36 xapi Called from file ocaml/xapi/stream_vdi.ml, line 512 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 3/36 xapi Called from file ocaml/xapi/stream_vdi.ml, line 542 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 4/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 5/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 6/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 7/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 8/36 xapi Called from file list.ml, line 110 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 9/36 xapi Called from file ocaml/xapi/stream_vdi.ml, line 68 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 10/36 xapi Called from file ocaml/xapi/stream_vdi.ml, line 545 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 11/36 xapi Called from file ocaml/xapi/import.ml, line 2386 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 12/36 xapi Called from file ocaml/xapi/import.ml, line 2428 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 13/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 14/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 15/36 xapi Called from file ocaml/libs/open-uri/open_uri.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 16/36 xapi Called from file ocaml/libs/open-uri/open_uri.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 17/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 18/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 19/36 xapi Called from file ocaml/xapi/xapi_vm.ml, line 1532 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 20/36 xapi Called from file ocaml/xapi/xapi_vm.ml, line 1599 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 21/36 xapi Called from file ocaml/xapi/message_forwarding.ml, line 143 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 22/36 xapi Called from file ocaml/xapi/rbac.ml, line 191 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 23/36 xapi Called from file ocaml/xapi/rbac.ml, line 200 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 24/36 xapi Called from file ocaml/xapi/server_helpers.ml, line 75 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 25/36 xapi Called from file scanf.ml, line 275 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 26/36 xapi Called from file scanf.ml, line 174 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 27/36 xapi Called from file scanf.ml, line 191 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 28/36 xapi Called from file scanf.ml, line 961 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 29/36 xapi Called from file ocaml/xapi/server_helpers.ml, line 94 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 30/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 31/36 xapi Called from file scanf.ml, line 275 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 32/36 xapi Called from file scanf.ml, line 174 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 33/36 xapi Called from file scanf.ml, line 191 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 34/36 xapi Called from file scanf.ml, line 961 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 35/36 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] 36/36 xapi Called from file ocaml/libs/log/debug.ml, line 250 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|dispatch:VM.import D:9bc53bcd5145|backtrace] Oct 4 15:35:06 r530-n1 xapi: [ info||2176 /var/lib/xcp/xapi|session.logout D:3e72f991e76f|xapi_session] Session.destroy trackid=2d0b97841ac361d7c0b3e38d2364f310 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|cli] Converting exception INTERNAL_ERROR: [ End_of_file ] into a CLI response Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] Raised Server_error(INTERNAL_ERROR, [ End_of_file ]) Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 1/9 xapi Raised at file ocaml/xapi-client/client.ml, line 7 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 2/9 xapi Called from file ocaml/xapi-client/client.ml, line 19 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 3/9 xapi Called from file ocaml/xapi-client/client.ml, line 6353 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 4/9 xapi Called from file ocaml/xapi-cli-server/cli_operations.ml, line 5626 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 5/9 xapi Called from file ocaml/xapi-cli-server/xapi_cli.ml, line 169 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 6/9 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 7/9 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 8/9 xapi Called from file ocaml/xapi-cli-server/xapi_cli.ml, line 140 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] 9/9 xapi Called from file lib/backtrace.ml, line 177 Oct 4 15:35:06 r530-n1 xapi: [error||2176 /var/lib/xcp/xapi|post_cli|backtrace] Oct 4 15:35:06 r530-n1 xapi: [ info||2354 /var/lib/xcp/xapi|post_cli|cli] xe vm-import filename=/dev/stdin username=root password=(omitted) Oct 4 15:35:06 r530-n1 xapi: [ info||2354 /var/lib/xcp/xapi|session.login_with_password D:5bd4566c9763|xapi_session] Session.create trackid=0b351d1740ced5cd1fdc7fdcf6a4aa33 pool=false uname=root originator=cli is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:06 r530-n1 xapi: [debug||2355 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:5a6ae65c941f created by task D:5bd4566c9763 Oct 4 15:35:06 r530-n1 xapi: [ info||2354 /var/lib/xcp/xapi|task.create D:a1c52a6070ae|taskhelper] task VM import R:299bb2a3729b (uuid:337c572f-843f-0333-dccf-14eb206011ac) created (trackid=0b351d1740ced5cd1fdc7fdcf6a4aa33) by task D:a1c52a6070ae Oct 4 15:35:06 r530-n1 xapi: [debug||2354 /var/lib/xcp/xapi|post_cli|Cli_operations] requesting HttpPut('/dev/stdin','/import?session_id=OpaqueRef:7a1ad64e-d079-4c45-820a-53dc3a35169f&task_id=OpaqueRef:299bb2a3-729b-0ced-07d9-49bdde91474f&restore=false&force=false&dry_run=false&sr_id=OpaqueRef:ddffb5ca-d41c-8a8f-045c-db005632de88') Oct 4 15:35:06 r530-n1 xapi: [debug||2357 HTTP 127.0.0.1->:::80|put_import|import] import handler Oct 4 15:35:06 r530-n1 xapi: [debug||2358 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:41768fe4de41 created by task D:a0fe19e78d1c Oct 4 15:35:06 r530-n1 xapi: [ info||2358 /var/lib/xcp/xapi|session.slave_login D:1abd293f5e18|xapi_session] Session.create trackid=774fdd8bfdf5f7697d05295b1ceaf5e6 pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:06 r530-n1 xapi: [debug||2359 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:752a911be7da created by task D:1abd293f5e18 Oct 4 15:35:06 r530-n1 xapi: [ info||2357 :::80|VM.import D:a0fe19e78d1c|import] VM.import: SR = 'be4e8362-f4e1-b5eb-2122-2930b2c6371d (Local storage)'; force = false; full_restore = false Oct 4 15:35:06 r530-n1 xapi: [ info||2357 :::80|VM.import D:a0fe19e78d1c|taskhelper] task VM import R:299bb2a3729b forwarded (trackid=0b351d1740ced5cd1fdc7fdcf6a4aa33) Oct 4 15:35:06 r530-n1 xapi: [debug||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|import] Check RPU status before VM.import Oct 4 15:35:06 r530-n1 xapi: [debug||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|import] Importing (as new VM) Oct 4 15:35:06 r530-n1 xapi: [debug||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|import] Reading XML Oct 4 15:35:06 r530-n1 xapi: [debug||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|import] Failed to directly open the archive; trying gzip Oct 4 15:35:06 r530-n1 xapi: [debug||2360 ||import] Writing initial buffer Oct 4 15:35:06 r530-n1 xapi: [debug||2360 ||import] Written a total of 512 + 29789 bytes Oct 4 15:35:06 r530-n1 xapi: [ info||2361 /var/lib/xcp/xapi|session.login_with_password D:30e46de9fcae|xapi_session] Session.create trackid=026694bf0aac4d2e2cf87482131cb901 pool=false uname=root originator=SM is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:06 r530-n1 xapi: [debug||2362 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:60647d8f3ef7 created by task D:30e46de9fcae Oct 4 15:35:06 r530-n1 xapi: [error||2360 ||xapi_compression] nice failed to decompress: exit code 1 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] Raised End_of_file Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 1/13 xapi Raised at file unix/tar_unix.ml, line 34 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 2/13 xapi Called from file unix/tar_unix.ml, line 26 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 3/13 xapi Called from file lib/tar.ml, line 829 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 4/13 xapi Called from file lib/tar.ml, line 660 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 5/13 xapi Called from file lib/tar.ml, line 666 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 6/13 xapi Called from file lib/tar.ml, line 673 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 7/13 xapi Called from file lib/tar.ml, line 749 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 8/13 xapi Called from file lib/tar.ml, line 867 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 9/13 xapi Called from file ocaml/xapi/import.ml, line 2132 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 10/13 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 11/13 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 12/13 xapi Called from file ocaml/xapi/import.ml, line 2554 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] 13/13 xapi Called from file lib/backtrace.ml, line 177 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|backtrace] Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|VM import R:299bb2a3729b|import] Prematurely reached end-of-file during import Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] VM import R:299bb2a3729b failed with exception Server_error(IMPORT_ERROR_PREMATURE_EOF, [ ]) Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] Raised Server_error(IMPORT_ERROR_PREMATURE_EOF, [ ]) Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 1/7 xapi Raised at file lib/backtrace.ml, line 210 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 2/7 xapi Called from file ocaml/xapi/import.ml, line 2204 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 3/7 xapi Called from file ocaml/xapi/server_helpers.ml, line 72 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 4/7 xapi Called from file ocaml/xapi/server_helpers.ml, line 94 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 5/7 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 6/7 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] 7/7 xapi Called from file ocaml/libs/log/debug.ml, line 250 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80|VM.import D:a0fe19e78d1c|backtrace] Oct 4 15:35:06 r530-n1 xapi: [ info||2354 /var/lib/xcp/xapi|session.logout D:368a24fcf043|xapi_session] Session.destroy trackid=0b351d1740ced5cd1fdc7fdcf6a4aa33 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|cli] Converting exception IMPORT_ERROR_PREMATURE_EOF: [ ] into a CLI response Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] Raised Server_error(IMPORT_ERROR_PREMATURE_EOF, [ ]) Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 1/9 xapi Raised at file ocaml/xapi-cli-server/cli_util.ml, line 171 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 2/9 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 3/9 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 4/9 xapi Called from file ocaml/xapi-cli-server/cli_operations.ml, line 5681 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 5/9 xapi Called from file ocaml/xapi-cli-server/xapi_cli.ml, line 169 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 6/9 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [debug||2364 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.logout D:18601477ca46 created by task D:a0fe19e78d1c Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 7/9 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 8/9 xapi Called from file ocaml/xapi-cli-server/xapi_cli.ml, line 140 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] 9/9 xapi Called from file lib/backtrace.ml, line 177 Oct 4 15:35:06 r530-n1 xapi: [error||2354 /var/lib/xcp/xapi|post_cli|backtrace] Oct 4 15:35:06 r530-n1 xapi: [ info||2364 /var/lib/xcp/xapi|session.logout D:1698de24812a|xapi_session] Session.destroy trackid=774fdd8bfdf5f7697d05295b1ceaf5e6 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] VM.import D:a0fe19e78d1c failed with exception Server_error(IMPORT_ERROR_PREMATURE_EOF, [ ]) Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] Raised Server_error(IMPORT_ERROR_PREMATURE_EOF, [ ]) Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 1/14 xapi Raised at file ocaml/libs/log/debug.ml, line 267 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 2/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 3/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 4/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 5/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 6/14 xapi Called from file ocaml/xapi/xapi_http.ml, line 254 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 7/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 8/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 9/14 xapi Called from file ocaml/xapi/import.ml, line 2451 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 10/14 xapi Called from file ocaml/xapi/server_helpers.ml, line 72 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 11/14 xapi Called from file ocaml/xapi/server_helpers.ml, line 94 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 12/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 24 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 13/14 xapi Called from file ocaml/libs/xapi-stdext/lib/xapi-stdext-pervasives/pervasiveext.ml, line 39 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] 14/14 xapi Called from file ocaml/libs/log/debug.ml, line 250 Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|backtrace] Oct 4 15:35:06 r530-n1 xapi: [error||2357 HTTP 127.0.0.1->:::80|put_import|xapi_http] Unhandled Api_errors.Server_error(IMPORT_ERROR_PREMATURE_EOF, [ ]) Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80||backtrace] put_import failed with exception Http_svr.Generic_error("IMPORT_ERROR_PREMATURE_EOF: [ ]") Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80||backtrace] Raised Http_svr.Generic_error("IMPORT_ERROR_PREMATURE_EOF: [ ]") Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80||backtrace] 1/2 xapi Raised at file ocaml/xapi/xapi_http.ml, line 401 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80||backtrace] 2/2 xapi Called from file ocaml/libs/log/debug.ml, line 250 Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80||backtrace] Oct 4 15:35:06 r530-n1 xapi: [error||2357 :::80||http_internal_errors] Responding with 500 Internal Error due to Http_svr.Generic_error("IMPORT_ERROR_PREMATURE_EOF: [ ]") Oct 4 15:35:06 r530-n1 xapi: [debug||2357 :::80||http_internal_errors] Raised at Debug.with_thread_associated in file \\"ocaml/libs/log/debug.ml\\", line 267, characters 6-15\\nCalled from Http_svr.handle_one in file \\"ocaml/libs/http-lib/http_svr.ml\\", line 511, characters 8-32\\n Oct 4 15:35:06 r530-n1 xapi: [ info||2370 /var/lib/xcp/xapi|session.logout D:ee7923015d77|xapi_session] Session.destroy trackid=026694bf0aac4d2e2cf87482131cb901 Oct 4 15:35:06 r530-n1 xapi: [ info||2371 /var/lib/xcp/xapi|session.login_with_password D:6a9cdb75ce08|xapi_session] Session.create trackid=17398ae5250a19ef68e5a02f74383c89 pool=false uname=root originator=SM is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:06 r530-n1 xapi: [debug||2372 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:83292ce4e82a created by task D:6a9cdb75ce08 Oct 4 15:35:06 r530-n1 xapi: [ info||2384 /var/lib/xcp/xapi|session.logout D:3b7edda7cdeb|xapi_session] Session.destroy trackid=17398ae5250a19ef68e5a02f74383c89 Oct 4 15:35:10 r530-n1 xapi: [debug||2385 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:session.slave_login D:fbf6652130a3 created by task D:defc7f3461a7 Oct 4 15:35:10 r530-n1 xapi: [ info||2385 /var/lib/xcp/xapi|session.slave_login D:2a91639b6e48|xapi_session] Session.create trackid=2764ae6a6c3696eec678e785dffe693f pool=true uname= originator=xapi is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 Oct 4 15:35:10 r530-n1 xapi: [debug||2386 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:pool.get_all D:a7269b06935b created by task D:2a91639b6e48 Oct 4 15:35:10 r530-n1 xapi: [debug||2387 /var/lib/xcp/xapi|post_root|dummytaskhelper] task dispatch:event.from D:d3031117f089 created by task D:defc7f3461a7 Oct 4 15:35:14 r530-n1 xcp-rrdd: [ info||8 ||rrdd_main] GC live_words = 753723 Oct 4 15:35:14 r530-n1 xcp-rrdd: [ info||8 ||rrdd_main] GC heap_words = 1467904 Oct 4 15:35:14 r530-n1 xcp-rrdd: [ info||8 ||rrdd_main] GC free_words = 714148