An unknown error has occurred when trying to get the list of nodes from the Ironic inventory. Error: StrictVersion instance has no attribute 'version'

Bug #1793766 reported by Matt Riedemann
14
This bug affects 3 people
Affects Status Importance Assigned to Milestone
OpenStack Compute (nova)
Confirmed
Low
Unassigned

Bug Description

Seen in Ironic CI jobs since Rocky when version discovery was added to the ironic virt driver in nova-compute:

http://logs.openstack.org/27/602127/2/check/ironic-tempest-dsvm-ipa-wholedisk-bios-agent_ipmitool-tinyipa/4238d0f/controller/logs/screen-n-cpu.txt.gz?level=TRACE#_Sep_20_21_52_53_685133

Sep 20 21:52:03.587629 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task Traceback (most recent call last):
Sep 20 21:52:03.587816 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task File "/usr/local/lib/python2.7/dist-packages/oslo_service/periodic_task.py", line 220, in run_periodic_tasks
Sep 20 21:52:03.588019 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task task(self, context)
Sep 20 21:52:03.588182 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task File "/opt/stack/nova/nova/compute/manager.py", line 7462, in _sync_power_states
Sep 20 21:52:03.588344 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task num_vm_instances = self.driver.get_num_instances()
Sep 20 21:52:03.588517 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task File "/opt/stack/nova/nova/virt/driver.py", line 183, in get_num_instances
Sep 20 21:52:03.588714 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task return len(self.list_instances())
Sep 20 21:52:03.588885 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task File "/opt/stack/nova/nova/virt/ironic/driver.py", line 624, in list_instances
Sep 20 21:52:03.589071 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task fields=['instance_uuid'], limit=0)
Sep 20 21:52:03.589263 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task File "/opt/stack/nova/nova/virt/ironic/driver.py", line 611, in _get_node_list
Sep 20 21:52:03.589447 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task raise exception.VirtDriverNotReady()
Sep 20 21:52:03.589602 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task VirtDriverNotReady: Virt driver is not ready.
Sep 20 21:52:03.589770 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR oslo_service.periodic_task
Sep 20 21:52:53.625466 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR nova.compute.manager [None req-2339900e-55df-468b-95ff-b904d73d5728 None None] No compute node record for host ubuntu-xenial-inap-mtl01-0002177186: ComputeHostNotFound_Remote: Compute host ubuntu-xenial-inap-mtl01-0002177186 could not be found.
Sep 20 21:52:53.685133 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: ERROR nova.virt.ironic.driver [None req-2339900e-55df-468b-95ff-b904d73d5728 None None] An unknown error has occurred when trying to get the list of nodes from the Ironic inventory. Error: StrictVersion instance has no attribute 'version'
Sep 20 21:52:53.685496 ubuntu-xenial-inap-mtl01-0002177186 nova-compute[14241]: WARNING nova.compute.manager [None req-2339900e-55df-468b-95ff-b904d73d5728 None None] Virt driver is not ready.: VirtDriverNotReady: Virt driver is not ready.

The virt driver not ready error is normal/expected while ironic is coming up after nova-compute, but the StrictVersion thing should be handled probably.

Tags: compute ironic
Revision history for this message
David Hill (david-hill-ubisoft) wrote :
Download full text (7.8 KiB)

I do have this error looping every minute or so.

2019-05-17 21:33:39.463 8 DEBUG ironicclient.common.http [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] No version header in response, requesting from server negotiate_version /usr/lib/python3.6/site-packages/ironicclient/common/http.py:157
2019-05-17 21:33:39.473 8 ERROR nova.virt.ironic.driver [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] An unknown error has occurred when trying to get the list of nodes from the Ironic inventory. Error: 'StrictVersion' object has no attribute 'version'
2019-05-17 21:33:39.473 8 WARNING nova.compute.manager [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Virt driver is not ready.: nova.exception.VirtDriverNotReady: Virt driver is not ready.
2019-05-17 21:33:40.473 8 DEBUG oslo_service.periodic_task [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Running periodic task ComputeManager._heal_instance_info_cache run_periodic_tasks /usr/lib/python3.6/site-packages/oslo_service/periodic_task.py:217
2019-05-17 21:33:40.473 8 DEBUG nova.compute.manager [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Starting heal instance info cache _heal_instance_info_cache /usr/lib/python3.6/site-packages/nova/compute/manager.py:7247
2019-05-17 21:33:40.474 8 DEBUG nova.compute.manager [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Rebuilding the list of instances to heal _heal_instance_info_cache /usr/lib/python3.6/site-packages/nova/compute/manager.py:7251
2019-05-17 21:33:40.487 8 DEBUG nova.compute.manager [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Didn't find any instances for network info cache update. _heal_instance_info_cache /usr/lib/python3.6/site-packages/nova/compute/manager.py:7333
2019-05-17 21:33:40.487 8 DEBUG oslo_service.periodic_task [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Running periodic task ComputeManager._poll_unconfirmed_resizes run_periodic_tasks /usr/lib/python3.6/site-packages/oslo_service/periodic_task.py:217
2019-05-17 21:33:40.488 8 DEBUG oslo_service.periodic_task [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Running periodic task ComputeManager._reclaim_queued_deletes run_periodic_tasks /usr/lib/python3.6/site-packages/oslo_service/periodic_task.py:217
2019-05-17 21:33:40.488 8 DEBUG nova.compute.manager [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] CONF.reclaim_instance_interval <= 0, skipping... _reclaim_queued_deletes /usr/lib/python3.6/site-packages/nova/compute/manager.py:7946
2019-05-17 21:33:41.422 8 DEBUG oslo_service.periodic_task [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Running periodic task ComputeManager._poll_rebooting_instances run_periodic_tasks /usr/lib/python3.6/site-packages/oslo_service/periodic_task.py:217
2019-05-17 21:33:41.423 8 DEBUG oslo_service.periodic_task [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Running periodic task ComputeManager._poll_rescued_instances run_periodic_tasks /usr/lib/python3.6/site-packages/oslo_service/periodic_task.py:217
2019-05-17 21:33:43.422 8 DEBUG oslo_service.periodic_task [req-f1d152cb-d19c-4946-b0b0-baaf2f9e4804 - - - - -] Running periodic task ComputeManager._instance_usage_audit run_periodic_tasks /...

Read more...

Revision history for this message
Rajini Karthik (rajini-karthik) wrote :

I see this error too

Revision history for this message
Jay Faulkner (jason-oldos) wrote :

Please indicate the versions of Ironic and Nova you're using. Thanks.

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.