This is still valid in Newton (SLE12SP2 + libvirt+Xen). The compute log, while running 

ostestr -r '^tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_volume_boot_pattern'

says

2016-11-24 14:03:05.361 20735 DEBUG nova.virt.libvirt.vif [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] vif_type=ovs instance=Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone=None,cell_name=None,cleaned=False,config_drive='',created_at=2016-11-24T14:02:58Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=None,disable_terminate=False,display_description='tempest.common.compute-instance-113612408',display_name='tempest.common.compute-instance-113612408',ec2_ids=EC2Ids,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=Flavor(2),host='d52-54-77-77-77-02',hostname='tempest.common.compute-instance-113612408',id=45,image_ref='',info_cache=InstanceInfoCache,instance_type_id=2,kernel_id='6589b1d5-1128-4354-8b4d-02492c28f51d',key_data='ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDfW9wEI5aC9a78TPAVdlLB/n5ynpR+IZ36DOIWFaZxCScNFl9axRNKk65C+kvim4BG9XDlp5gcxsnaTI0dy+j+V9A1woAKAgfHNHokB99JcHnX+rQ1TJc03z/owj1UXenGb0TsAWRvCr2ed/ICDZcrCnfrcAu7EnUjnE43Oy40L8n1/BCANRdf7VOuLrjJs9kZLtf8F1YntR0J2Z/JO2eOeEoaPoHGdTIxMncOC2vxlv+WYRXOCix01RJ2MRk67PDzwSp0H3gHQb6GmA97e9R4iWKvzuNaWc4atl4tJJ2WPnLIAh2wcFKjC1BhHehBZuhZKTDHyn0hkpsW8YPV+AzN Generated-by-Nova',key_name='tempest-TestVolumeBootPattern-860379563',keypairs=KeyPairList,launch_index=0,launched_at=None,launched_on='d52-54-77-77-77-02',locked=False,locked_by=None,memory_mb=128,metadata={},migration_context=<?>,new_flavor=None,node='d52-54-77-77-77-02.vc3.cloud.suse.de',numa_topology=None,old_flavor=None,os_type=None,pci_devices=PciDeviceList,pci_requests=InstancePCIRequests,power_state=0,progress=0,project_id='77892b47b3644886b8abccca3b1348bd',ramdisk_id='16db3de2-6668-4b65-a03d-bc81848172ce',reservation_id='r-zmyfugva',root_device_name='/dev/vda',root_gb=0,security_groups=SecurityGroupList,services=<?>,shutdown_terminate=False,system_metadata={image_base_image_ref='',image_kernel_id='6589b1d5-1128-4354-8b4d-02492c28f51d',image_min_disk='0',image_min_ram='0',image_ramdisk_id='16db3de2-6668-4b65-a03d-bc81848172ce',network_allocated='True'},tags=<?>,task_state='spawning',terminated_at=None,updated_at=2016-11-24T14:02:59Z,user_data=None,user_id='bc99b0f18e9f4bbc8771459747dfbf82',uuid=08b12f22-3020-4524-b5ec-c4cd357f2def,vcpu_model=None,vcpus=1,vm_mode=None,vm_state='building') vif={"profile": {}, "ovs_interfaceid": "97f1e71f-36f3-4fef-bd86-a813be63039e", "preserve_on_delete": false, "network": {"bridge": "br-int", "subnets": [{"ips": [{"meta": {}, "version": 4, "type": "fixed", "floating_ips": [], "address": "10.100.0.5"}], "version": 4, "meta": {"dhcp_server": "10.100.0.2"}, "dns": [], "routes": [], "cidr": "10.100.0.0/28", "gateway": {"meta": {}, "version": 4, "type": "gateway", "address": "10.100.0.1"}}], "meta": {"injected": false, "tenant_id": "77892b47b3644886b8abccca3b1348bd", "mtu": 8858}, "id": "db161be2-6b35-4876-9e8e-cbde69116fae", "label": "tempest-TestVolumeBootPattern-1007647547-network"}, "devname": "tap97f1e71f-36", "vnic_type": "normal", "qbh_params": null, "meta": {}, "details": {"port_filter": true, "ovs_hybrid_plug": true}, "address": "fa:16:3e:dc:ac:aa", "active": false, "type": "ovs", "id": "97f1e71f-36f3-4fef-bd86-a813be63039e", "qbg_params": null} plug /usr/lib/python2.7/site-packages/nova/virt/libvirt/vif.py:814
2016-11-24 14:03:05.362 20735 DEBUG nova.network.os_vif_util [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Converting VIF {"profile": {}, "ovs_interfaceid": "97f1e71f-36f3-4fef-bd86-a813be63039e", "preserve_on_delete": false, "network": {"bridge": "br-int", "subnets": [{"ips": [{"meta": {}, "version": 4, "type": "fixed", "floating_ips": [], "address": "10.100.0.5"}], "version": 4, "meta": {"dhcp_server": "10.100.0.2"}, "dns": [], "routes": [], "cidr": "10.100.0.0/28", "gateway": {"meta": {}, "version": 4, "type": "gateway", "address": "10.100.0.1"}}], "meta": {"injected": false, "tenant_id": "77892b47b3644886b8abccca3b1348bd", "mtu": 8858}, "id": "db161be2-6b35-4876-9e8e-cbde69116fae", "label": "tempest-TestVolumeBootPattern-1007647547-network"}, "devname": "tap97f1e71f-36", "vnic_type": "normal", "qbh_params": null, "meta": {}, "details": {"port_filter": true, "ovs_hybrid_plug": true}, "address": "fa:16:3e:dc:ac:aa", "active": false, "type": "ovs", "id": "97f1e71f-36f3-4fef-bd86-a813be63039e", "qbg_params": null} nova_to_osvif_vif /usr/lib/python2.7/site-packages/nova/network/os_vif_util.py:362
2016-11-24 14:03:05.362 20735 DEBUG nova.network.os_vif_util [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Converted object VIFBridge(active=False,address=fa:16:3e:dc:ac:aa,bridge_name='qbr97f1e71f-36',has_traffic_filtering=True,id=97f1e71f-36f3-4fef-bd86-a813be63039e,network=Network(db161be2-6b35-4876-9e8e-cbde69116fae),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tap97f1e71f-36') nova_to_osvif_vif /usr/lib/python2.7/site-packages/nova/network/os_vif_util.py:374
2016-11-24 14:03:05.363 20735 DEBUG os_vif [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Plugging vif VIFBridge(active=False,address=fa:16:3e:dc:ac:aa,bridge_name='qbr97f1e71f-36',has_traffic_filtering=True,id=97f1e71f-36f3-4fef-bd86-a813be63039e,network=Network(db161be2-6b35-4876-9e8e-cbde69116fae),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tap97f1e71f-36') plug /usr/lib/python2.7/site-packages/os_vif/__init__.py:76
2016-11-24 14:03:05.781 20735 INFO os_vif [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Successfully plugged vif VIFBridge(active=False,address=fa:16:3e:dc:ac:aa,bridge_name='qbr97f1e71f-36',has_traffic_filtering=True,id=97f1e71f-36f3-4fef-bd86-a813be63039e,network=Network(db161be2-6b35-4876-9e8e-cbde69116fae),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tap97f1e71f-36')
2016-11-24 14:03:05.782 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Running cmd (subprocess): sudo nova-rootwrap /etc/nova/rootwrap.conf ip link set br-int mtu 8858 execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:344
2016-11-24 14:03:06.079 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CMD "sudo nova-rootwrap /etc/nova/rootwrap.conf ip link set br-int mtu 8858" returned: 0 in 0.297s execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:374
2016-11-24 14:03:06.084 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Running cmd (subprocess): sudo nova-rootwrap /etc/nova/rootwrap.conf ip link set qvb97f1e71f-36 mtu 8858 execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:344
2016-11-24 14:03:06.352 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CMD "sudo nova-rootwrap /etc/nova/rootwrap.conf ip link set qvb97f1e71f-36 mtu 8858" returned: 0 in 0.268s execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:374
2016-11-24 14:03:06.355 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Running cmd (subprocess): sudo nova-rootwrap /etc/nova/rootwrap.conf ip link set qvo97f1e71f-36 mtu 8858 execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:344
2016-11-24 14:03:06.604 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CMD "sudo nova-rootwrap /etc/nova/rootwrap.conf ip link set qvo97f1e71f-36 mtu 8858" returned: 0 in 0.250s execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:374
2016-11-24 14:03:06.614 20735 DEBUG oslo_messaging._drivers.amqpdriver [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CALL msg_id: f4ab51f57df04ad2a9fb0f228f513de1 exchange 'nova' topic 'conductor' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:448
2016-11-24 14:03:06.724 20735 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: f4ab51f57df04ad2a9fb0f228f513de1 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:296
2016-11-24 14:03:06.728 20735 DEBUG oslo_messaging._drivers.amqpdriver [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CALL msg_id: acf29049f98f4d24a468cd327ec88390 exchange 'nova' topic 'conductor' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:448
2016-11-24 14:03:06.745 20735 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: acf29049f98f4d24a468cd327ec88390 __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:296
2016-11-24 14:03:07.117 20735 ERROR nova.virt.libvirt.guest [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Error launching a defined domain with XML: <domain type='xen'>
  <name>instance-0000002d</name>
  <uuid>08b12f22-3020-4524-b5ec-c4cd357f2def</uuid>
  <metadata>
    <nova:instance xmlns:nova="http://openstack.org/xmlns/libvirt/nova/1.0">
      <nova:package version="14.0.3-14.0.3~a0~dev19"/>
      <nova:name>tempest.common.compute-instance-113612408</nova:name>
      <nova:creationTime>2016-11-24 14:03:04</nova:creationTime>
      <nova:flavor name="tempest-stuff">
        <nova:memory>128</nova:memory>
        <nova:disk>0</nova:disk>
        <nova:swap>0</nova:swap>
        <nova:ephemeral>0</nova:ephemeral>
        <nova:vcpus>1</nova:vcpus>
      </nova:flavor>
      <nova:owner>
        <nova:user uuid="bc99b0f18e9f4bbc8771459747dfbf82">tempest-TestVolumeBootPattern-2111967676</nova:user>
        <nova:project uuid="77892b47b3644886b8abccca3b1348bd">tempest-TestVolumeBootPattern-2111967676</nova:project>
      </nova:owner>
    </nova:instance>
  </metadata>
  <memory unit='KiB'>131072</memory>
  <currentMemory unit='KiB'>131072</currentMemory>
  <vcpu placement='static'>1</vcpu>
  <os>
    <type arch='x86_64' machine='xenpv'>linux</type>
    <kernel>/var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def/kernel</kernel>
    <initrd>/var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def/ramdisk</initrd>
    <cmdline>ro root=/dev/vda</cmdline>
  </os>
  <features>
    <pae/>
  </features>
  <clock offset='utc'/>
  <on_poweroff>destroy</on_poweroff>
  <on_reboot>restart</on_reboot>
  <on_crash>destroy</on_crash>
  <devices>
    <disk type='block' device='disk'>
      <driver name='phy' type='raw' cache='none' io='native'/>
      <source dev='/dev/disk/by-path/ip-192.168.249.81:3260-iscsi-iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99-lun-1'/>
      <target dev='vda' bus='xen'/>
      <serial>92ccd016-bfbc-4c40-a011-0b9bf47f2c99</serial>
    </disk>
    <interface type='bridge'>
      <mac address='fa:16:3e:dc:ac:aa'/>
      <source bridge='qbr97f1e71f-36'/>
      <target dev='tap97f1e71f-36'/>
    </interface>
    <console type='pty'>
      <target type='xen' port='0'/>
    </console>
    <input type='mouse' bus='xen'/>
    <input type='keyboard' bus='xen'/>
    <graphics type='vnc' port='-1' autoport='yes' listen='0.0.0.0' keymap='en-us'>
      <listen type='address' address='0.0.0.0'/>
    </graphics>
    <video>
      <model type='xen' vram='4096' heads='1' primary='yes'/>
    </video>
    <memballoon model='xen'>
      <stats period='10'/>
    </memballoon>
  </devices>
</domain>

2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Instance failed to spawn
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Traceback (most recent call last):
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 2078, in _build_resources
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     yield resources
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/compute/manager.py", line 1920, in _build_and_run_instance
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     block_device_info=block_device_info)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 2599, in spawn
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     post_xml_callback=gen_confdrive)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 4840, in _create_domain_and_network
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     post_xml_callback=post_xml_callback)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/driver.py", line 4769, in _create_domain
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     guest.launch(pause=pause)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/guest.py", line 144, in launch
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     self._encoded_xml, errors='ignore')
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 220, in __exit__
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     self.force_reraise()
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 196, in force_reraise
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     six.reraise(self.type_, self.value, self.tb)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/nova/virt/libvirt/guest.py", line 139, in launch
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     return self._domain.createWithFlags(flags)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/eventlet/tpool.py", line 186, in doit
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     result = proxy_call(self._autowrap, f, *args, **kwargs)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/eventlet/tpool.py", line 144, in proxy_call
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     rv = execute(f, *args, **kwargs)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/eventlet/tpool.py", line 125, in execute
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     six.reraise(c, e, tb)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib/python2.7/site-packages/eventlet/tpool.py", line 83, in tworker
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     rv = meth(*args, **kwargs)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]   File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1065, in createWithFlags
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def]     if ret == -1: raise libvirtError ('virDomainCreateWithFlags() failed', dom=self)
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] libvirtError: internal error: libxenlight failed to create new domain 'instance-0000002d'
2016-11-24 14:03:07.117 20735 ERROR nova.compute.manager [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] 
2016-11-24 14:03:07.119 20735 INFO nova.compute.manager [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Terminating instance
2016-11-24 14:03:07.120 20735 DEBUG oslo_messaging._drivers.amqpdriver [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CAST unique_id: 38994d23bec0425196e88ebcdde4bba3 NOTIFY exchange 'nova' topic 'notifications.info' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:432
2016-11-24 14:03:07.123 20735 DEBUG nova.compute.manager [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Start destroying the instance on the hypervisor. _shutdown_instance /usr/lib/python2.7/site-packages/nova/compute/manager.py:2192
2016-11-24 14:03:07.131 20735 INFO nova.virt.libvirt.driver [-] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Instance destroyed successfully.
2016-11-24 14:03:07.133 20735 DEBUG nova.virt.libvirt.vif [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] vif_type=ovs instance=Instance(access_ip_v4=None,access_ip_v6=None,architecture=None,auto_disk_config=False,availability_zone=None,cell_name=None,cleaned=False,config_drive='',created_at=2016-11-24T14:02:58Z,default_ephemeral_device=None,default_swap_device=None,deleted=False,deleted_at=None,device_metadata=None,disable_terminate=False,display_description='tempest.common.compute-instance-113612408',display_name='tempest.common.compute-instance-113612408',ec2_ids=EC2Ids,ephemeral_gb=0,ephemeral_key_uuid=None,fault=<?>,flavor=Flavor(2),host='d52-54-77-77-77-02',hostname='tempest.common.compute-instance-113612408',id=45,image_ref='',info_cache=InstanceInfoCache,instance_type_id=2,kernel_id='6589b1d5-1128-4354-8b4d-02492c28f51d',key_data='ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDfW9wEI5aC9a78TPAVdlLB/n5ynpR+IZ36DOIWFaZxCScNFl9axRNKk65C+kvim4BG9XDlp5gcxsnaTI0dy+j+V9A1woAKAgfHNHokB99JcHnX+rQ1TJc03z/owj1UXenGb0TsAWRvCr2ed/ICDZcrCnfrcAu7EnUjnE43Oy40L8n1/BCANRdf7VOuLrjJs9kZLtf8F1YntR0J2Z/JO2eOeEoaPoHGdTIxMncOC2vxlv+WYRXOCix01RJ2MRk67PDzwSp0H3gHQb6GmA97e9R4iWKvzuNaWc4atl4tJJ2WPnLIAh2wcFKjC1BhHehBZuhZKTDHyn0hkpsW8YPV+AzN Generated-by-Nova',key_name='tempest-TestVolumeBootPattern-860379563',keypairs=KeyPairList,launch_index=0,launched_at=None,launched_on='d52-54-77-77-77-02',locked=False,locked_by=None,memory_mb=128,metadata={},migration_context=<?>,new_flavor=None,node='d52-54-77-77-77-02.vc3.cloud.suse.de',numa_topology=None,old_flavor=None,os_type=None,pci_devices=PciDeviceList,pci_requests=InstancePCIRequests,power_state=0,progress=0,project_id='77892b47b3644886b8abccca3b1348bd',ramdisk_id='16db3de2-6668-4b65-a03d-bc81848172ce',reservation_id='r-zmyfugva',root_device_name='/dev/vda',root_gb=0,security_groups=SecurityGroupList,services=<?>,shutdown_terminate=False,system_metadata={image_base_image_ref='',image_kernel_id='6589b1d5-1128-4354-8b4d-02492c28f51d',image_min_disk='0',image_min_ram='0',image_ramdisk_id='16db3de2-6668-4b65-a03d-bc81848172ce',network_allocated='True'},tags=<?>,task_state='spawning',terminated_at=None,updated_at=2016-11-24T14:02:59Z,user_data=None,user_id='bc99b0f18e9f4bbc8771459747dfbf82',uuid=08b12f22-3020-4524-b5ec-c4cd357f2def,vcpu_model=None,vcpus=1,vm_mode=None,vm_state='building') vif={"profile": {}, "ovs_interfaceid": "97f1e71f-36f3-4fef-bd86-a813be63039e", "preserve_on_delete": false, "network": {"bridge": "br-int", "subnets": [{"ips": [{"meta": {}, "version": 4, "type": "fixed", "floating_ips": [], "address": "10.100.0.5"}], "version": 4, "meta": {"dhcp_server": "10.100.0.2"}, "dns": [], "routes": [], "cidr": "10.100.0.0/28", "gateway": {"meta": {}, "version": 4, "type": "gateway", "address": "10.100.0.1"}}], "meta": {"injected": false, "tenant_id": "77892b47b3644886b8abccca3b1348bd", "mtu": 8858}, "id": "db161be2-6b35-4876-9e8e-cbde69116fae", "label": "tempest-TestVolumeBootPattern-1007647547-network"}, "devname": "tap97f1e71f-36", "vnic_type": "normal", "qbh_params": null, "meta": {}, "details": {"port_filter": true, "ovs_hybrid_plug": true}, "address": "fa:16:3e:dc:ac:aa", "active": false, "type": "ovs", "id": "97f1e71f-36f3-4fef-bd86-a813be63039e", "qbg_params": null} unplug /usr/lib/python2.7/site-packages/nova/virt/libvirt/vif.py:1035
2016-11-24 14:03:07.134 20735 DEBUG nova.network.os_vif_util [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Converting VIF {"profile": {}, "ovs_interfaceid": "97f1e71f-36f3-4fef-bd86-a813be63039e", "preserve_on_delete": false, "network": {"bridge": "br-int", "subnets": [{"ips": [{"meta": {}, "version": 4, "type": "fixed", "floating_ips": [], "address": "10.100.0.5"}], "version": 4, "meta": {"dhcp_server": "10.100.0.2"}, "dns": [], "routes": [], "cidr": "10.100.0.0/28", "gateway": {"meta": {}, "version": 4, "type": "gateway", "address": "10.100.0.1"}}], "meta": {"injected": false, "tenant_id": "77892b47b3644886b8abccca3b1348bd", "mtu": 8858}, "id": "db161be2-6b35-4876-9e8e-cbde69116fae", "label": "tempest-TestVolumeBootPattern-1007647547-network"}, "devname": "tap97f1e71f-36", "vnic_type": "normal", "qbh_params": null, "meta": {}, "details": {"port_filter": true, "ovs_hybrid_plug": true}, "address": "fa:16:3e:dc:ac:aa", "active": false, "type": "ovs", "id": "97f1e71f-36f3-4fef-bd86-a813be63039e", "qbg_params": null} nova_to_osvif_vif /usr/lib/python2.7/site-packages/nova/network/os_vif_util.py:362
2016-11-24 14:03:07.135 20735 DEBUG nova.network.os_vif_util [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Converted object VIFBridge(active=False,address=fa:16:3e:dc:ac:aa,bridge_name='qbr97f1e71f-36',has_traffic_filtering=True,id=97f1e71f-36f3-4fef-bd86-a813be63039e,network=Network(db161be2-6b35-4876-9e8e-cbde69116fae),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tap97f1e71f-36') nova_to_osvif_vif /usr/lib/python2.7/site-packages/nova/network/os_vif_util.py:374
2016-11-24 14:03:07.136 20735 DEBUG os_vif [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Unplugging vif VIFBridge(active=False,address=fa:16:3e:dc:ac:aa,bridge_name='qbr97f1e71f-36',has_traffic_filtering=True,id=97f1e71f-36f3-4fef-bd86-a813be63039e,network=Network(db161be2-6b35-4876-9e8e-cbde69116fae),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tap97f1e71f-36') unplug /usr/lib/python2.7/site-packages/os_vif/__init__.py:109
2016-11-24 14:03:07.325 20735 INFO os_vif [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Successfully unplugged vif VIFBridge(active=False,address=fa:16:3e:dc:ac:aa,bridge_name='qbr97f1e71f-36',has_traffic_filtering=True,id=97f1e71f-36f3-4fef-bd86-a813be63039e,network=Network(db161be2-6b35-4876-9e8e-cbde69116fae),plugin='ovs',port_profile=VIFPortProfileBase,preserve_on_delete=False,vif_name='tap97f1e71f-36')
2016-11-24 14:03:07.326 20735 DEBUG nova.virt.libvirt.volume.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] calling os-brick to detach iSCSI Volume disconnect_volume /usr/lib/python2.7/site-packages/nova/virt/libvirt/volume/iscsi.py:72
2016-11-24 14:03:07.326 20735 DEBUG os_brick.initiator.connectors.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] ==> disconnect_volume: call {'args': (<os_brick.initiator.connectors.iscsi.ISCSIConnector object at 0x7fe26cb4dd90>, {u'device_path': u'/dev/disk/by-path/ip-192.168.249.81:3260-iscsi-iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99-lun-1', u'target_discovered': False, u'encrypted': False, u'qos_specs': None, u'target_iqn': u'iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99', u'target_portal': u'192.168.249.81:3260', u'volume_id': u'92ccd016-bfbc-4c40-a011-0b9bf47f2c99', u'auth_password': u'Jx3yQXzKcc9zXCwp', u'target_lun': 1, u'access_mode': u'rw', u'auth_username': u'8uFqkL7Vuem52gBeGPVP', u'auth_method': u'CHAP'}, None), 'kwargs': {}} trace_logging_wrapper /usr/lib/python2.7/site-packages/os_brick/utils.py:141
2016-11-24 14:03:07.327 20735 DEBUG oslo_concurrency.lockutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Lock "connect_volume" acquired by "os_brick.initiator.connectors.iscsi.disconnect_volume" :: waited 0.000s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:270
2016-11-24 14:03:07.327 20735 DEBUG os_brick.initiator.linuxscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Flushing IO for device /dev/sdc flush_device_io /usr/lib/python2.7/site-packages/os_brick/initiator/linuxscsi.py:148
2016-11-24 14:03:07.344 20735 DEBUG os_brick.initiator.linuxscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Remove SCSI device /dev/sdc with /sys/block/sdc/device/delete remove_scsi_device /usr/lib/python2.7/site-packages/os_brick/initiator/linuxscsi.py:71
2016-11-24 14:03:07.413 20735 DEBUG os_brick.initiator.linuxscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Checking to see if SCSI volume /dev/disk/by-path/ip-192.168.249.81:3260-iscsi-iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99-lun-1 has been removed. wait_for_volume_removal /usr/lib/python2.7/site-packages/os_brick/initiator/linuxscsi.py:79
2016-11-24 14:03:07.414 20735 DEBUG os_brick.initiator.linuxscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] SCSI volume /dev/disk/by-path/ip-192.168.249.81:3260-iscsi-iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99-lun-1 has been removed. wait_for_volume_removal /usr/lib/python2.7/site-packages/os_brick/initiator/linuxscsi.py:85
2016-11-24 14:03:07.470 20735 DEBUG os_brick.initiator.connectors.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] iscsiadm ('--op', 'update', '-n', 'node.startup', '-v', 'manual'): stdout= stderr= _run_iscsiadm /usr/lib/python2.7/site-packages/os_brick/initiator/connectors/iscsi.py:593
2016-11-24 14:03:07.525 20735 DEBUG os_brick.initiator.connectors.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] iscsiadm ('--logout',): stdout=Logging out of session [sid: 24, target: iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99, portal: 192.168.249.81,3260]
Logout of [sid: 24, target: iqn.2010-10.org.openstack:volume-92ccd016-bfbc-4c40-a011-0b9bf47f2c99, portal: 192.168.249.81,3260] successful.
 stderr= _run_iscsiadm /usr/lib/python2.7/site-packages/os_brick/initiator/connectors/iscsi.py:593
2016-11-24 14:03:07.584 20735 DEBUG os_brick.initiator.connectors.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] iscsiadm ('--op', 'delete'): stdout= stderr= _run_iscsiadm /usr/lib/python2.7/site-packages/os_brick/initiator/connectors/iscsi.py:593
2016-11-24 14:03:07.585 20735 DEBUG oslo_concurrency.lockutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Lock "connect_volume" released by "os_brick.initiator.connectors.iscsi.disconnect_volume" :: held 0.258s inner /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:282
2016-11-24 14:03:07.585 20735 DEBUG os_brick.initiator.connectors.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] <== disconnect_volume: return (259ms) None trace_logging_wrapper /usr/lib/python2.7/site-packages/os_brick/utils.py:165
2016-11-24 14:03:07.585 20735 DEBUG nova.virt.libvirt.volume.iscsi [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Disconnected iSCSI Volume vda disconnect_volume /usr/lib/python2.7/site-packages/nova/virt/libvirt/volume/iscsi.py:78
2016-11-24 14:03:07.586 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Running cmd (subprocess): mv /var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def /var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def_del execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:344
2016-11-24 14:03:07.655 20735 DEBUG oslo_concurrency.processutils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CMD "mv /var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def /var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def_del" returned: 0 in 0.068s execute /usr/lib/python2.7/site-packages/oslo_concurrency/processutils.py:374
2016-11-24 14:03:07.657 20735 INFO nova.virt.libvirt.driver [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Deleting instance files /var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def_del
2016-11-24 14:03:07.664 20735 INFO nova.virt.libvirt.driver [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Deletion of /var/lib/nova/instances/08b12f22-3020-4524-b5ec-c4cd357f2def_del complete
2016-11-24 14:03:07.670 20735 DEBUG oslo_messaging._drivers.amqpdriver [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] CALL msg_id: 42bc9a8640704d60b51f8d61b0c8e32d exchange 'nova' topic 'conductor' _send /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:448
2016-11-24 14:03:07.841 20735 DEBUG oslo_messaging._drivers.amqpdriver [-] received reply msg_id: 42bc9a8640704d60b51f8d61b0c8e32d __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:296
2016-11-24 14:03:07.849 20735 DEBUG nova.virt.libvirt.guest [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] Error from libvirt during undefineFlags. -1Retrying with undefine delete_configuration /usr/lib/python2.7/site-packages/nova/virt/libvirt/guest.py:266
2016-11-24 14:03:07.850 20735 INFO nova.compute.manager [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] [instance: 08b12f22-3020-4524-b5ec-c4cd357f2def] Took 0.73 seconds to destroy the instance on the hypervisor.
2016-11-24 14:03:07.851 20735 DEBUG os_brick.utils [req-2c616be2-2a1e-4c8a-9e13-c987769c08b9 bc99b0f18e9f4bbc8771459747dfbf82 77892b47b3644886b8abccca3b1348bd - - -] ==> get_connector_properties: call {'execute': None, 'my_ip': '192.168.249.82', 'enforce_multipath': True, 'host': 'd52-54-77-77-77-02', 'root_helper': 'sudo nova-rootwrap /etc/nova/rootwrap.conf', 'multipath': False} trace_logging_wrapper /usr/lib/python2.7/site-packages/os_brick/utils.py:141