[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


 


Rackspace

Lists.xenproject.org is hosted with RackSpace, monitoring our
servers 24x7x365 and backed by RackSpace's Fanatical Support®.