PLAY [Destroy] *****************************************************************

TASK [Get passwd entries for USER env] *****************************************
Tuesday 30 September 2025  02:39:42 +0000 (0:00:00.013)       0:00:00.013 *****
ok: [localhost]

TASK [Get shell async_dir] *****************************************************
Tuesday 30 September 2025  02:39:42 +0000 (0:00:00.293)       0:00:00.307 *****
ok: [localhost]

TASK [Set async_dir for HOME env] **********************************************
Tuesday 30 September 2025  02:39:42 +0000 (0:00:00.042)       0:00:00.349 *****
skipping: [localhost]

TASK [Destroy molecule instance(s)] ********************************************
Tuesday 30 September 2025  02:39:42 +0000 (0:00:00.046)       0:00:00.395 *****
changed: [localhost] => (item={'command': '/sbin/init', 'dockerfile': 'containerfile', 'image': 'registry.access.redhat.com/ubi9/ubi-init', 'name': 'instance', 'pre_build_image': True})

TASK [Wait for instance(s) deletion to complete] *******************************
Tuesday 30 September 2025  02:39:42 +0000 (0:00:00.394)       0:00:00.790 *****
FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j394595372002.26075', 'results_file': '/home/zuul/.ansible_async/j394595372002.26075', 'changed': True, 'item': {'command': '/sbin/init', 'dockerfile': 'containerfile', 'image': 'registry.access.redhat.com/ubi9/ubi-init', 'name': 'instance', 'pre_build_image': True}, 'ansible_loop_var': 'item'})

TASK [Delete podman network dedicated to this scenario] ************************
Tuesday 30 September 2025  02:39:48 +0000 (0:00:05.466)       0:00:06.256 *****
skipping: [localhost] => (item=instance: None specified)
skipping: [localhost]

PLAY RECAP *********************************************************************
localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0

Tuesday 30 September 2025  02:39:48 +0000 (0:00:00.050)       0:00:06.306 *****
===============================================================================
Wait for instance(s) deletion to complete ------------------------------- 5.47s
Destroy molecule instance(s) -------------------------------------------- 0.39s
Get passwd entries for USER env ----------------------------------------- 0.29s
Delete podman network dedicated to this scenario ------------------------ 0.05s
Set async_dir for HOME env ---------------------------------------------- 0.05s
Get shell async_dir ----------------------------------------------------- 0.04s

PLAY [Create] ******************************************************************

TASK [Get podman executable path] **********************************************
Tuesday 30 September 2025  02:39:48 +0000 (0:00:00.013)       0:00:00.013 *****
ok: [localhost]

TASK [Register podman executable path] *****************************************
Tuesday 30 September 2025  02:39:49 +0000 (0:00:00.291)       0:00:00.305 *****
ok: [localhost]

TASK [Get passwd entries for USER env] *****************************************
Tuesday 30 September 2025  02:39:49 +0000 (0:00:00.040)       0:00:00.345 *****
ok: [localhost]

TASK [Get shell async_dir] *****************************************************
Tuesday 30 September 2025  02:39:49 +0000 (0:00:00.285)       0:00:00.630 *****
ok: [localhost]

TASK [Set async_dir for HOME env] **********************************************
Tuesday 30 September 2025  02:39:49 +0000 (0:00:00.042)       0:00:00.673 *****
skipping: [localhost]

TASK [Log into a container registry] *******************************************
Tuesday 30 September 2025  02:39:49 +0000 (0:00:00.033)       0:00:00.706 *****
skipping: [localhost] => (item="instance registry username: None specified")
skipping: [localhost]

TASK [Check presence of custom Dockerfiles] ************************************
Tuesday 30 September 2025  02:39:49 +0000 (0:00:00.043)       0:00:00.750 *****
ok: [localhost] => (item=Dockerfile: containerfile)

TASK [Create Dockerfiles from image names] *************************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.329)       0:00:01.080 *****
skipping: [localhost] => (item="Dockerfile: containerfile; Image: registry.access.redhat.com/ubi9/ubi-init")
skipping: [localhost]

TASK [Discover local Podman images] ********************************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.040)       0:00:01.120 *****
ok: [localhost] => (item=instance)

TASK [Build an Ansible compatible image] ***************************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.334)       0:00:01.455 *****
skipping: [localhost] => (item=registry.access.redhat.com/ubi9/ubi-init)
skipping: [localhost]

TASK [Determine the CMD directives] ********************************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.041)       0:00:01.496 *****
ok: [localhost] => (item="instance command: /sbin/init")

TASK [Remove possible pre-existing containers] *********************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.050)       0:00:01.547 *****
changed: [localhost]

TASK [Discover local podman networks] ******************************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.237)       0:00:01.784 *****
skipping: [localhost] => (item=instance: None specified)
skipping: [localhost]

TASK [Create podman network dedicated to this scenario] ************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.043)       0:00:01.828 *****
skipping: [localhost]

TASK [Create molecule instance(s)] *********************************************
Tuesday 30 September 2025  02:39:50 +0000 (0:00:00.036)       0:00:01.864 *****
changed: [localhost] => (item=instance)

TASK [Wait for instance(s) creation to complete] *******************************
Tuesday 30 September 2025  02:39:51 +0000 (0:00:00.335)       0:00:02.200 *****
FAILED - RETRYING: [localhost]: Wait for instance(s) creation to complete (300 retries left).
changed: [localhost] => (item=instance)

PLAY RECAP *********************************************************************
localhost                  : ok=10   changed=3    unreachable=0    failed=0    skipped=6    rescued=0    ignored=0

Tuesday 30 September 2025  02:39:56 +0000 (0:00:05.506)       0:00:07.707 *****
===============================================================================
Wait for instance(s) creation to complete ------------------------------- 5.51s
Create molecule instance(s) --------------------------------------------- 0.34s
Discover local Podman images -------------------------------------------- 0.33s
Check presence of custom Dockerfiles ------------------------------------ 0.33s
Get podman executable path ---------------------------------------------- 0.29s
Get passwd entries for USER env ----------------------------------------- 0.29s
Remove possible pre-existing containers --------------------------------- 0.24s
Determine the CMD directives -------------------------------------------- 0.05s
Log into a container registry ------------------------------------------- 0.04s
Discover local podman networks ------------------------------------------ 0.04s
Get shell async_dir ----------------------------------------------------- 0.04s
Build an Ansible compatible image --------------------------------------- 0.04s
Create Dockerfiles from image names ------------------------------------- 0.04s
Register podman executable path ----------------------------------------- 0.04s
Create podman network dedicated to this scenario ------------------------ 0.04s
Set async_dir for HOME env ---------------------------------------------- 0.03s

PLAY [Converge] ****************************************************************

TASK [Gather stack nodes and facts] ********************************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.018)       0:00:00.018 *****
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/adoption_osp_deploy/tasks/gather_stack_nodes.yml for instance => (item={'stackname': 'overcloud', 'network_data_file': 'network_data.yaml.j2', 'vips_data_file': 'vips_data_overcloud.yaml', 'stack_nodes': ['osp-controllers']})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/adoption_osp_deploy/tasks/gather_stack_nodes.yml for instance => (item={'stackname': 'cell1', 'network_data_file': 'network_data.yaml.j2', 'vips_data_file': 'vips_data_cell1.yaml', 'stack_nodes': ['cell1-osp-computes', 'cell1-osp-controllers']})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/adoption_osp_deploy/tasks/gather_stack_nodes.yml for instance => (item={'stackname': 'cell2', 'network_data_file': 'network_data.yaml.j2', 'vips_data_file': 'vips_data_cell2.yaml', 'stack_nodes': ['cell2-osp-computes', 'cell2-osp-controllers']})

TASK [Get main facts for the overcloud stack] **********************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.028)       0:00:00.047 *****
ok: [instance]

TASK [Gather other facts for stack overcloud"] *********************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.034)       0:00:00.082 *****
ok: [instance]

TASK [Gather nodes for stack overcloud] ****************************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.084)       0:00:00.166 *****
skipping: [instance] => (item=cell1-osp-computes)
skipping: [instance] => (item=cell1-osp-controllers)
skipping: [instance] => (item=cell2-osp-computes)
skipping: [instance] => (item=cell2-osp-controllers)
skipping: [instance] => (item=controllers)
skipping: [instance] => (item=ocps)
ok: [instance] => (item=osp-controllers)
skipping: [instance] => (item=osp-underclouds)

TASK [Get main facts for the overcloud stack] **********************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.060)       0:00:00.226 *****
ok: [instance]

TASK [Gather other facts for stack cell1"] *************************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.031)       0:00:00.258 *****
ok: [instance]

TASK [Gather nodes for stack cell1] ********************************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.069)       0:00:00.327 *****
ok: [instance] => (item=cell1-osp-computes)
ok: [instance] => (item=cell1-osp-controllers)
skipping: [instance] => (item=cell2-osp-computes)
skipping: [instance] => (item=cell2-osp-controllers)
skipping: [instance] => (item=controllers)
skipping: [instance] => (item=ocps)
skipping: [instance] => (item=osp-controllers)
skipping: [instance] => (item=osp-underclouds)

TASK [Get main facts for the overcloud stack] **********************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.064)       0:00:00.392 *****
ok: [instance]

TASK [Gather other facts for stack cell2"] *************************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.030)       0:00:00.422 *****
ok: [instance]

TASK [Gather nodes for stack cell2] ********************************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.068)       0:00:00.491 *****
skipping: [instance] => (item=cell1-osp-computes)
skipping: [instance] => (item=cell1-osp-controllers)
ok: [instance] => (item=cell2-osp-computes)
ok: [instance] => (item=cell2-osp-controllers)
skipping: [instance] => (item=controllers)
skipping: [instance] => (item=ocps)
skipping: [instance] => (item=osp-controllers)
skipping: [instance] => (item=osp-underclouds)

TASK [Store result for verification as persistent fact] ************************
Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.063)       0:00:00.555 *****
ok: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=13   changed=0    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0

Tuesday 30 September 2025  02:39:57 +0000 (0:00:00.027)       0:00:00.582 *****
===============================================================================
Gather other facts for stack overcloud" --------------------------------- 0.08s
Gather other facts for stack cell1" ------------------------------------- 0.07s
Gather other facts for stack cell2" ------------------------------------- 0.07s
Gather nodes for stack cell1 -------------------------------------------- 0.06s
Gather nodes for stack cell2 -------------------------------------------- 0.06s
Gather nodes for stack overcloud ---------------------------------------- 0.06s
Get main facts for the overcloud stack ---------------------------------- 0.03s
Get main facts for the overcloud stack ---------------------------------- 0.03s
Get main facts for the overcloud stack ---------------------------------- 0.03s
Gather stack nodes and facts -------------------------------------------- 0.03s
Store result for verification as persistent fact ------------------------ 0.03s

PLAY [Verify] ******************************************************************

TASK [Set _tripleo_nodes_stack from persistent fact] ***************************
Tuesday 30 September 2025  02:39:58 +0000 (0:00:00.019)       0:00:00.019 *****
skipping: [instance]

TASK [Assert gathered nodes for stacks] ****************************************
Tuesday 30 September 2025  02:39:58 +0000 (0:00:00.022)       0:00:00.042 *****
ok: [instance] => (item={'stackname': 'overcloud', 'network_data_file': 'network_data.yaml.j2', 'vips_data_file': 'vips_data_overcloud.yaml', 'stack_nodes': ['osp-controllers']}) => changed=false
  _stack:
    network_data_file: network_data.yaml.j2
    stack_nodes:
    - osp-controllers
    stackname: overcloud
    vips_data_file: vips_data_overcloud.yaml
  ansible_loop_var: _stack
  msg: Successfully verified gathered nodes for stack overcloud
ok: [instance] => (item={'stackname': 'cell1', 'network_data_file': 'network_data.yaml.j2', 'vips_data_file': 'vips_data_cell1.yaml', 'stack_nodes': ['cell1-osp-computes', 'cell1-osp-controllers']}) => changed=false
  _stack:
    network_data_file: network_data.yaml.j2
    stack_nodes:
    - cell1-osp-computes
    - cell1-osp-controllers
    stackname: cell1
    vips_data_file: vips_data_cell1.yaml
  ansible_loop_var: _stack
  msg: Successfully verified gathered nodes for stack cell1
ok: [instance] => (item={'stackname': 'cell2', 'network_data_file': 'network_data.yaml.j2', 'vips_data_file': 'vips_data_cell2.yaml', 'stack_nodes': ['cell2-osp-computes', 'cell2-osp-controllers']}) => changed=false
  _stack:
    network_data_file: network_data.yaml.j2
    stack_nodes:
    - cell2-osp-computes
    - cell2-osp-controllers
    stackname: cell2
    vips_data_file: vips_data_cell2.yaml
  ansible_loop_var: _stack
  msg: Successfully verified gathered nodes for stack cell2

PLAY RECAP *********************************************************************
instance                   : ok=1    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0

Tuesday 30 September 2025  02:39:58 +0000 (0:00:00.071)       0:00:00.114 *****
===============================================================================
Assert gathered nodes for stacks ---------------------------------------- 0.07s
Set _tripleo_nodes_stack from persistent fact --------------------------- 0.02s

PLAY [Destroy] *****************************************************************

TASK [Get passwd entries for USER env] *****************************************
Tuesday 30 September 2025  02:39:58 +0000 (0:00:00.013)       0:00:00.013 *****
ok: [localhost]

TASK [Get shell async_dir] *****************************************************
Tuesday 30 September 2025  02:39:59 +0000 (0:00:00.296)       0:00:00.309 *****
ok: [localhost]

TASK [Set async_dir for HOME env] **********************************************
Tuesday 30 September 2025  02:39:59 +0000 (0:00:00.042)       0:00:00.352 *****
skipping: [localhost]

TASK [Destroy molecule instance(s)] ********************************************
Tuesday 30 September 2025  02:39:59 +0000 (0:00:00.034)       0:00:00.386 *****
changed: [localhost] => (item={'command': '/sbin/init', 'dockerfile': 'containerfile', 'image': 'registry.access.redhat.com/ubi9/ubi-init', 'name': 'instance', 'pre_build_image': True})

TASK [Wait for instance(s) deletion to complete] *******************************
Tuesday 30 September 2025  02:39:59 +0000 (0:00:00.406)       0:00:00.792 *****
FAILED - RETRYING: [localhost]: Wait for instance(s) deletion to complete (300 retries left).
changed: [localhost] => (item={'failed': 0, 'started': 1, 'finished': 0, 'ansible_job_id': 'j666517569349.26525', 'results_file': '/home/zuul/.ansible_async/j666517569349.26525', 'changed': True, 'item': {'command': '/sbin/init', 'dockerfile': 'containerfile', 'image': 'registry.access.redhat.com/ubi9/ubi-init', 'name': 'instance', 'pre_build_image': True}, 'ansible_loop_var': 'item'})

TASK [Delete podman network dedicated to this scenario] ************************
Tuesday 30 September 2025  02:40:05 +0000 (0:00:05.510)       0:00:06.303 *****
skipping: [localhost] => (item=instance: None specified)
skipping: [localhost]

PLAY RECAP *********************************************************************
localhost                  : ok=4    changed=2    unreachable=0    failed=0    skipped=2    rescued=0    ignored=0

Tuesday 30 September 2025  02:40:05 +0000 (0:00:00.075)       0:00:06.378 *****
===============================================================================
Wait for instance(s) deletion to complete ------------------------------- 5.51s
Destroy molecule instance(s) -------------------------------------------- 0.41s
Get passwd entries for USER env ----------------------------------------- 0.30s
Delete podman network dedicated to this scenario ------------------------ 0.08s
Get shell async_dir ----------------------------------------------------- 0.04s
Set async_dir for HOME env ---------------------------------------------- 0.03s