[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [Xen-API] Bug#674161: xcp-xapi: 'the device disappeared from xenstore' message during vbd-plug (vm-start)
Package: xcp-xapi Version: 1.3.2-6 Severity: normal Tags: upstream vbd plug to PV domain cause following error: The server failed to handle your request, due to an internal error. The given message may give details useful for debugging the problem. message: the device disappeared from xenstore (frontend (domid=4 | kind=vbd | devid=51760); backend (domid=0 | kind=vbd | devid=51760)) (same error occur during normal vm installation/running, but this is too long way and I cut some edges by creating a 'diskless' VM, wich just boot and stops inside in initramfs). Operation log: (preparation - not related to bug) # mkdir /boot/guest # cp /boot/vmlinuz-3.2.0-2-amd64 /boot/initrd.img-3.2.0-2-amd64 /boot/guest/ #(prepare external kernels) # xe vm-install template=Other\ install\ media new-name-label=raw 8a6f56a7-3511-650e-d14b-4dd2a3d9c75d # export vm=8a6f56a7-3511-650e-d14b-4dd2a3d9c75d # xe vm-param-set uuid=$vm HVM-boot-policy= #(disable HVM mode == switch to PV) # xe vm-param-set uuid=$vm PV-bootloader= #(disable eliloader/pygrub - use external kernel) # xe vm-param-set uuid=$vm PV-kernel=/boot/guest/vmlinuz-3.2.0-2-amd64 # xe vm-param-set uuid=$vm PV-ramdisk=/boot/guest/initrd.img-3.2.0-2-amd64 # xe vm-param-set uuid=$vm PV-args="root=/" #(kerel cmdline - to go to initrd) # xe vm-start uuid=$vm (now we got clean vm without network or block devices and we can easily repeat but conditions) # xe sr-create type=file name-label=fileSR device-config:location=/mnt 319f3eaa-d1ba-a81d-acb3-493ecbdaab17 #xe vdi-create type=user virtual-size=2GiB name-label=test sr-uuid=319f3eaa-d1ba-a81d-acb3-493ecbdaab17 8cc62479-e620-4561-a057-2eff0e0b8f8d here bug part starts: xe vbd-create vm-uuid=8a6f56a7-3511-650e-d14b-4dd2a3d9c75d vdi-uuid=8cc62479-e620-4561-a057-2eff0e0b8f8d device=0 716880c9-d6cb-44a8-e5cd-6a68f708c1f9 root@lab-xh3:~# xe vbd-plug uuid=716880c9-d6cb-44a8-e5cd-6a68f708c1f9 The server failed to handle your request, due to an internal error. The given message may give details useful for debugging the problem. message: the device disappeared from xenstore (frontend (domid=2 | kind=vbd | devid=51712); backend (domid=0 | kind=vbd | devid=51712)) Log file content: [20120523T14:00:23.276Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi||cli] xe vbd-plug uuid=716880c9-d6cb-44a8-e5cd-6a68f708c1f9 username=root password=null [20120523T14:00:23.278Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|session.login_with_password D:0661f1729b93|xapi] Session.create trackid=094bbc269cc3c3ff4fe8b0faadef2ef1 pool=false uname=root is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 [20120523T14:00:23.278Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|session.login_with_password D:0661f1729b93|xapi] Attempting to open /var/lib/xcp/xapi [20120523T14:00:23.279Z|debug|lab-xh3|75 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:session.get_uuid D:f3e45d1e1222 created by task D:0661f1729b93 [20120523T14:00:23.285Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|audit] VBD.plug: VBD = '716880c9-d6cb-44a8-e5cd-6a68f708c1f9' [20120523T14:00:23.289Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|locking_helpers] Acquired lock on VM OpaqueRef:714e30c2-f627-1df7-db85-f543eccca324 with token 3 [20120523T14:00:23.289Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] vbd_plug: attempting to attach vbd [20120523T14:00:23.289Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Attempting to dynamically attach VBD to domid 2 [20120523T14:00:23.290Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] VBD device name 0 interpreted as Xen(0, 0) (hvm = false) [20120523T14:00:23.290Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|sm] SM file sr_content_type sr=OpaqueRef:90cbfca8-ffca-554a-4809-d85a71dd826c [20120523T14:00:23.292Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:e2722ffdc310|xapi] Session.create trackid=d1fe239f7a7942262e1e1b0d73c8f9dc pool=false uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 [20120523T14:00:23.293Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:e2722ffdc310|xapi] Attempting to open /var/lib/xcp/xapi [20120523T14:00:23.293Z|debug|lab-xh3|76 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:session.get_uuid D:ca1bcfee9e48 created by task D:e2722ffdc310 [20120523T14:00:23.374Z|debug|lab-xh3|77 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:host.get_other_config D:f8b4e61f4b2d created by task R:4b5db3df62d8 [20120523T14:00:23.376Z|debug|lab-xh3|77 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.382Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:e2722ffdc310|xapi] Session.destroy trackid=d1fe239f7a7942262e1e1b0d73c8f9dc [20120523T14:00:23.383Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|storage_impl] VDI.attach task:OpaqueRef:4b5db3df-62d8-3ec4-37c5-b813328ea279 dp:vbd/2/0 sr:319f3eaa-d1ba-a81d-acb3-493ecbdaab17 vdi:8cc62479-e620-4561-a057-2eff0e0b8f8d read_write:true [20120523T14:00:23.384Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|dummytaskhelper] task VDI.attach D:c50b045b76ac created by task R:4b5db3df62d8 [20120523T14:00:23.384Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VDI.attach D:c50b045b76ac|sm] SM file vdi_attach sr=OpaqueRef:90cbfca8-ffca-554a-4809-d85a71dd826c vdi=OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e writable=true [20120523T14:00:23.385Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:b6a28b0b4cd5|xapi] Session.create trackid=86f63a8f7c1a95156bc12aa8873e1d44 pool=false uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 [20120523T14:00:23.386Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:b6a28b0b4cd5|xapi] Attempting to open /var/lib/xcp/xapi [20120523T14:00:23.387Z|debug|lab-xh3|78 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:session.get_uuid D:2cfe5c31c6b7 created by task D:b6a28b0b4cd5 [20120523T14:00:23.468Z|debug|lab-xh3|79 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:host.get_other_config D:62ab2c48c7f5 created by task D:c50b045b76ac [20120523T14:00:23.470Z|debug|lab-xh3|79 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.502Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:b6a28b0b4cd5|xapi] Session.destroy trackid=86f63a8f7c1a95156bc12aa8873e1d44 [20120523T14:00:23.503Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|storage_impl] task:OpaqueRef:4b5db3df-62d8-3ec4-37c5-b813328ea279 dp:vbd/2/0 sr:319f3eaa-d1ba-a81d-acb3-493ecbdaab17 vdi:8cc62479-e620-4561-a057-2eff0e0b8f8d superstate:attached RW [20120523T14:00:23.504Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|storage_impl] VDI.activate task:OpaqueRef:4b5db3df-62d8-3ec4-37c5-b813328ea279 dp:vbd/2/0 sr:319f3eaa-d1ba-a81d-acb3-493ecbdaab17 vdi:8cc62479-e620-4561-a057-2eff0e0b8f8d [20120523T14:00:23.504Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|dummytaskhelper] task VDI.activate D:da62a5425fb6 created by task R:4b5db3df62d8 [20120523T14:00:23.504Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VDI.activate D:da62a5425fb6|sm] SM file vdi_activate sr=OpaqueRef:90cbfca8-ffca-554a-4809-d85a71dd826c vdi=OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e [20120523T14:00:23.506Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:a249a76eac61|xapi] Session.create trackid=9c511ffe89ca69d435a39ba939dc8083 pool=false uname= is_local_superuser=true auth_user_sid= parent=trackid=9834f5af41c964e225f24279aefe4e49 [20120523T14:00:23.507Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:a249a76eac61|xapi] Attempting to open /var/lib/xcp/xapi [20120523T14:00:23.507Z|debug|lab-xh3|80 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:session.get_uuid D:523810ee01c2 created by task D:a249a76eac61 [20120523T14:00:23.588Z|debug|lab-xh3|81 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:host.get_other_config D:0cd4c9163a9a created by task D:da62a5425fb6 [20120523T14:00:23.590Z|debug|lab-xh3|81 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.600Z|debug|lab-xh3|82 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VDI.get_by_uuid D:f9680d9069ea created by task D:da62a5425fb6 [20120523T14:00:23.602Z|debug|lab-xh3|82 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.603Z|debug|lab-xh3|83 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:host.get_by_uuid D:1366191ebd80 created by task D:da62a5425fb6 [20120523T14:00:23.605Z|debug|lab-xh3|83 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.606Z|debug|lab-xh3|84 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VDI.get_sm_config D:990bce9ac71c created by task D:da62a5425fb6 [20120523T14:00:23.607Z|debug|lab-xh3|84 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.608Z|debug|lab-xh3|85 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VDI.add_to_sm_config D:ca8a41754135 created by task D:da62a5425fb6 [20120523T14:00:23.609Z| info|lab-xh3|85 UNIX /var/lib/xcp/xapi|dispatch:VDI.add_to_sm_config D:ca8a41754135|api_effect] VDI.add_to_sm_config [20120523T14:00:23.611Z|debug|lab-xh3|85 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.611Z|debug|lab-xh3|86 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VDI.get_sm_config D:5743d23d52ab created by task D:da62a5425fb6 [20120523T14:00:23.613Z|debug|lab-xh3|86 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.614Z|debug|lab-xh3|87 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VDI.get_by_uuid D:fbd52f47c790 created by task D:da62a5425fb6 [20120523T14:00:23.616Z|debug|lab-xh3|87 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.617Z|debug|lab-xh3|88 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VDI.get_SR D:4e937c4a1379 created by task D:da62a5425fb6 [20120523T14:00:23.618Z|debug|lab-xh3|88 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.619Z|debug|lab-xh3|89 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:SR.get_uuid D:9aaaa895c167 created by task D:da62a5425fb6 [20120523T14:00:23.621Z|debug|lab-xh3|89 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.622Z|debug|lab-xh3|90 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:SR.get_by_uuid D:4d9c1be2ddba created by task D:da62a5425fb6 [20120523T14:00:23.624Z|debug|lab-xh3|90 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.624Z|debug|lab-xh3|91 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:SR.get_type D:259559b7ae22 created by task D:da62a5425fb6 [20120523T14:00:23.626Z|debug|lab-xh3|91 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.627Z|debug|lab-xh3|92 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:SM.get_all_records_where D:e8b7d1fd933a created by task D:da62a5425fb6 [20120523T14:00:23.629Z|debug|lab-xh3|92 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.630Z|debug|lab-xh3|93 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:SM.get_driver_filename D:9aace8dccffa created by task D:da62a5425fb6 [20120523T14:00:23.632Z|debug|lab-xh3|93 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.633Z|debug|lab-xh3|94 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:VM.get_all_records_where D:49f473b24d94 created by task D:da62a5425fb6 [20120523T14:00:23.638Z|debug|lab-xh3|94 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.639Z|debug|lab-xh3|95 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:PBD.get_all_records_where D:ab689a18ab34 created by task D:da62a5425fb6 [20120523T14:00:23.641Z|debug|lab-xh3|95 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.641Z|debug|lab-xh3|96 UNIX /var/lib/xcp/xapi||dummytaskhelper] task dispatch:PBD.get_device_config D:98ed30da69f4 created by task D:da62a5425fb6 [20120523T14:00:23.643Z|debug|lab-xh3|96 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.646Z|debug|lab-xh3|97 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.655Z| info|lab-xh3|98 UNIX /var/lib/xcp/xapi|dispatch:VDI.remove_from_xenstore_data D:774a27e7f6a2|api_effect] VDI.remove_from_xenstore_data [20120523T14:00:23.657Z|debug|lab-xh3|98 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.658Z| info|lab-xh3|99 UNIX /var/lib/xcp/xapi|dispatch:VDI.remove_from_xenstore_data D:dfa79cc6aa39|api_effect] VDI.remove_from_xenstore_data [20120523T14:00:23.660Z|debug|lab-xh3|99 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.661Z| info|lab-xh3|100 UNIX /var/lib/xcp/xapi|dispatch:VDI.remove_from_xenstore_data D:55ec2bb8c12a|api_effect] VDI.remove_from_xenstore_data [20120523T14:00:23.663Z|debug|lab-xh3|100 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.665Z| info|lab-xh3|101 UNIX /var/lib/xcp/xapi|dispatch:VDI.remove_from_xenstore_data D:0e6ab4d0e278|api_effect] VDI.remove_from_xenstore_data [20120523T14:00:23.666Z|debug|lab-xh3|101 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.668Z| info|lab-xh3|102 UNIX /var/lib/xcp/xapi|dispatch:VDI.add_to_xenstore_data D:f3712db91596|api_effect] VDI.add_to_xenstore_data [20120523T14:00:23.669Z|debug|lab-xh3|102 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.671Z| info|lab-xh3|103 UNIX /var/lib/xcp/xapi|dispatch:VDI.add_to_xenstore_data D:405254ef3d29|api_effect] VDI.add_to_xenstore_data [20120523T14:00:23.672Z|debug|lab-xh3|103 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.674Z| info|lab-xh3|104 UNIX /var/lib/xcp/xapi|dispatch:VDI.add_to_xenstore_data D:9ccdf51d9119|api_effect] VDI.add_to_xenstore_data [20120523T14:00:23.676Z|debug|lab-xh3|104 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.677Z| info|lab-xh3|105 UNIX /var/lib/xcp/xapi|dispatch:VDI.remove_from_xenstore_data D:a0d04baf4d20|api_effect] VDI.remove_from_xenstore_data [20120523T14:00:23.679Z|debug|lab-xh3|105 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.681Z| info|lab-xh3|106 UNIX /var/lib/xcp/xapi|dispatch:VDI.remove_from_xenstore_data D:809ea44d0919|api_effect] VDI.remove_from_xenstore_data [20120523T14:00:23.682Z|debug|lab-xh3|106 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.684Z| info|lab-xh3|107 UNIX /var/lib/xcp/xapi|dispatch:VDI.add_to_xenstore_data D:47e8d83e8ecc|api_effect] VDI.add_to_xenstore_data [20120523T14:00:23.685Z|debug|lab-xh3|107 UNIX /var/lib/xcp/xapi||http_critical] Premature termination of connection! [20120523T14:00:23.742Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|sm_exec D:a249a76eac61|xapi] Session.destroy trackid=9c511ffe89ca69d435a39ba939dc8083 [20120523T14:00:23.743Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|storage_impl] task:OpaqueRef:4b5db3df-62d8-3ec4-37c5-b813328ea279 dp:vbd/2/0 sr:319f3eaa-d1ba-a81d-acb3-493ecbdaab17 vdi:8cc62479-e620-4561-a057-2eff0e0b8f8d superstate:activated RW [20120523T14:00:23.744Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xenops] Device.Vbd.add (device_number=Xen(0, 0) | params=/dev/sm/backend/319f3eaa-d1ba-a81d-acb3-493ecbdaab17/8cc62479-e620-4561-a057-2eff0e0b8f8d | phystype=vhd) [20120523T14:00:23.744Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xenops] adding device B0[/local/domain/0/backend/vbd/2/51712] F2[/local/domain/2/device/vbd/51712] H[/xapi/2/hotplug/vbd/51712] [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|backtrace] Raised at device.ml:65.10-42 -> xst.ml:52.18-23 -> xst.ml:55.9-12 -> device.ml:497.1-60 -> vbdops.ml:102.37-229 -> storage_access.ml:516.14-317 -> xapi_xenops_errors.ml:79.4-8 [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Converting xenops exception (INTERNAL_ERROR: [ Device_common.Device_backend_vanished(_) ]) into nice API internal error [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29 [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at xapi_xenops_errors.ml:83.10-26 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at pervasiveext.ml:26.22-25 -> xapi_vbd.ml:46.3-80 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|locking_helpers] Released lock on VM OpaqueRef:714e30c2-f627-1df7-db85-f543eccca324 with token 3 [20120523T14:00:23.745Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at pervasiveext.ml:26.22-25 -> message_forwarding.ml:233.25-44 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.747Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|backtrace] Raised at pervasiveext.ml:26.22-25 -> message_forwarding.ml:3238.3-194 -> rbac.ml:229.16-23 [20120523T14:00:23.747Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|backtrace] Raised at rbac.ml:238.10-15 -> server_helpers.ml:79.11-41 [20120523T14:00:23.747Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|dispatcher] Server_helpers.exec exception_handler: Got exception INTERNAL_ERROR: [ the device disappeared from xenstore (frontend (domid=2 | kind=vbd | devid=51712); backend (domid=0 | kind=vbd | devid=51712)) ] [20120523T14:00:23.747Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|dispatcher] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29 [20120523T14:00:23.747Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|backtrace] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29 [20120523T14:00:23.750Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at server_helpers.ml:94.14-15 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.751Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.751Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|dispatch:VBD.plug D:e3c3ca998d32|xapi] Raised at pervasiveext.ml:26.22-25 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.751Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi|dispatch:VBD.plug D:e3c3ca998d32|backtrace] Raised at pervasiveext.ml:26.22-25 -> server_helpers.ml:153.10-106 -> server.ml:26859.19-167 -> server_helpers.ml:119.4-7 [20120523T14:00:23.751Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi||xapi] Raised at client.ml:6.37-75 -> client.ml:9878.12-61 -> xapi_cli.ml:112.18-56 -> pervasiveext.ml:22.2-9 [20120523T14:00:23.753Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|session.logout D:4eb585f43123|xapi] Session.destroy trackid=094bbc269cc3c3ff4fe8b0faadef2ef1 [20120523T14:00:23.754Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi||backtrace] Raised at pervasiveext.ml:26.22-25 -> xapi_cli.ml:111.2-138 -> xapi_cli.ml:205.7-44 -> xapi_cli.ml:257.4-23 [20120523T14:00:23.754Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi||cli] Xapi_cli.exception_handler: Got exception INTERNAL_ERROR: [ the device disappeared from xenstore (frontend (domid=2 | kind=vbd | devid=51712); backend (domid=0 | kind=vbd | devid=51712)) ] [20120523T14:00:23.754Z|debug|lab-xh3|74 UNIX /var/lib/xcp/xapi||cli] Raised at string.ml:150.25-34 -> stringext.ml:108.13-29 [20120523T14:01:02.079Z|debug|lab-xh3|19|Starting periodic scheduler D:3f704699c722|backgroundscheduler] Adding function Logrotate to queue, start=300.000000, type=Periodic(300.000000) [20120523T14:01:02.079Z|debug|lab-xh3|19|Starting periodic scheduler D:3f704699c722|backgroundscheduler] Sleeping until next event (119.911749 seconds) syslog: May 23 18:00:23 lab-xh3 xapi: [20120523T14:00:23.672Z| info|lab-xh3|103 UNIX /var/lib/xcp/xapi|VDI.add_to_xenstore_data D:be30c8e0e2cc|audit] ('trackid=9c511ffe89ca69d435a39ba939dc8083' 'LOCAL_SUPERUSER' '' 'ALLOWED' 'OK' 'API' 'VDI.add_to_xenstore_data' (('self' 'test' '8cc62479-e620-4561-a057-2eff0e0b8f8d' 'OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e'))) May 23 18:00:23 lab-xh3 xapi: [20120523T14:00:23.675Z| info|lab-xh3|104 UNIX /var/lib/xcp/xapi|VDI.add_to_xenstore_data D:fb48cb1c478e|audit] ('trackid=9c511ffe89ca69d435a39ba939dc8083' 'LOCAL_SUPERUSER' '' 'ALLOWED' 'OK' 'API' 'VDI.add_to_xenstore_data' (('self' 'test' '8cc62479-e620-4561-a057-2eff0e0b8f8d' 'OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e'))) May 23 18:00:23 lab-xh3 xapi: [20120523T14:00:23.679Z| info|lab-xh3|105 UNIX /var/lib/xcp/xapi|VDI.remove_from_xenstore_data D:d41cb4970a71|audit] ('trackid=9c511ffe89ca69d435a39ba939dc8083' 'LOCAL_SUPERUSER' '' 'ALLOWED' 'OK' 'API' 'VDI.remove_from_xenstore_data' (('self' 'test' '8cc62479-e620-4561-a057-2eff0e0b8f8d' 'OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e'))) May 23 18:00:23 lab-xh3 xapi: [20120523T14:00:23.682Z| info|lab-xh3|106 UNIX /var/lib/xcp/xapi|VDI.remove_from_xenstore_data D:d6afa4349dcc|audit] ('trackid=9c511ffe89ca69d435a39ba939dc8083' 'LOCAL_SUPERUSER' '' 'ALLOWED' 'OK' 'API' 'VDI.remove_from_xenstore_data' (('self' 'test' '8cc62479-e620-4561-a057-2eff0e0b8f8d' 'OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e'))) May 23 18:00:23 lab-xh3 xapi: [20120523T14:00:23.685Z| info|lab-xh3|107 UNIX /var/lib/xcp/xapi|VDI.add_to_xenstore_data D:f03a5d19ee42|audit] ('trackid=9c511ffe89ca69d435a39ba939dc8083' 'LOCAL_SUPERUSER' '' 'ALLOWED' 'OK' 'API' 'VDI.add_to_xenstore_data' (('self' 'test' '8cc62479-e620-4561-a057-2eff0e0b8f8d' 'OpaqueRef:cd5aca3f-0e25-b85f-9ba7-866bf783575e'))) May 23 18:00:23 lab-xh3 tapdisk[4245]: tapdisk-control: init, 10 x 4k buffers May 23 18:00:23 lab-xh3 tapdisk[4245]: I/O queue driver: lio May 23 18:00:23 lab-xh3 tapdisk[4245]: tapdisk-log: started, level 0 May 23 18:00:23 lab-xh3 tapdisk[4245]: received 'attach' message (uuid = 0) May 23 18:00:23 lab-xh3 tapdisk[4245]: sending 'attach response' message (uuid = 0) May 23 18:00:23 lab-xh3 tapdisk[4245]: received 'open' message (uuid = 0) May 23 18:00:23 lab-xh3 tapdisk[4245]: /mnt/8cc62479-e620-4561-a057-2eff0e0b8f8d.vhd version: tap 0x00010003, b: 1024, a: 0, f: 0, n: 13 May 23 18:00:23 lab-xh3 tapdisk[4245]: opened image /mnt/8cc62479-e620-4561-a057-2eff0e0b8f8d.vhd (1 users, state: 0x00000001, type: 4, rw) May 23 18:00:23 lab-xh3 tapdisk[4245]: VBD CHAIN: May 23 18:00:23 lab-xh3 tapdisk[4245]: /mnt/8cc62479-e620-4561-a057-2eff0e0b8f8d.vhd: type:vhd(4) storage:ext(2) May 23 18:00:23 lab-xh3 tapdisk[4245]: bdev: capacity=4194304 sector_size=512/512 flags=0 May 23 18:00:23 lab-xh3 tapdisk[4245]: sending 'open response' message (uuid = 0) May 23 18:00:23 lab-xh3 kernel: [ 545.326774] block tda: sector-size: 512/512+0 capacity: 4194304 discard: 0+0 flush: 0x0 May 23 18:00:23 lab-xh3 xapi: [20120523T14:00:23.747Z| info|lab-xh3|74 UNIX /var/lib/xcp/xapi|VBD.plug R:4b5db3df62d8|audit] ('trackid=094bbc269cc3c3ff4fe8b0faadef2ef1' 'LOCAL_SUPERUSER' 'root' 'ALLOWED' 'ERROR:INTERNAL_ERROR: [ the device disappeared from xenstore (frontend (domid=2 | kind=vbd | devid=51712); backend (domid=0 | kind=vbd | devid=51712)) ]' 'API' 'VBD.plug' (('self' '' '716880c9-d6cb-44a8-e5cd-6a68f708c1f9' 'OpaqueRef:14ac0618-0dd5-d41b-212d-a250221c1e80'))) -- System Information: Debian Release: wheezy/sid APT prefers unstable APT policy: (500, 'unstable') Architecture: amd64 (x86_64) Kernel: Linux 3.2.0-2-amd64 (SMP w/8 CPU cores) Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/dash Versions of packages xcp-xapi depends on: ii hwdata 0.233-1 ii libc6 2.13-32 ii libpam0g 1.1.3-7.1 ii libuuid1 2.20.1-5 ii libvhd0 2.0.90-1 ii libxen-4.1 4.1.2-7 ii libxenstore3.0 4.1.2-7 ii lsb-base 4.1+Debian4 ii pciutils 1:3.1.9-3 ii python 2.7.2-10 ii python-xenapi 1.3.2-6 ii stunnel4 [stunnel] 3:4.52-1 ii xcp-eliloader 0.1-4 ii xcp-fe 0.5.2-3+b1 ii xcp-networkd 1.3.2-6 ii xcp-squeezed 1.3.2-6 ii xcp-storage-managers 0.1.1-2 ii xcp-v6d 1.3.2-6 ii xcp-xe 1.3.2-6 ii xen-hypervisor-4.1-amd64 [xen-hypervisor-4.1] 4.1.2-7 ii xen-utils-4.1 4.1.2-7 ii zlib1g 1:1.2.7.dfsg-11 Versions of packages xcp-xapi recommends: ii cifs-utils 2:5.4-2 ii xcp-guest-templates 0.1-3 ii xcp-vncterm 0.1-2 xcp-xapi suggests no packages. -- no debconf information _______________________________________________ Xen-api mailing list Xen-api@xxxxxxxxxxxxx http://lists.xen.org/cgi-bin/mailman/listinfo/xen-api
|
Lists.xenproject.org is hosted with RackSpace, monitoring our |