Comment 42 for bug 1560965

Revision history for this message
lixiaolong (kong62) wrote :

Hi,I also met this bug under Queens

when i use nova reboot --hard uuid ,instance can be rebooted ,bug nova-compute.log have these:

2018-09-29 17:21:56.348 6074 INFO nova.compute.manager [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] [instance: 9ce3016b-3df2-43c7-aa78-6442feb8187b] Rebooting instance
2018-09-29 17:21:57.407 6074 WARNING nova.compute.manager [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] [instance: 9ce3016b-3df2-43c7-aa78-6442feb8187b] trying to reboot a non-running instance: (state: 0 expected: 1)
2018-09-29 17:21:57.512 6074 INFO nova.virt.libvirt.driver [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] [instance: 9ce3016b-3df2-43c7-aa78-6442feb8187b] Instance destroyed successfully.
2018-09-29 17:21:57.513 6074 INFO os_vif [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Successfully unplugged vif VIFBridge(active=True,address=fa:16:3e:44:c5:42,bridge_name='brq435fb16f-77',has_traffic_filtering=True,id=8a1c11a1-3822-4c92-a677-6fdafd402f97,network=Network(435fb16f-77de-4aa7-a987-c78976458515),plugin='linux_bridge',port_profile=<?>,preserve_on_delete=True,vif_name='tap8a1c11a1-38')
2018-09-29 17:21:57.515 6074 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Running privsep helper: ['sudo', 'nova-rootwrap', '/etc/nova/rootwrap.conf', 'privsep-helper', '--config-file', '/etc/nova/nova.conf', '--config-file', '/etc/nova/nova-compute.conf', '--privsep_context', 'os_brick.privileged.default', '--privsep_sock_path', '/tmp/tmp1iYREs/privsep.sock']
2018-09-29 17:21:58.033 6074 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Spawned new privsep daemon via rootwrap
2018-09-29 17:21:57.993 30402 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep daemon starting
2018-09-29 17:21:57.996 30402 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep process running with uid/gid: 0/0
2018-09-29 17:21:57.998 30402 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep process running with capabilities (eff/prm/inh): CAP_SYS_ADMIN/CAP_SYS_ADMIN/none
2018-09-29 17:21:57.998 30402 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep daemon running as pid 30402
2018-09-29 17:21:58.091 6074 WARNING os_brick.initiator.connectors.iscsi [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Couldn't find iSCSI nodes because iscsiadm err: iscsiadm: No records found

2018-09-29 17:21:58.100 6074 WARNING os_brick.initiator.connectors.iscsi [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Couldn't find iscsi sessions because iscsiadm err: iscsiadm: No active sessions.

2018-09-29 17:21:58.119 6074 INFO nova.virt.libvirt.driver [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Configuring timezone for windows instance to localtime
2018-09-29 17:21:58.119 6074 INFO os_brick.initiator.connectors.iscsi [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Trying to connect to iSCSI portal 172.31.2.222:3260
2018-09-29 17:21:58.173 6074 WARNING os_brick.initiator.connectors.iscsi [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Couldn't find iscsi sessions because iscsiadm err: iscsiadm: No active sessions.

2018-09-29 17:21:59.024 6074 INFO nova.compute.resource_tracker [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Final resource view: name=jitstack0001 phys_ram=257623MB used_ram=36864MB phys_disk=203GB used_disk=0GB total_vcpus=48 used_vcpus=2 pci_stats=[]
2018-09-29 17:22:00.606 6074 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Running privsep helper: ['sudo', 'nova-rootwrap', '/etc/nova/rootwrap.conf', 'privsep-helper', '--config-file', '/etc/nova/nova.conf', '--config-file', '/etc/nova/nova-compute.conf', '--privsep_context', 'vif_plug_linux_bridge.privsep.vif_plug', '--privsep_sock_path', '/tmp/tmpedbNPE/privsep.sock']
2018-09-29 17:22:01.117 6074 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Spawned new privsep daemon via rootwrap
2018-09-29 17:22:01.081 30515 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep daemon starting
2018-09-29 17:22:01.083 30515 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep process running with uid/gid: 0/0
2018-09-29 17:22:01.086 30515 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep process running with capabilities (eff/prm/inh): CAP_NET_ADMIN/CAP_NET_ADMIN/none
2018-09-29 17:22:01.086 30515 INFO oslo.privsep.daemon [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] privsep daemon running as pid 30515
2018-09-29 17:22:01.177 6074 INFO os_vif [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] Successfully plugged vif VIFBridge(active=True,address=fa:16:3e:44:c5:42,bridge_name='brq435fb16f-77',has_traffic_filtering=True,id=8a1c11a1-3822-4c92-a677-6fdafd402f97,network=Network(435fb16f-77de-4aa7-a987-c78976458515),plugin='linux_bridge',port_profile=<?>,preserve_on_delete=True,vif_name='tap8a1c11a1-38')
2018-09-29 17:22:01.358 6074 INFO nova.compute.manager [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] [instance: 9ce3016b-3df2-43c7-aa78-6442feb8187b] VM Resumed (Lifecycle Event)
2018-09-29 17:22:01.397 6074 INFO nova.virt.libvirt.driver [req-c1fb79c2-d47a-4b0b-b9e7-0745518deb9b 4cc1c945837c45ed995f54922fdaf9bd 989c7f5435af432dabd4de1e59d42c65 - default default] [instance: 9ce3016b-3df2-43c7-aa78-6442feb8187b] Instance rebooted successfully.