2013-05-17T14:54:44.306147+03:00 hv04 kernel: [ 909.307861] device vif2.0 left promiscuous mode 2013-05-17T14:54:44.325228+03:00 hv04 local: /etc/xen/scripts/block: remove XENBUS_PATH=backend/vbd/2/51712 2013-05-17T14:54:44.326123+03:00 hv04 local: /etc/xen/scripts/block: remove XENBUS_PATH=backend/vbd/2/51728 2013-05-17T14:54:44.334134+03:00 hv04 tapdisk2[4133]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.334667+03:00 hv04 tapdisk2[4133]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.335095+03:00 hv04 tapdisk2[4136]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.335536+03:00 hv04 tapdisk2[4136]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.335968+03:00 hv04 tapdisk2[4292]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.336414+03:00 hv04 tapdisk2[4292]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.336932+03:00 hv04 tapdisk2[4297]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.337392+03:00 hv04 tapdisk2[4297]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.337822+03:00 hv04 tapdisk2[4133]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.338350+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.338872+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.339541+03:00 hv04 tapdisk2[4136]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.340338+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.343005+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.343017+03:00 hv04 tapdisk2[4292]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.343022+03:00 hv04 tapdisk2[4292]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.343987+03:00 hv04 kernel: [ 909.342243] blktap_ring_vm_close: 6 callbacks suppressed 2013-05-17T14:54:44.343995+03:00 hv04 kernel: [ 909.342248] blktap_ring_vm_close: unmapping ring 2 2013-05-17T14:54:44.343997+03:00 hv04 kernel: [ 909.342252] blktap_ring_release: freeing device 2 2013-05-17T14:54:44.343998+03:00 hv04 kernel: [ 909.342991] blktap_device_destroy: destroy device 2 users 0 2013-05-17T14:54:44.344010+03:00 hv04 tapdisk2[4292]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.344018+03:00 hv04 tapdisk2[4297]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.344023+03:00 hv04 tapdisk2[4297]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.344441+03:00 hv04 tapdisk2[4297]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.344818+03:00 hv04 tapdisk2[4292]: received 'close' message (uuid = 2) 2013-05-17T14:54:44.344956+03:00 hv04 tapdisk2[4292]: closed image /storage/images/manual/test1.raw (0 users, state: 0x00000000, type: 0) 2013-05-17T14:54:44.345150+03:00 hv04 tapdisk2[4292]: sending 'close response' message (uuid = 2) 2013-05-17T14:54:44.345289+03:00 hv04 tapdisk2[4292]: received 'detach' message (uuid = 2) 2013-05-17T14:54:44.345422+03:00 hv04 tapdisk2[4292]: sending 'detach response' message (uuid = 2) 2013-05-17T14:54:44.345553+03:00 hv04 local: /etc/xen/scripts/vif-ovs: offline type_if=vif XENBUS_PATH=backend/vif/2/0 2013-05-17T14:54:44.345694+03:00 hv04 tapdisk2[4133]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.346120+03:00 hv04 tapdisk2[4133]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.346500+03:00 hv04 tapdisk2[4136]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.346878+03:00 hv04 tapdisk2[4136]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.347352+03:00 hv04 tapdisk2[4297]: received 'pid' message (uuid = 0) 2013-05-17T14:54:44.347771+03:00 hv04 tapdisk2[4297]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:44.348148+03:00 hv04 tapdisk2[4133]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.348530+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.348916+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.349301+03:00 hv04 tapdisk2[4136]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.349682+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.350069+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.350122+03:00 hv04 kernel: [ 909.350488] blktap_ring_vm_close: unmapping ring 3 2013-05-17T14:54:44.350131+03:00 hv04 kernel: [ 909.350492] blktap_ring_release: freeing device 3 2013-05-17T14:54:44.350590+03:00 hv04 tapdisk2[4297]: received 'list' message (uuid = 65535) 2013-05-17T14:54:44.350804+03:00 hv04 tapdisk2[4297]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.350996+03:00 hv04 tapdisk2[4297]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:44.351175+03:00 hv04 tapdisk2[4297]: received 'close' message (uuid = 3) 2013-05-17T14:54:44.351367+03:00 hv04 tapdisk2[4297]: closed image /storage/images/manual/test1_storage.raw (0 users, state: 0x00000000, type: 0) 2013-05-17T14:54:44.351549+03:00 hv04 tapdisk2[4297]: sending 'close response' message (uuid = 3) 2013-05-17T14:54:44.351729+03:00 hv04 tapdisk2[4297]: received 'detach' message (uuid = 3) 2013-05-17T14:54:44.351994+03:00 hv04 tapdisk2[4297]: sending 'detach response' message (uuid = 3) 2013-05-17T14:54:44.354133+03:00 hv04 kernel: [ 909.352103] blktap_device_destroy: destroy device 3 users 0 2013-05-17T14:54:44.368669+03:00 hv04 ovs-vsctl: 00001|vsctl|INFO|Called as ovs-vsctl del-port vlannet vif2.0 2013-05-17T14:54:44.404213+03:00 hv04 local: /etc/xen/scripts/vif-ovs: ip link set vif2.0 down failed 2013-05-17T14:54:44.405650+03:00 hv04 local: /etc/xen/scripts/vif-ovs: Successful vif-ovs offline for switch vlannet dev vif2.0, vlan 2512, mtu 9000 2013-05-17T14:54:53.136729+03:00 hv04 tapdisk2[4133]: received 'pid' message (uuid = 0) 2013-05-17T14:54:53.137411+03:00 hv04 tapdisk2[4133]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:53.137945+03:00 hv04 tapdisk2[4136]: received 'pid' message (uuid = 0) 2013-05-17T14:54:53.138135+03:00 hv04 kernel: [ 918.138974] blktap_control_allocate_tap: allocated tap ffff8800ea8a8000 2013-05-17T14:54:53.138590+03:00 hv04 tapdisk2[4136]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:53.138993+03:00 hv04 tapdisk2[4133]: received 'list' message (uuid = 65535) 2013-05-17T14:54:53.139410+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.139824+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.140303+03:00 hv04 tapdisk2[4136]: received 'list' message (uuid = 65535) 2013-05-17T14:54:53.140728+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.141144+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.141543+03:00 hv04 tapdisk2[4695]: I/O queue driver: lio 2013-05-17T14:54:53.142019+03:00 hv04 tapdisk2[4695]: received 'attach' message (uuid = 2) 2013-05-17T14:54:53.142123+03:00 hv04 kernel: [ 918.143614] blktap_ring_open: opening device blktap2 2013-05-17T14:54:53.142130+03:00 hv04 kernel: [ 918.143617] blktap_ring_open: opened device 2 2013-05-17T14:54:53.142131+03:00 hv04 kernel: [ 918.143636] blktap_ring_mmap: blktap: mapping pid is 4696 2013-05-17T14:54:53.142133+03:00 hv04 kernel: [ 918.143790] blktap_validate_params: aio:/storage/images/manual/test1.raw: capacity: 20971520, sector-size: 512 2013-05-17T14:54:53.142134+03:00 hv04 kernel: [ 918.143793] blktap_validate_params: aio:/storage/images/manual/test1.raw: capacity: 20971520, sector-size: 512 2013-05-17T14:54:53.142135+03:00 hv04 kernel: [ 918.143794] blktap_device_create: minor 2 sectors 20971520 sector-size 512 2013-05-17T14:54:53.142136+03:00 hv04 kernel: [ 918.143973] blktap_device_create: creation of 253:2: 0 2013-05-17T14:54:53.142439+03:00 hv04 tapdisk2[4695]: sending 'attach response' message (uuid = 2) 2013-05-17T14:54:53.143007+03:00 hv04 tapdisk2[4695]: received 'open' message (uuid = 2) 2013-05-17T14:54:53.143514+03:00 hv04 tapdisk2[4695]: block-aio open('/storage/images/manual/test1.raw') 2013-05-17T14:54:53.144159+03:00 hv04 tapdisk2[4695]: open(/storage/images/manual/test1.raw) with O_DIRECT 2013-05-17T14:54:53.144654+03:00 hv04 tapdisk2[4695]: Image size: 2013-05-17T14:54:53.145141+03:00 hv04 tapdisk2[4695]: opened image /storage/images/manual/test1.raw (1 users, state: 0x00000001, type: 0) 2013-05-17T14:54:53.145556+03:00 hv04 tapdisk2[4695]: VBD CHAIN: 2013-05-17T14:54:53.146045+03:00 hv04 tapdisk2[4695]: /storage/images/manual/test1.raw: 0 2013-05-17T14:54:53.146456+03:00 hv04 tapdisk2[4695]: sending 'open response' message (uuid = 2) 2013-05-17T14:54:53.148803+03:00 hv04 tapdisk2[4133]: received 'pid' message (uuid = 0) 2013-05-17T14:54:53.149375+03:00 hv04 tapdisk2[4133]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:53.149855+03:00 hv04 tapdisk2[4136]: received 'pid' message (uuid = 0) 2013-05-17T14:54:53.150365+03:00 hv04 tapdisk2[4136]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:53.150846+03:00 hv04 tapdisk2[4695]: received 'pid' message (uuid = 0) 2013-05-17T14:54:53.151329+03:00 hv04 tapdisk2[4695]: sending 'pid response' message (uuid = 0) 2013-05-17T14:54:53.151800+03:00 hv04 tapdisk2[4133]: received 'list' message (uuid = 65535) 2013-05-17T14:54:53.152392+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.152893+03:00 hv04 tapdisk2[4133]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.153406+03:00 hv04 tapdisk2[4136]: received 'list' message (uuid = 65535) 2013-05-17T14:54:53.153897+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.154130+03:00 hv04 kernel: [ 918.153577] blktap_control_allocate_tap: allocated tap ffff8800f4eba800 2013-05-17T14:54:53.154412+03:00 hv04 tapdisk2[4136]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.155063+03:00 hv04 tapdisk2[4695]: received 'list' message (uuid = 65535) 2013-05-17T14:54:53.155582+03:00 hv04 tapdisk2[4695]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.156209+03:00 hv04 tapdisk2[4695]: sending 'list response' message (uuid = 65535) 2013-05-17T14:54:53.156694+03:00 hv04 tapdisk2[4700]: I/O queue driver: lio 2013-05-17T14:54:53.157207+03:00 hv04 tapdisk2[4700]: received 'attach' message (uuid = 3) 2013-05-17T14:54:53.157696+03:00 hv04 tapdisk2[4700]: sending 'attach response' message (uuid = 3) 2013-05-17T14:54:53.158125+03:00 hv04 kernel: [ 918.158869] blktap_ring_open: opening device blktap3 2013-05-17T14:54:53.158297+03:00 hv04 tapdisk2[4700]: received 'open' message (uuid = 3) 2013-05-17T14:54:53.158940+03:00 hv04 tapdisk2[4700]: block-aio open('/storage/images/manual/test1_storage.raw') 2013-05-17T14:54:53.159465+03:00 hv04 tapdisk2[4700]: open(/storage/images/manual/test1_storage.raw) with O_DIRECT 2013-05-17T14:54:53.159953+03:00 hv04 tapdisk2[4700]: Image size: 2013-05-17T14:54:53.160443+03:00 hv04 tapdisk2[4700]: opened image /storage/images/manual/test1_storage.raw (1 users, state: 0x00000001, type: 0) 2013-05-17T14:54:53.160932+03:00 hv04 tapdisk2[4700]: VBD CHAIN: 2013-05-17T14:54:53.161420+03:00 hv04 tapdisk2[4700]: /storage/images/manual/test1_storage.raw: 0 2013-05-17T14:54:53.161988+03:00 hv04 tapdisk2[4700]: sending 'open response' message (uuid = 3) 2013-05-17T14:54:53.190990+03:00 hv04 local: /etc/xen/scripts/block: add XENBUS_PATH=backend/vbd/3/51712 2013-05-17T14:54:53.193395+03:00 hv04 local: /etc/xen/scripts/block: add XENBUS_PATH=backend/vbd/3/51728 2013-05-17T14:54:53.271920+03:00 hv04 local: /etc/xen/scripts/vif-ovs: online type_if=vif XENBUS_PATH=backend/vif/3/0 2013-05-17T14:54:53.302602+03:00 hv04 ovs-vsctl: 00001|vsctl|INFO|Called as ovs-vsctl add-port vlannet vif3.0 tag=2512 2013-05-17T14:54:53.306135+03:00 hv04 kernel: [ 918.307947] device vif3.0 entered promiscuous mode 2013-05-17T14:54:53.355759+03:00 hv04 local: /etc/xen/scripts/vif-ovs: Successful vif-ovs online for switch vlannet dev vif3.0, vlan 2512, mtu 9000 2013-05-17T14:54:53.357293+03:00 hv04 local: /etc/xen/scripts/vif-ovs: Writing backend/vif/3/0/hotplug-status connected to xenstore. 2013-05-17T14:54:54.878304+03:00 hv04 kernel: [ 919.878284] blkback: event-channel 19 2013-05-17T14:54:54.878328+03:00 hv04 kernel: [ 919.878385] blkback: protocol 1 (x86_64-abi) 2013-05-17T14:54:54.878331+03:00 hv04 kernel: [ 919.878562] blkback: ring-ref 770 2013-05-17T14:54:54.886195+03:00 hv04 kernel: [ 919.887871] blkback: event-channel 20 2013-05-17T14:54:54.886209+03:00 hv04 kernel: [ 919.887966] blkback: protocol 1 (x86_64-abi) 2013-05-17T14:54:54.890191+03:00 hv04 kernel: [ 919.888212] blkback: ring-ref 771