Skip to content

Instantly share code, notes, and snippets.

@skrobul
Last active November 24, 2025 16:10
Show Gist options
  • Select an option

  • Save skrobul/64798d4ff8987ee3fcce93f8f1b991e5 to your computer and use it in GitHub Desktop.

Select an option

Save skrobul/64798d4ff8987ee3fcce93f8f1b991e5 to your computer and use it in GitHub Desktop.
Ironic fail to download image from Glance on 2025.2
2025-11-24 15:50:18.573 13 DEBUG ironic.conductor.manager [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Completed sending sensor data, evaluated 4 nodes with 4 workers in 12.03 seconds _send_sensor_data /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/manager.py:2974
2025-11-24 15:50:22.437 13 INFO ironic.conductor.manager [None req-5789c071-ce73-4fe7-b99d-dd2fcb478d23 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] VIF 7b45c83d-887f-4458-b83e-8c87387256bb successfully attached to node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd
2025-11-24 15:50:24.384 13 DEBUG ironic.conductor.manager [None req-d7c99d0b-3563-4679-b08a-40e8038fc49d 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] RPC update_node called for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. update_node /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/manager.py:204
2025-11-24 15:50:24.422 13 DEBUG ironic.conductor.task_manager [None req-d7c99d0b-3563-4679-b08a-40e8038fc49d 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd successfully reserved for node update (took 0.02 seconds) reserve_node /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/task_manager.py:363
2025-11-24 15:50:24.974 13 DEBUG ironic.conductor.manager [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] RPC validate_driver_interfaces called for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. validate_driver_interfaces /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/manager.py:2139
2025-11-24 15:50:25.458 13 DEBUG ironic.common.glance_service.image_service [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 5048de36-4c01-4047-b638-195e639cb1e3 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:50:25.932 13 ERROR ironic.common.glance_service.service_utils [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 5048de36-4c01-4047-b638-195e639cb1e3: 'NoneType' object has no attribute 'image'
2025-11-24 15:50:25.958 13 DEBUG ironic.drivers.modules.agent_base [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deploy steps are not yet available for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd get_steps /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/agent_base.py:331
2025-11-24 15:50:26.514 13 DEBUG ironic.common.neutron [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:50:27.096 13 DEBUG ironic.common.neutron [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:50:27.625 13 DEBUG ironic.common.neutron [None req-6a0d5ea2-7b16-4ee9-97f2-ba1016930353 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:50:28.843 13 DEBUG ironic.conductor.manager [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] RPC do_node_deploy called for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. do_node_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/manager.py:934
2025-11-24 15:50:28.877 13 DEBUG ironic.conductor.task_manager [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd successfully reserved for node deployment (took 0.02 seconds) reserve_node /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/task_manager.py:363
2025-11-24 15:50:28.878 13 WARNING ironic.conductor.deployments [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Could not automatically save lessee dcd8e230ebf448df85cd03d332e12ac1 to node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. Node already has a defined lessee of 8281ed4fb25748b8961f73a10a3fd090.
2025-11-24 15:50:29.358 13 DEBUG ironic.common.glance_service.image_service [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 5048de36-4c01-4047-b638-195e639cb1e3 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:50:29.911 13 ERROR ironic.common.glance_service.service_utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 5048de36-4c01-4047-b638-195e639cb1e3: 'NoneType' object has no attribute 'image'
2025-11-24 15:50:29.963 13 DEBUG ironic.drivers.modules.agent_base [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deploy steps are not yet available for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd get_steps /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/agent_base.py:331
2025-11-24 15:50:29.964 13 DEBUG ironic.common.states [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Exiting old state 'available' in response to event 'deploy' on_exit /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:361
2025-11-24 15:50:29.964 13 DEBUG ironic.common.states [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Entering new state 'deploying' in response to event 'deploy' on_enter /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:367
2025-11-24 15:50:29.995 13 INFO ironic.conductor.task_manager [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd moved to provision state "deploying" from state "available"; target provision state is "active"
2025-11-24 15:50:30.000 13 DEBUG ironic.conductor.configdrive_utils [req-fce28aae-0aa5-44ed-9ebd-72d4ee13157b req-45d9c574-08a8-4942-8c4a-7271bfc6357a - - - - - -] Starting to evaluate configdrive for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd check_and_fix_configdrive /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/configdrive_utils.py:477
2025-11-24 15:50:30.698 13 DEBUG ironic.common.neutron [req-fce28aae-0aa5-44ed-9ebd-72d4ee13157b req-45d9c574-08a8-4942-8c4a-7271bfc6357a - - - - - -] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:50:31.338 13 DEBUG ironic.common.neutron [req-fce28aae-0aa5-44ed-9ebd-72d4ee13157b req-45d9c574-08a8-4942-8c4a-7271bfc6357a - - - - - -] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:50:32.449 13 INFO ironic.conductor.utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd current power state is 'power on', requested state is 'power off'.
2025-11-24 15:50:40.465 13 WARNING ironic.common.nova [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Could not connect to Nova to send a power notification, please check configuration. An auth plugin is required to determine endpoint URL: keystoneauth1.exceptions.auth_plugins.MissingAuthPlugin: An auth plugin is required to determine endpoint URL
2025-11-24 15:50:40.472 13 INFO ironic.conductor.utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Successfully set node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd power state to power off by power off.
2025-11-24 15:50:40.472 13 INFO ironic.drivers.modules.network.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unbinding instance ports from node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd
2025-11-24 15:50:45.189 13 DEBUG ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:50:45.190 13 DEBUG ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Removing ports on network c57e4a02-73bb-4c6e-ab03-537ea11168e3 on node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. remove_ports_from_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:498
2025-11-24 15:50:45.811 13 INFO ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Successfully removed node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd neutron ports.
2025-11-24 15:50:45.812 13 INFO ironic.drivers.modules.network.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Adding provisioning network to node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd
2025-11-24 15:50:46.565 13 DEBUG ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] For node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd, creating neutron ports on network c57e4a02-73bb-4c6e-ab03-537ea11168e3 using NeutronNetwork network interface. add_ports_to_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:313
2025-11-24 15:50:46.565 13 WARNING ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port a42fdf63-c939-4483-971e-4596c480b743
2025-11-24 15:50:46.565 13 WARNING ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 89e88703-0fd3-4527-8b53-fdc4aecd1267
2025-11-24 15:51:00.737 13 DEBUG ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Validating Port b13e8265-b925-4d4a-a173-a87b666cd0e6 status is ACTIVE wait_for_port_status /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:1139
2025-11-24 15:51:00.796 13 DEBUG ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Port b13e8265-b925-4d4a-a173-a87b666cd0e6 status is: ACTIVE wait_for_port_status /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:1142
2025-11-24 15:51:00.798 13 WARNING ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 3ec70d4d-3daa-4972-836c-25ae0eff995b
2025-11-24 15:51:00.798 13 WARNING ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 02eea42d-e3f7-45d0-a43f-92351652f6a7
2025-11-24 15:51:00.812 13 DEBUG ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Adding port 3a7f7121-54c7-4e26-89b0-e42a1ddd89c0 to network c57e4a02-73bb-4c6e-ab03-537ea11168e3 for provisioning without an IP allocation. add_ports_to_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:377
2025-11-24 15:51:02.653 13 WARNING ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Could not create neutron port for node's 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 3a7f7121-54c7-4e26-89b0-e42a1ddd89c0 on the neutron network c57e4a02-73bb-4c6e-ab03-537ea11168e3. ConflictException: 409: Client Error for url: http://neutron-server.openstack.svc.cluster.local:9696/v2.0/ports/524ff5fa-51a9-4c43-8a45-05d37159e302, Unable to complete operation for network c57e4a02-73bb-4c6e-ab03-537ea11168e3. The mac address 14:23:f3:f5:25:90 is in use.: openstack.exceptions.ConflictException: ConflictException: 409: Client Error for url: http://neutron-server.openstack.svc.cluster.local:9696/v2.0/ports/524ff5fa-51a9-4c43-8a45-05d37159e302, Unable to complete operation for network c57e4a02-73bb-4c6e-ab03-537ea11168e3. The mac address 14:23:f3:f5:25:90 is in use.
2025-11-24 15:51:02.654 13 WARNING ironic.common.neutron [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Some errors were encountered when updating vif_port_id for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd on the following ports: ['a42fdf63-c939-4483-971e-4596c480b743', '89e88703-0fd3-4527-8b53-fdc4aecd1267', '3ec70d4d-3daa-4972-836c-25ae0eff995b', '02eea42d-e3f7-45d0-a43f-92351652f6a7', '3a7f7121-54c7-4e26-89b0-e42a1ddd89c0'].
2025-11-24 15:51:03.232 13 DEBUG ironic.common.glance_service.image_service [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 5048de36-4c01-4047-b638-195e639cb1e3 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:51:03.770 13 ERROR ironic.common.glance_service.service_utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 5048de36-4c01-4047-b638-195e639cb1e3: 'NoneType' object has no attribute 'image'
2025-11-24 15:51:03.773 13 DEBUG ironic.drivers.modules.deploy_utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got image info: {'size': 1183633920, 'disk_format': 'qcow2', 'owner': '32e02632f4f04415bab5895d1e7247b7', 'container_format': 'bare', 'checksum': '4832521698c5ac167cb96aa23b903f67', 'id': '5048de36-4c01-4047-b638-195e639cb1e3', 'name': 'Ubuntu 24.04', 'created_at': datetime.datetime(2024, 9, 19, 17, 27, 35), 'updated_at': datetime.datetime(2025, 2, 12, 16, 13, 56), 'deleted_at': None, 'deleted': None, 'status': 'active', 'min_disk': 0, 'min_ram': 0, 'tags': [], 'visibility': 'public', 'protected': None, 'file': '/v2/images/5048de36-4c01-4047-b638-195e639cb1e3/file', 'schema': '/v2/schemas/image', 'os_hash_algo': None, 'os_hash_value': None, 'properties': {'owner_specified.openstack.md5': '', 'owner_specified.openstack.object': 'images/Ubuntu-24.04', 'owner_specified.openstack.sha256': '', 'stores': 'file', 'virtual_size': 4028497920, 'os_version': '24.04', 'hash_algo': 'sha512', 'owner_id': '32e02632f4f04415bab5895d1e7247b7', 'hash_value': '9b1a105707a63c0ae4873db066e83ca0dd7758c2328b55b70a1eac78cf706e0aa1f32db741f37f59308a4adc01250fd905e79eb42ca61d2c26cecff70a945e09', 'os_distro': 'ubuntu', 'location': Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': None, 'name': None, 'domain_id': None, 'domain_name': None})})}} for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. _instance_info_for_glance /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/deploy_utils.py:1385
2025-11-24 15:51:03.775 13 DEBUG ironic.drivers.modules.deploy_utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Fetching image 5048de36-4c01-4047-b638-195e639cb1e3 for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd cache_instance_image /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/deploy_utils.py:1126
2025-11-24 15:51:04.317 13 DEBUG ironic.common.glance_service.image_service [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 5048de36-4c01-4047-b638-195e639cb1e3 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:51:04.856 13 ERROR ironic.common.glance_service.service_utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 5048de36-4c01-4047-b638-195e639cb1e3: 'NoneType' object has no attribute 'image'
2025-11-24 15:51:05.327 13 DEBUG ironic.common.glance_service.image_service [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 5048de36-4c01-4047-b638-195e639cb1e3 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:51:05.886 13 ERROR ironic.common.glance_service.service_utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 5048de36-4c01-4047-b638-195e639cb1e3: 'NoneType' object has no attribute 'image'
2025-11-24 15:51:05.888 13 INFO ironic.drivers.modules.image_cache [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Master cache miss for image 5048de36-4c01-4047-b638-195e639cb1e3, will download
2025-11-24 15:51:05.888 13 DEBUG ironic.common.images [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Using GlanceImageService to download image 5048de36-4c01-4047-b638-195e639cb1e3. fetch_into /var/lib/openstack/lib/python3.10/site-packages/ironic/common/images.py:389
2025-11-24 15:52:20.928 13 DEBUG ironic.common.images [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Image 5048de36-4c01-4047-b638-195e639cb1e3 downloaded in 75.04 seconds. fetch_into /var/lib/openstack/lib/python3.10/site-packages/ironic/common/images.py:406
2025-11-24 15:52:21.138 13 ERROR ironic.drivers.modules.image_cache [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Could not link image 5048de36-4c01-4047-b638-195e639cb1e3 from /var/lib/openstack-helm/ironic/master_images/5048de36-4c01-4047-b638-195e639cb1e3.converted to /var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/disk, error: [Errno 2] No such file or directory: '/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted': FileNotFoundError: [Errno 2] No such file or directory: '/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted'
2025-11-24 15:52:21.139 13 ERROR ironic.conductor.utils [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Error while preparing to deploy to node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd: Could not link image 5048de36-4c01-4047-b638-195e639cb1e3 from /var/lib/openstack-helm/ironic/master_images/5048de36-4c01-4047-b638-195e639cb1e3.converted to /var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/disk, error: [Errno 2] No such file or directory: '/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted': ironic.common.exception.ImageDownloadFailed: Could not link image 5048de36-4c01-4047-b638-195e639cb1e3 from /var/lib/openstack-helm/ironic/master_images/5048de36-4c01-4047-b638-195e639cb1e3.converted to /var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/disk, error: [Errno 2] No such file or directory: '/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted'
2025-11-24 15:52:21.229 13 DEBUG ironic.common.states [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Exiting old state 'deploying' in response to event 'fail' on_exit /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:361
2025-11-24 15:52:21.230 13 DEBUG ironic.common.states [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Entering new state 'deploy failed' in response to event 'fail' on_enter /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:367
2025-11-24 15:52:21.265 13 ERROR ironic.conductor.task_manager [None req-6a2daa94-2d78-4584-9cf8-76ce1a5742c5 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd moved to provision state "deploy failed" from state "deploying"; target provision state is "active": ironic.common.exception.ImageDownloadFailed: Could not link image 5048de36-4c01-4047-b638-195e639cb1e3 from /var/lib/openstack-helm/ironic/master_images/5048de36-4c01-4047-b638-195e639cb1e3.converted to /var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/disk, error: [Errno 2] No such file or directory: '/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted'
2025-11-24 15:52:31.654 13 DEBUG ironic.conductor.manager [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] RPC do_node_tear_down called for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. do_node_tear_down /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/manager.py:1066
2025-11-24 15:52:31.726 13 DEBUG ironic.conductor.task_manager [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd successfully reserved for node tear down (took 0.04 seconds) reserve_node /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/task_manager.py:363
2025-11-24 15:52:31.728 13 DEBUG ironic.common.states [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Exiting old state 'deploy failed' in response to event 'delete' on_exit /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:361
2025-11-24 15:52:31.729 13 DEBUG ironic.common.states [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Entering new state 'deleting' in response to event 'delete' on_enter /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:367
2025-11-24 15:52:31.783 13 INFO ironic.conductor.task_manager [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd moved to provision state "deleting" from state "deploy failed"; target provision state is "available"
2025-11-24 15:52:31.789 13 DEBUG ironic.common.pxe_utils [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Cleaning up PXE config for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd clean_up_pxe_config /var/lib/openstack/lib/python3.10/site-packages/ironic/common/pxe_utils.py:414
2025-11-24 15:52:31.791 13 DEBUG ironic.drivers.modules.boot_mode_utils [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Deploy boot mode is uefi for 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. get_boot_mode_for_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/boot_mode_utils.py:250
2025-11-24 15:52:31.833 13 DEBUG ironic.drivers.modules.image_cache [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Starting clean up for master image cache /var/lib/openstack-helm/tftpboot/master_images clean_up /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py:270
2025-11-24 15:52:31.836 13 DEBUG ironic.common.pxe_utils [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Cleaning up PXE config for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd clean_up_pxe_config /var/lib/openstack/lib/python3.10/site-packages/ironic/common/pxe_utils.py:414
2025-11-24 15:52:31.836 13 DEBUG ironic.drivers.modules.boot_mode_utils [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Deploy boot mode is uefi for 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. get_boot_mode_for_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/boot_mode_utils.py:250
2025-11-24 15:52:31.840 13 DEBUG ironic.drivers.modules.image_cache [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Starting clean up for master image cache /var/lib/openstack-helm/tftpboot/master_images clean_up /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py:270
2025-11-24 15:52:31.893 13 DEBUG ironic.dhcp.dnsmasq [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Writing DHCP host file for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd to /etc/dnsmasq.d/hostsdir.d/ironic-d4:04:e6:4f:87:60.conf: d4:04:e6:4f:87:60,ignore clean_dhcp_opts /var/lib/openstack/lib/python3.10/site-packages/ironic/dhcp/dnsmasq.py:140
2025-11-24 15:52:31.895 13 DEBUG ironic.dhcp.dnsmasq [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Removing DHCP options file for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd at /etc/dnsmasq.d/optsdir.d/ironic-86eb7354-cc10-4173-8ff2-d1ac2ea6befd.conf clean_dhcp_opts /var/lib/openstack/lib/python3.10/site-packages/ironic/dhcp/dnsmasq.py:151
2025-11-24 15:52:31.898 13 DEBUG ironic.drivers.modules.image_cache [None req-b4486e15-96a8-4bd2-9c9b-5500178f2de1 - - - - - -] Starting clean up for master image cache /var/lib/openstack-helm/ironic/master_images clean_up /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py:270
2025-11-24 15:52:32.327 13 DEBUG ironic.conductor.utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Not going to change node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd power state because current state = requested state = 'power off'. _not_going_to_change /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/utils.py:252
2025-11-24 15:52:32.409 13 INFO ironic.drivers.modules.network.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unbinding instance ports from node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd
2025-11-24 15:52:37.873 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:52:37.873 13 INFO ironic.drivers.modules.network.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Removing ports from provisioning network for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd
2025-11-24 15:52:37.874 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Removing ports on network c57e4a02-73bb-4c6e-ab03-537ea11168e3 on node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. remove_ports_from_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:498
2025-11-24 15:52:38.443 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deleting neutron port b13e8265-b925-4d4a-a173-a87b666cd0e6 of node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. remove_neutron_ports /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:528
2025-11-24 15:52:55.479 13 INFO ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Successfully removed node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd neutron ports.
2025-11-24 15:52:55.500 13 INFO ironic.conductor.manager [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Successfully unprovisioned node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd with instance 903680f7-9e9e-462f-bcca-e030979235cf.
2025-11-24 15:52:59.636 13 DEBUG ironic.common.states [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Exiting old state 'deleting' in response to event 'clean' on_exit /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:361
2025-11-24 15:52:59.637 13 DEBUG ironic.common.states [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Entering new state 'cleaning' in response to event 'clean' on_enter /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:367
2025-11-24 15:52:59.665 13 INFO ironic.conductor.task_manager [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd moved to provision state "cleaning" from state "deleting"; target provision state is "available"
2025-11-24 15:52:59.671 13 DEBUG ironic.conductor.cleaning [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Starting StepFlow.CLEANING_AUTO cleaning for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd do_node_clean /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/cleaning.py:55
2025-11-24 15:53:00.311 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:53:01.386 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:53:02.450 13 DEBUG ironic.conductor.utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting BIOS info for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd node_cache_bios_settings /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/utils.py:1587
2025-11-24 15:53:03.040 13 DEBUG ironic.drivers.modules.redfish.bios [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Cache BIOS settings for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd cache_bios_settings /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/redfish/bios.py:127
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Caching of bios settings failed on node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd.: AttributeError: 'BIOSSetting' object has no attribute 'get_registry_fields'
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils Traceback (most recent call last):
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/utils.py", line 1588, in node_cache_bios_settings
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils task.driver.bios.cache_bios_settings(task)
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/redfish/bios.py", line 131, in cache_bios_settings
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils objects.BIOSSettingList.sync_node_setting(
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/oslo_versionedobjects/base.py", line 184, in wrapper
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils result = fn(cls, context, *args, **kwargs)
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/objects/bios.py", line 262, in sync_node_setting
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils current_settings = cls.get_by_node_id(context, node_id)
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/oslo_versionedobjects/base.py", line 184, in wrapper
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils result = fn(cls, context, *args, **kwargs)
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/objects/bios.py", line 239, in get_by_node_id
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils return object_base.obj_make_list(
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/oslo_versionedobjects/base.py", line 1112, in obj_make_list
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils item = item_cls._from_db_object(context, item_cls(), db_item,
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/objects/base.py", line 299, in _from_db_object
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils obj.convert_to_version(obj.__class__.VERSION,
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/objects/base.py", line 178, in convert_to_version
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils self._convert_to_version(
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/objects/bios.py", line 143, in _convert_to_version
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils for field in self.get_registry_fields():
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils AttributeError: 'BIOSSetting' object has no attribute 'get_registry_fields'
2025-11-24 15:53:03.075 13 ERROR ironic.conductor.utils
2025-11-24 15:53:03.077 13 DEBUG ironic.conductor.utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting Firmware Components for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd node_cache_firmware_components /var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/utils.py:1976
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Caching of firmware components failed on node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd: oslo_db.exception.DBError: (pymysql.err.IntegrityError) (1048, "Column 'initial_version' cannot be null")
[SQL: INSERT INTO firmware_information (node_id, component, initial_version, current_version, last_version_flashed, version, created_at, updated_at) VALUES (%(node_id)s, %(component)s, %(initial_version)s, %(current_version)s, %(last_version_flashed)s, %(version)s, %(created_at)s, %(updated_at)s)]
[parameters: {'node_id': 155, 'component': 'nic:NIC.Integrated.1', 'initial_version': None, 'current_version': None, 'last_version_flashed': None, 'version': '1.1', 'created_at': datetime.datetime(2025, 11, 24, 15, 53, 4, 495289), 'updated_at': None}]
(Background on this error at: https://sqlalche.me/e/20/gkpj)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils Traceback (most recent call last):
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 1961, in _exec_single_context
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils self.dialect.do_execute(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/default.py", line 944, in do_execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils cursor.execute(statement, parameters)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/cursors.py", line 153, in execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils result = self._query(query)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/cursors.py", line 322, in _query
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils conn.query(q)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 563, in query
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils self._affected_rows = self._read_query_result(unbuffered=unbuffered)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 825, in _read_query_result
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils result.read()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 1199, in read
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils first_packet = self.connection._read_packet()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 775, in _read_packet
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils packet.raise_for_error()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/protocol.py", line 219, in raise_for_error
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils err.raise_mysql_exception(self._data)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/err.py", line 150, in raise_mysql_exception
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils raise errorclass(errno, errval)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils pymysql.err.IntegrityError: (1048, "Column 'initial_version' cannot be null")
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils The above exception was the direct cause of the following exception:
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils Traceback (most recent call last):
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/conductor/utils.py", line 1978, in node_cache_firmware_components
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils task.driver.firmware.cache_firmware_components(task)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/common/metrics.py", line 60, in wrapped
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils result = f(*args, **kwargs)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/redfish/firmware.py", line 139, in cache_firmware_components
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils new_fw_cmp.create()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/oslo_versionedobjects/base.py", line 226, in wrapper
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils return fn(self, *args, **kwargs)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/objects/firmware.py", line 52, in create
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils db_fwcmp = self.dbapi.create_firmware_component(values)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/db/sqlalchemy/api.py", line 75, in wrapper
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils return f(*args, **kwargs)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/ironic/db/sqlalchemy/api.py", line 3151, in create_firmware_component
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils session.flush()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/session.py", line 4345, in flush
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils self._flush(objects)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/session.py", line 4480, in _flush
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils with util.safe_reraise():
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/util/langhelpers.py", line 224, in __exit__
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils raise exc_value.with_traceback(exc_tb)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/session.py", line 4441, in _flush
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils flush_context.execute()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/unitofwork.py", line 466, in execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils rec.execute(self)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/unitofwork.py", line 642, in execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils util.preloaded.orm_persistence.save_obj(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/persistence.py", line 93, in save_obj
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils _emit_insert_statements(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/orm/persistence.py", line 1233, in _emit_insert_statements
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils result = connection.execute(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 1413, in execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils return meth(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/sql/elements.py", line 526, in _execute_on_connection
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils return connection._execute_clauseelement(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 1635, in _execute_clauseelement
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils ret = self._execute_context(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 1840, in _execute_context
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils return self._exec_single_context(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 1980, in _exec_single_context
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils self._handle_dbapi_exception(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 2346, in _handle_dbapi_exception
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils raise newraise.with_traceback(exc_info[2]) from e
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/base.py", line 1961, in _exec_single_context
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils self.dialect.do_execute(
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/sqlalchemy/engine/default.py", line 944, in do_execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils cursor.execute(statement, parameters)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/cursors.py", line 153, in execute
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils result = self._query(query)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/cursors.py", line 322, in _query
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils conn.query(q)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 563, in query
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils self._affected_rows = self._read_query_result(unbuffered=unbuffered)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 825, in _read_query_result
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils result.read()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 1199, in read
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils first_packet = self.connection._read_packet()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/connections.py", line 775, in _read_packet
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils packet.raise_for_error()
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/protocol.py", line 219, in raise_for_error
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils err.raise_mysql_exception(self._data)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils File "/var/lib/openstack/lib/python3.10/site-packages/pymysql/err.py", line 150, in raise_mysql_exception
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils raise errorclass(errno, errval)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils oslo_db.exception.DBError: (pymysql.err.IntegrityError) (1048, "Column 'initial_version' cannot be null")
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils [SQL: INSERT INTO firmware_information (node_id, component, initial_version, current_version, last_version_flashed, version, created_at, updated_at) VALUES (%(node_id)s, %(component)s, %(initial_version)s, %(current_version)s, %(last_version_flashed)s, %(version)s, %(created_at)s, %(updated_at)s)]
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils [parameters: {'node_id': 155, 'component': 'nic:NIC.Integrated.1', 'initial_version': None, 'current_version': None, 'last_version_flashed': None, 'version': '1.1', 'created_at': datetime.datetime(2025, 11, 24, 15, 53, 4, 495289), 'updated_at': None}]
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils (Background on this error at: https://sqlalche.me/e/20/gkpj)
2025-11-24 15:53:04.499 13 ERROR ironic.conductor.utils
2025-11-24 15:53:05.466 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Got network matching provisioning: openstack.network.v2.network.Network(id=c57e4a02-73bb-4c6e-ab03-537ea11168e3, name=provisioning, admin_state_up=True, mtu=1500, status=ACTIVE, subnets=['b0fa63d0-fb0c-446f-bfd3-26c0a50730c0'], shared=False, availability_zone_hints=[], availability_zones=[], ipv4_address_scope=None, ipv6_address_scope=None, router:external=False, vlan_transparent=None, description=, port_security_enabled=True, tags=['UNDERSYNC_DHCP_RELAY:10.46.100.86', 'UNDERSYNC_PROVISIONING'], created_at=2024-09-19T20:55:45Z, updated_at=2025-08-05T18:12:36Z, revision_number=16, project_id=32e02632f4f04415bab5895d1e7247b7, segments=[{'provider:network_type': 'vxlan', 'provider:physical_network': None, 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-1-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-2-network', 'provider:segmentation_id': 4010}, {'provider:network_type': 'vlan', 'provider:physical_network': 'f20-3-network', 'provider:segmentation_id': 4010}], tenant_id=32e02632f4f04415bab5895d1e7247b7, qinq=None, l2_adjacency=True, location=Munch({'cloud': '', 'region_name': None, 'zone': None, 'project': Munch({'id': '32e02632f4f04415bab5895d1e7247b7', 'name': None, 'domain_id': None, 'domain_name': None})})) _get_network_by_uuid_or_name /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:965
2025-11-24 15:53:05.467 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Removing ports on network c57e4a02-73bb-4c6e-ab03-537ea11168e3 on node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. remove_ports_from_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:498
2025-11-24 15:53:05.964 13 INFO ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Successfully removed node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd neutron ports.
2025-11-24 15:53:05.965 13 INFO ironic.drivers.modules.network.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Adding cleaning network to node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd
2025-11-24 15:53:06.375 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] For node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd, creating neutron ports on network c57e4a02-73bb-4c6e-ab03-537ea11168e3 using NeutronNetwork network interface. add_ports_to_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:313
2025-11-24 15:53:06.375 13 WARNING ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port a42fdf63-c939-4483-971e-4596c480b743
2025-11-24 15:53:06.375 13 WARNING ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 89e88703-0fd3-4527-8b53-fdc4aecd1267
2025-11-24 15:53:20.252 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Validating Port 3879e2ed-1588-40fa-8a90-b1ba348af88f status is ACTIVE wait_for_port_status /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:1139
2025-11-24 15:53:20.299 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Port 3879e2ed-1588-40fa-8a90-b1ba348af88f status is: ACTIVE wait_for_port_status /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:1142
2025-11-24 15:53:20.299 13 WARNING ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 3ec70d4d-3daa-4972-836c-25ae0eff995b
2025-11-24 15:53:20.299 13 WARNING ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] The local_link_connection is required for 'neutron' network interface and is not present in the nodes 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 02eea42d-e3f7-45d0-a43f-92351652f6a7
2025-11-24 15:53:20.308 13 DEBUG ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Adding port 3a7f7121-54c7-4e26-89b0-e42a1ddd89c0 to network c57e4a02-73bb-4c6e-ab03-537ea11168e3 for provisioning without an IP allocation. add_ports_to_network /var/lib/openstack/lib/python3.10/site-packages/ironic/common/neutron.py:377
2025-11-24 15:53:22.060 13 WARNING ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Could not create neutron port for node's 86eb7354-cc10-4173-8ff2-d1ac2ea6befd port 3a7f7121-54c7-4e26-89b0-e42a1ddd89c0 on the neutron network c57e4a02-73bb-4c6e-ab03-537ea11168e3. ConflictException: 409: Client Error for url: http://neutron-server.openstack.svc.cluster.local:9696/v2.0/ports/2831fe03-e824-4503-ac98-7ab126229f56, Unable to complete operation for network c57e4a02-73bb-4c6e-ab03-537ea11168e3. The mac address 14:23:f3:f5:25:90 is in use.: openstack.exceptions.ConflictException: ConflictException: 409: Client Error for url: http://neutron-server.openstack.svc.cluster.local:9696/v2.0/ports/2831fe03-e824-4503-ac98-7ab126229f56, Unable to complete operation for network c57e4a02-73bb-4c6e-ab03-537ea11168e3. The mac address 14:23:f3:f5:25:90 is in use.
2025-11-24 15:53:22.061 13 WARNING ironic.common.neutron [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Some errors were encountered when updating vif_port_id for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd on the following ports: ['a42fdf63-c939-4483-971e-4596c480b743', '89e88703-0fd3-4527-8b53-fdc4aecd1267', '3ec70d4d-3daa-4972-836c-25ae0eff995b', '02eea42d-e3f7-45d0-a43f-92351652f6a7', '3a7f7121-54c7-4e26-89b0-e42a1ddd89c0'].
2025-11-24 15:53:22.134 13 DEBUG ironic.drivers.modules.boot_mode_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deploy boot mode is uefi for 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. get_boot_mode_for_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/boot_mode_utils.py:250
2025-11-24 15:53:22.134 13 DEBUG ironic.drivers.modules.boot_mode_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deploy boot mode is uefi for 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. get_boot_mode_for_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/boot_mode_utils.py:250
2025-11-24 15:53:22.158 13 DEBUG ironic.dhcp.dnsmasq [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Writing DHCP options for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd to /etc/dnsmasq.d/optsdir.d/ironic-86eb7354-cc10-4173-8ff2-d1ac2ea6befd.conf: tag:ef179385-6b82-4ec5-bf8a-d69af54b6679,tag:!ipxe,67,http://10.46.100.86:80/snponly.efi; tag:ef179385-6b82-4ec5-bf8a-d69af54b6679,tag:ipxe,67,http://10.46.100.86:80/boot.ipxe; tag:ef179385-6b82-4ec5-bf8a-d69af54b6679,60,HTTPClient; tag:ef179385-6b82-4ec5-bf8a-d69af54b6679,tag:!ipxe6,59,http://10.46.100.86:80/snponly.efi; tag:ef179385-6b82-4ec5-bf8a-d69af54b6679,tag:ipxe6,59,http://10.46.100.86:80/boot.ipxe update_dhcp_opts /var/lib/openstack/lib/python3.10/site-packages/ironic/dhcp/dnsmasq.py:71
2025-11-24 15:53:22.158 13 DEBUG ironic.dhcp.dnsmasq [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Writing DHCP host file for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd to /etc/dnsmasq.d/hostsdir.d/ironic-d4:04:e6:4f:87:60.conf: d4:04:e6:4f:87:60,set:ef179385-6b82-4ec5-bf8a-d69af54b6679,set:ironic update_dhcp_opts /var/lib/openstack/lib/python3.10/site-packages/ironic/dhcp/dnsmasq.py:82
2025-11-24 15:53:22.599 13 DEBUG ironic.drivers.modules.boot_mode_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deploy boot mode is uefi for 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. get_boot_mode_for_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/boot_mode_utils.py:250
2025-11-24 15:53:22.600 13 DEBUG ironic.common.pxe_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Building PXE config for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd create_pxe_config /var/lib/openstack/lib/python3.10/site-packages/ironic/common/pxe_utils.py:330
2025-11-24 15:53:22.601 13 DEBUG ironic.drivers.modules.boot_mode_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Deploy boot mode is uefi for 86eb7354-cc10-4173-8ff2-d1ac2ea6befd. get_boot_mode_for_deploy /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/boot_mode_utils.py:250
2025-11-24 15:53:23.550 13 DEBUG ironic.common.pxe_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Fetching necessary kernel and ramdisk for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd cache_ramdisk_kernel /var/lib/openstack/lib/python3.10/site-packages/ironic/common/pxe_utils.py:1319
2025-11-24 15:53:24.051 13 DEBUG ironic.common.glance_service.image_service [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 1c6b05d9-bf18-4088-b41d-f0b56acafa80 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:53:24.614 13 ERROR ironic.common.glance_service.service_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 1c6b05d9-bf18-4088-b41d-f0b56acafa80: 'NoneType' object has no attribute 'image'
2025-11-24 15:53:25.027 13 DEBUG ironic.common.glance_service.image_service [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 43f8cc16-b529-44aa-9b4a-8a87bf58b005 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:53:25.523 13 ERROR ironic.common.glance_service.service_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 43f8cc16-b529-44aa-9b4a-8a87bf58b005: 'NoneType' object has no attribute 'image'
2025-11-24 15:53:25.948 13 DEBUG ironic.common.glance_service.image_service [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 1c6b05d9-bf18-4088-b41d-f0b56acafa80 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:53:26.440 13 ERROR ironic.common.glance_service.service_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 1c6b05d9-bf18-4088-b41d-f0b56acafa80: 'NoneType' object has no attribute 'image'
2025-11-24 15:53:26.443 13 DEBUG ironic.drivers.modules.image_cache [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Master cache hit for image 1c6b05d9-bf18-4088-b41d-f0b56acafa80 fetch_image /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py:182
2025-11-24 15:53:26.863 13 DEBUG ironic.common.glance_service.image_service [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Getting image metadata from glance. Image: 43f8cc16-b529-44aa-9b4a-8a87bf58b005 show /var/lib/openstack/lib/python3.10/site-packages/ironic/common/glance_service/image_service.py:163
2025-11-24 15:53:27.424 13 ERROR ironic.common.glance_service.service_utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Unable to retrieve image members for image 43f8cc16-b529-44aa-9b4a-8a87bf58b005: 'NoneType' object has no attribute 'image'
2025-11-24 15:53:27.426 13 DEBUG ironic.drivers.modules.image_cache [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Master cache hit for image 43f8cc16-b529-44aa-9b4a-8a87bf58b005 fetch_image /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py:182
2025-11-24 15:53:27.426 13 DEBUG ironic.drivers.modules.pxe_base [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Ramdisk (i)PXE boot for node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd has been prepared with kernel params {'deployment_aki_path': 'http://10.46.100.86:80/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/deploy_kernel', 'deployment_ari_path': 'http://10.46.100.86:80/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/deploy_ramdisk', 'initrd_filename': 'deploy_ramdisk', 'aki_path': 'no_kernel', 'ari_path': 'no_ramdisk', 'pxe_append_params': 'nofb nomodeset vga=normal ipa-debug=1 rootpwd="REDACTED" sshkey="ssh-ed25519 REDACTED ipa-api-url=https://ironic.dev.undercloud.rackspace.net ipa-global-request-id=req-0597c1bb-772d-4055-9ffb-33d0ac643e71', 'tftp_server': '10.46.100.86', 'ipxe_timeout': 0, 'ipa-api-url':'https://ironic.dev.undercloud.rackspace.net'} prepare_ramdisk /var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/pxe_base.py:230
2025-11-24 15:53:58.515 13 INFO ironic.conductor.utils [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Successfully set node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd power state to power on by rebooting.
2025-11-24 15:53:58.516 13 DEBUG ironic.common.states [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Exiting old state 'cleaning' in response to event 'wait' on_exit /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:361
2025-11-24 15:53:58.516 13 DEBUG ironic.common.states [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Entering new state 'clean wait' in response to event 'wait' on_enter /var/lib/openstack/lib/python3.10/site-packages/ironic/common/states.py:367
2025-11-24 15:53:58.541 13 INFO ironic.conductor.task_manager [None req-0597c1bb-772d-4055-9ffb-33d0ac643e71 6dff409ebb31414299c3d0cd837eea9e 32e02632f4f04415bab5895d1e7247b7 - - a6f7dcd63c9b4940915062f57a48df77 7f46f53fcb3c4625a343eaa35b5e0d04] Node 86eb7354-cc10-4173-8ff2-d1ac2ea6befd moved to provision state "clean wait" from state "cleaning"; target provision state is "available"
root@1327175-hp3:/var/lib/openstack-helm/tftpboot/master_images# grep master_path /etc/ironic/ironic.conf
iso_master_path = /var/lib/openstack-helm/master_iso_images
instance_master_path = /var/lib/openstack-helm/ironic/master_images
tftp_master_path = /var/lib/openstack-helm/tftpboot/master_images
root@1327175-hp3:~# strace -e file -p 2923771 -f 2>&1| grep -vE 'netrc|nsswitch|certs'
strace: Process 2923771 attached with 100 threads
[pid 2940000] newfstatat(AT_FDCWD, "/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=105, ...}, 0) = 0
[pid 2940000] openat(AT_FDCWD, "/etc/hosts", O_RDONLY|O_CLOEXEC) = 22
[pid 2940000] newfstatat(22, "", {st_mode=S_IFREG|0644, st_size=334, ...}, AT_EMPTY_PATH) = 0
[pid 2977287] newfstatat(AT_FDCWD, "/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=105, ...}, 0) = 0
[pid 2977287] openat(AT_FDCWD, "/etc/hosts", O_RDONLY|O_CLOEXEC) = 23
[pid 2977287] newfstatat(23, "", {st_mode=S_IFREG|0644, st_size=334, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted.part", O_RDONLY|O_CLOEXEC) = 16
[pid 2940630] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=1183633920, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted.part", O_RDONLY|O_CLOEXEC) = 16
[pid 2940630] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=1183633920, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted.part", O_RDONLY|O_CLOEXEC) = 16
[pid 2940630] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=1183633920, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] statfs("/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e", {f_type=EXT2_SUPER_MAGIC, f_bsize=4096, f_blocks=38558158, f_bfree=18280222, f_bavail=16612969, f_files=9830400, f_ffree=8625984, f_fsid={val=[0x3c602c2d, 0xee06f898]}, f_namelen=255, f_frsize=4096, f_flags=ST_VALID|ST_RELATIME}) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
[pid 2940630] unlink("/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e/5048de36-4c01-4047-b638-195e639cb1e3.converted.part") = 0
[pid 2940630] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e", {st_mode=S_IFDIR|0700, st_size=4096, ...}, 0) = 0
[pid 2940630] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e", O_RDONLY|O_CLOEXEC) = 16
[pid 2940630] newfstatat(16, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] newfstatat(17, "", {st_mode=S_IFDIR|0700, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] rmdir("/var/lib/openstack-helm/ironic/master_images/tmp_bvrf57e") = 0
[pid 2940630] newfstatat(AT_FDCWD, "/var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py", {st_mode=S_IFREG|0644, st_size=26770, ...}, 0) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py", O_RDONLY|O_CLOEXEC) = 16
[pid 2940630] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=26770, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] newfstatat(AT_FDCWD, "/var/lib/openstack/lib/python3.10/site-packages/ironic/common/images.py", {st_mode=S_IFREG|0644, st_size=43727, ...}, 0) = 0
[pid 2940630] openat(AT_FDCWD, "/var/lib/openstack/lib/python3.10/site-packages/ironic/common/images.py", O_RDONLY|O_CLOEXEC) = 16
[pid 2940630] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=43727, ...}, AT_EMPTY_PATH) = 0
[pid 2940630] newfstatat(AT_FDCWD, "/var/lib/openstack/lib/python3.10/site-packages/ironic/drivers/modules/image_cache.py", {st_mode=S_IFREG|0644, st_size=26770, ...}, 0) = 0
[pid 2940630] newfstatat(AT_FDCWD, "/var/lib/openstack/lib/python3.10/site-packages/ironic/common/images.py", {st_mode=S_IFREG|0644, st_size=43727, ...}, 0) = 0
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/deploy_kernel") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/deploy_ramdisk") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/c4-cb-e1-bf-91-30") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-c4-cb-e1-bf-91-30") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/c4:cb:e1:bf:91:30.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/c4-cb-e1-bf-91-31") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-c4-cb-e1-bf-91-31") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/c4:cb:e1:bf:91:31.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/d4-04-e6-4f-87-60") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-d4-04-e6-4f-87-60") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/d4:04:e6:4f:87:60.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/d4-04-e6-4f-87-61") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-d4-04-e6-4f-87-61") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/d4:04:e6:4f:87:61.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/14-23-f3-f5-25-91") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-14-23-f3-f5-25-91") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/14:23:f3:f5:25:91.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/14-23-f3-f5-25-90") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-14-23-f3-f5-25-90") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/14:23:f3:f5:25:90.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/httpboot/86eb7354-cc10-4173-8ff2-d1ac2ea6befd", 0x7f73db0a2c10, 0) = -1 ENOENT (No such file or directory)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] mkdir("/var/lib/openstack-helm/tftpboot/master_images", 0777) = -1 EEXIST (File exists)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/1c6b05d9-bf18-4088-b41d-f0b56acafa80.converted", {st_mode=S_IFREG|0644, st_size=8181696, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/1c6b05d9-bf18-4088-b41d-f0b56acafa80.converted", {st_mode=S_IFREG|0644, st_size=8181696, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/43f8cc16-b529-44aa-9b4a-8a87bf58b005.converted", {st_mode=S_IFREG|0644, st_size=1142406656, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/43f8cc16-b529-44aa-9b4a-8a87bf58b005.converted", {st_mode=S_IFREG|0644, st_size=1142406656, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/1c6b05d9-bf18-4088-b41d-f0b56acafa80.converted", {st_mode=S_IFREG|0644, st_size=8181696, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/43f8cc16-b529-44aa-9b4a-8a87bf58b005.converted", {st_mode=S_IFREG|0644, st_size=1142406656, ...}, 0) = 0
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/c4-cb-e1-bf-91-30") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-c4-cb-e1-bf-91-30") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/c4:cb:e1:bf:91:30.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/c4-cb-e1-bf-91-31") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-c4-cb-e1-bf-91-31") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/c4:cb:e1:bf:91:31.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/d4-04-e6-4f-87-60") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-d4-04-e6-4f-87-60") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/d4:04:e6:4f:87:60.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/d4-04-e6-4f-87-61") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-d4-04-e6-4f-87-61") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/d4:04:e6:4f:87:61.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/14-23-f3-f5-25-91") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-14-23-f3-f5-25-91") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/14:23:f3:f5:25:91.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/pxelinux.cfg/14-23-f3-f5-25-90") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/grub.cfg-01-14-23-f3-f5-25-90") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/14:23:f3:f5:25:90.conf") = -1 ENOENT (No such file or directory)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/httpboot/86eb7354-cc10-4173-8ff2-d1ac2ea6befd", 0x7f73db0a2c10, 0) = -1 ENOENT (No such file or directory)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] mkdir("/var/lib/openstack-helm/tftpboot/master_images", 0777) = -1 EEXIST (File exists)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/1c6b05d9-bf18-4088-b41d-f0b56acafa80.converted", {st_mode=S_IFREG|0644, st_size=8181696, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/1c6b05d9-bf18-4088-b41d-f0b56acafa80.converted", {st_mode=S_IFREG|0644, st_size=8181696, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/43f8cc16-b529-44aa-9b4a-8a87bf58b005.converted", {st_mode=S_IFREG|0644, st_size=1142406656, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/43f8cc16-b529-44aa-9b4a-8a87bf58b005.converted", {st_mode=S_IFREG|0644, st_size=1142406656, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/1c6b05d9-bf18-4088-b41d-f0b56acafa80.converted", {st_mode=S_IFREG|0644, st_size=8181696, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/tftpboot/master_images/43f8cc16-b529-44aa-9b4a-8a87bf58b005.converted", {st_mode=S_IFREG|0644, st_size=1142406656, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/etc/dnsmasq.d/hostsdir.d/ironic-d4:04:e6:4f:87:60.conf", O_WRONLY|O_CREAT|O_TRUNC|O_CLOEXEC, 0666) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=0, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/etc/dnsmasq.d/optsdir.d/ironic-86eb7354-cc10-4173-8ff2-d1ac2ea6befd.conf", {st_mode=S_IFREG|0644, st_size=407, ...}, 0) = 0
[pid 2977280] unlink("/etc/dnsmasq.d/optsdir.d/ironic-86eb7354-cc10-4173-8ff2-d1ac2ea6befd.conf") = 0
[pid 2977280] unlink("/var/lib/openstack-helm/httpboot/agent_images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd") = -1 ENOENT (No such file or directory)
[pid 2977280] unlink("/var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd/disk") = -1 ENOENT (No such file or directory)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_SYMLINK_NOFOLLOW) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd", O_RDONLY|O_CLOEXEC) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] rmdir("/var/lib/openstack-helm/ironic/images/86eb7354-cc10-4173-8ff2-d1ac2ea6befd") = 0
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/ironic", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] mkdir("/var/lib/openstack-helm/ironic/master_images", 0777) = -1 EEXIST (File exists)
[pid 2977280] newfstatat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images", {st_mode=S_IFDIR|0755, st_size=4096, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] openat(AT_FDCWD, "/var/lib/openstack-helm/ironic/master_images", O_RDONLY|O_NONBLOCK|O_CLOEXEC|O_DIRECTORY) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFDIR|0755, st_size=4096, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=20480, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=20480, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=20480, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=20480, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=20480, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(17, "", {st_mode=S_IFDIR|0755, st_size=20480, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=105, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/etc/hosts", O_RDONLY|O_CLOEXEC) = 15
[pid 2977280] newfstatat(15, "", {st_mode=S_IFREG|0644, st_size=334, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=105, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/etc/hosts", O_RDONLY|O_CLOEXEC) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=334, ...}, AT_EMPTY_PATH) = 0
[pid 2977280] newfstatat(AT_FDCWD, "/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=105, ...}, 0) = 0
[pid 2977280] openat(AT_FDCWD, "/etc/hosts", O_RDONLY|O_CLOEXEC) = 16
[pid 2977280] newfstatat(16, "", {st_mode=S_IFREG|0644, st_size=334, ...}, AT_EMPTY_PATH) = 0
^C
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment