PLAY [Prepare] *****************************************************************
TASK [Gathering Facts] *********************************************************
Tuesday 07 October 2025 14:48:21 +0000 (0:00:00.011) 0:00:00.011 *******
ok: [instance]
TASK [Create dummy env file] ***************************************************
Tuesday 07 October 2025 14:48:21 +0000 (0:00:00.858) 0:00:00.869 *******
changed: [instance]
TASK [Create dummy playbook] ***************************************************
Tuesday 07 October 2025 14:48:22 +0000 (0:00:00.555) 0:00:01.425 *******
changed: [instance] => (item=dummy-1.yml)
changed: [instance] => (item=dummy-2.yml)
changed: [instance] => (item=dummy-3.yml)
changed: [instance] => (item=dummy-4.yml)
changed: [instance] => (item=dummy-5.yml)
changed: [instance] => (item=dummy-6.yml)
TASK [Remove dummy file for retry playbook test] *******************************
Tuesday 07 October 2025 14:48:24 +0000 (0:00:01.927) 0:00:03.352 *******
ok: [instance]
TASK [Create dummy retry playbook] *********************************************
Tuesday 07 October 2025 14:48:24 +0000 (0:00:00.283) 0:00:03.635 *******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=5 changed=3 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0
Tuesday 07 October 2025 14:48:25 +0000 (0:00:00.327) 0:00:03.963 *******
===============================================================================
Create dummy playbook --------------------------------------------------- 1.93s
Gathering Facts --------------------------------------------------------- 0.86s
Create dummy env file --------------------------------------------------- 0.56s
Create dummy retry playbook --------------------------------------------- 0.33s
Remove dummy file for retry playbook test ------------------------------- 0.28s
PLAY [Converge] ****************************************************************
TASK [Gathering Facts] *********************************************************
Tuesday 07 October 2025 14:48:25 +0000 (0:00:00.015) 0:00:00.015 *******
ok: [instance]
TASK [No hook] *****************************************************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.812) 0:00:00.827 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.028) 0:00:00.856 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.056) 0:00:00.913 *******
ok: [instance]
TASK [run_hook : Loop on hooks for no_hook] ************************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.073) 0:00:00.986 *******
skipping: [instance]
TASK [Ensure we do not have ceph_uuid] *****************************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.073) 0:00:01.060 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Combined hooks] **********************************************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.023) 0:00:01.084 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.029) 0:00:01.113 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.056) 0:00:01.170 *******
ok: [instance]
TASK [run_hook : Loop on hooks for run_molecule] *******************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.073) 0:00:01.243 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': '01 Default noop hook', 'source': 'noop.yml', 'type': 'playbook'})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': '02 Re-run noop', 'source': 'noop.yml', 'type': 'playbook'})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'source': '/tmp/dummy-1.yml', 'type': 'playbook', 'extra_vars': {'foo': 'bar', 'file': '/tmp/dummy-env.yml'}, 'name': '03 single hook'})
TASK [run_hook : Set playbook path for 01 Default noop hook] *******************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.123) 0:00:01.367 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:26 +0000 (0:00:00.047) 0:00:01.414 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:27 +0000 (0:00:00.289) 0:00:01.703 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:27 +0000 (0:00:00.016) 0:00:01.720 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:27 +0000 (0:00:00.278) 0:00:01.999 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:27 +0000 (0:00:00.019) 0:00:02.018 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:27 +0000 (0:00:00.304) 0:00:02.323 *******
ok: [instance]
TASK [run_hook : Run hook without retry - 01 Default noop hook] ****************
Tuesday 07 October 2025 14:48:28 +0000 (0:00:00.190) 0:00:02.513 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_000_run_hook_without_retry_01.log
changed: [instance]
TASK [run_hook : Run hook with retry - 01 Default noop hook] *******************
Tuesday 07 October 2025 14:48:28 +0000 (0:00:00.607) 0:00:03.120 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:28 +0000 (0:00:00.030) 0:00:03.151 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:28 +0000 (0:00:00.182) 0:00:03.334 *******
skipping: [instance]
TASK [run_hook : Set playbook path for 02 Re-run noop] *************************
Tuesday 07 October 2025 14:48:28 +0000 (0:00:00.018) 0:00:03.352 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:28 +0000 (0:00:00.047) 0:00:03.399 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:29 +0000 (0:00:00.192) 0:00:03.592 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:29 +0000 (0:00:00.017) 0:00:03.609 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:29 +0000 (0:00:00.190) 0:00:03.799 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:29 +0000 (0:00:00.019) 0:00:03.819 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:29 +0000 (0:00:00.201) 0:00:04.020 *******
ok: [instance]
TASK [run_hook : Run hook without retry - 02 Re-run noop] **********************
Tuesday 07 October 2025 14:48:29 +0000 (0:00:00.185) 0:00:04.206 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_001_run_hook_without_retry_02_re.log
changed: [instance]
TASK [run_hook : Run hook with retry - 02 Re-run noop] *************************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.595) 0:00:04.801 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.031) 0:00:04.832 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.174) 0:00:05.007 *******
skipping: [instance]
TASK [run_hook : Set playbook path for 03 single hook] *************************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.021) 0:00:05.029 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.051) 0:00:05.080 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.208) 0:00:05.289 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:30 +0000 (0:00:00.017) 0:00:05.307 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:31 +0000 (0:00:00.195) 0:00:05.503 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:31 +0000 (0:00:00.019) 0:00:05.522 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:31 +0000 (0:00:00.199) 0:00:05.722 *******
ok: [instance]
TASK [run_hook : Run hook without retry - 03 single hook] **********************
Tuesday 07 October 2025 14:48:31 +0000 (0:00:00.188) 0:00:05.911 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_002_run_hook_without_retry_03.log
changed: [instance]
TASK [run_hook : Run hook with retry - 03 single hook] *************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:02.011) 0:00:07.923 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.030) 0:00:07.954 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.201) 0:00:08.156 *******
ok: [instance]
TASK [Ensure we have the ceph_uuid variable now] *******************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.029) 0:00:08.185 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Only listed hooks] *******************************************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.030) 0:00:08.215 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.035) 0:00:08.251 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.062) 0:00:08.313 *******
ok: [instance]
TASK [run_hook : Loop on hooks for list_hooks] *********************************
Tuesday 07 October 2025 14:48:33 +0000 (0:00:00.075) 0:00:08.388 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': 'Run dummy-2', 'source': '/tmp/dummy-2.yml', 'type': 'playbook', 'extra_vars': {'foo': 'bar', 'file': '/tmp/dummy-env.yml'}})
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': 'Run dummy-3', 'source': '/tmp/dummy-3.yml', 'type': 'playbook', 'extra_vars': {'foo': 'bar', 'file': '/tmp/dummy-env.yml'}})
TASK [run_hook : Set playbook path for Run dummy-2] ****************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.109) 0:00:08.498 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.049) 0:00:08.547 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.191) 0:00:08.738 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.017) 0:00:08.756 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.186) 0:00:08.943 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.020) 0:00:08.963 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.194) 0:00:09.158 *******
ok: [instance]
TASK [run_hook : Run hook without retry - Run dummy-2] *************************
Tuesday 07 October 2025 14:48:34 +0000 (0:00:00.188) 0:00:09.347 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_003_run_hook_without_retry_run.log
changed: [instance]
TASK [run_hook : Run hook with retry - Run dummy-2] ****************************
Tuesday 07 October 2025 14:48:36 +0000 (0:00:01.923) 0:00:11.270 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:36 +0000 (0:00:00.031) 0:00:11.302 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.188) 0:00:11.491 *******
ok: [instance]
TASK [run_hook : Set playbook path for Run dummy-3] ****************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.022) 0:00:11.513 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.048) 0:00:11.562 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.187) 0:00:11.750 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.017) 0:00:11.767 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.219) 0:00:11.987 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.022) 0:00:12.010 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.195) 0:00:12.206 *******
ok: [instance]
TASK [run_hook : Run hook without retry - Run dummy-3] *************************
Tuesday 07 October 2025 14:48:37 +0000 (0:00:00.186) 0:00:12.392 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_004_run_hook_without_retry_run.log
changed: [instance]
TASK [run_hook : Run hook with retry - Run dummy-3] ****************************
Tuesday 07 October 2025 14:48:39 +0000 (0:00:01.964) 0:00:14.357 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:39 +0000 (0:00:00.033) 0:00:14.390 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.201) 0:00:14.591 *******
ok: [instance]
TASK [Ensure we have the ceph_uuid variable now] *******************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.027) 0:00:14.619 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Only filtered hooks] *****************************************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.025) 0:00:14.644 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.035) 0:00:14.680 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.059) 0:00:14.739 *******
ok: [instance]
TASK [run_hook : Loop on hooks for filtered_hooks] *****************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.075) 0:00:14.815 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'source': '/tmp/dummy-4.yml', 'type': 'playbook', 'extra_vars': {'foo': 'bar', 'file': '/tmp/dummy-env.yml'}, 'name': '01 my hook'})
TASK [run_hook : Set playbook path for 01 my hook] *****************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.097) 0:00:14.913 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.049) 0:00:14.962 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.191) 0:00:15.154 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.018) 0:00:15.173 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.188) 0:00:15.361 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:40 +0000 (0:00:00.020) 0:00:15.381 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:41 +0000 (0:00:00.192) 0:00:15.574 *******
ok: [instance]
TASK [run_hook : Run hook without retry - 01 my hook] **************************
Tuesday 07 October 2025 14:48:41 +0000 (0:00:00.189) 0:00:15.763 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_005_run_hook_without_retry_01_my.log
changed: [instance]
TASK [run_hook : Run hook with retry - 01 my hook] *****************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:01.943) 0:00:17.706 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.034) 0:00:17.741 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.189) 0:00:17.930 *******
ok: [instance]
TASK [Ensure we have the ceph_uuid variable now] *******************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.027) 0:00:17.958 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Direct hooks] ************************************************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.025) 0:00:17.983 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.037) 0:00:18.021 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.059) 0:00:18.080 *******
ok: [instance]
TASK [run_hook : Loop on hooks for no_hook] ************************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.072) 0:00:18.152 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': 'Dummy-5', 'source': '/tmp/dummy-5.yml', 'type': 'playbook', 'extra_vars': {'foo': 'bar', 'file': '/tmp/dummy-env.yml'}})
TASK [run_hook : Set playbook path for Dummy-5] ********************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.092) 0:00:18.244 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:43 +0000 (0:00:00.048) 0:00:18.292 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:44 +0000 (0:00:00.190) 0:00:18.483 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:44 +0000 (0:00:00.016) 0:00:18.500 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:44 +0000 (0:00:00.192) 0:00:18.692 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:44 +0000 (0:00:00.030) 0:00:18.722 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:44 +0000 (0:00:00.211) 0:00:18.934 *******
ok: [instance]
TASK [run_hook : Run hook without retry - Dummy-5] *****************************
Tuesday 07 October 2025 14:48:44 +0000 (0:00:00.190) 0:00:19.124 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_006_run_hook_without_retry_dummy.log
changed: [instance]
TASK [run_hook : Run hook with retry - Dummy-5] ********************************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:01.914) 0:00:21.038 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:00.029) 0:00:21.068 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:00.186) 0:00:21.254 *******
ok: [instance]
TASK [Ensure we have the ceph_uuid variable now] *******************************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:00.026) 0:00:21.281 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Direct hooks as param] ***************************************************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:00.057) 0:00:21.338 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:00.039) 0:00:21.378 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:46 +0000 (0:00:00.058) 0:00:21.436 *******
ok: [instance]
TASK [run_hook : Loop on hooks for no_hook] ************************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.073) 0:00:21.510 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': 'Hook as param', 'source': '/tmp/dummy-6.yml', 'type': 'playbook', 'extra_vars': {'foo': 'bar', 'file': '/tmp/dummy-env.yml'}})
TASK [run_hook : Set playbook path for Hook as param] **************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.098) 0:00:21.608 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.047) 0:00:21.656 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.190) 0:00:21.846 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.017) 0:00:21.864 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.197) 0:00:22.061 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.019) 0:00:22.081 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.193) 0:00:22.275 *******
ok: [instance]
TASK [run_hook : Run hook without retry - Hook as param] ***********************
Tuesday 07 October 2025 14:48:47 +0000 (0:00:00.184) 0:00:22.459 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_007_run_hook_without_retry_hook.log
changed: [instance]
TASK [run_hook : Run hook with retry - Hook as param] **************************
Tuesday 07 October 2025 14:48:49 +0000 (0:00:01.937) 0:00:24.396 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:49 +0000 (0:00:00.030) 0:00:24.426 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.187) 0:00:24.614 *******
ok: [instance]
TASK [Ensure we have the ceph_uuid variable now] *******************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.026) 0:00:24.640 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Ensure we have the test_list variable now] *******************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.024) 0:00:24.664 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Run hook with retry] *****************************************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.034) 0:00:24.698 *******
TASK [run_hook : Assert parameters are valid] **********************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.026) 0:00:24.725 *******
ok: [instance]
TASK [run_hook : Assert single hooks are all mappings] *************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.056) 0:00:24.782 *******
ok: [instance]
TASK [run_hook : Loop on hooks for retry_hook] *********************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.074) 0:00:24.856 *******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/run_hook/tasks/playbook.yml for instance => (item={'name': 'Run hook with retry', 'source': '/tmp/dummy-retry.yml', 'type': 'playbook', 'retry_hook': True})
TASK [run_hook : Set playbook path for Run hook with retry] ********************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.094) 0:00:24.951 *******
ok: [instance]
TASK [run_hook : Get file stat] ************************************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.049) 0:00:25.001 *******
ok: [instance]
TASK [run_hook : Fail if playbook doesn't exist] *******************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.193) 0:00:25.194 *******
skipping: [instance]
TASK [run_hook : Get parameters files] *****************************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.019) 0:00:25.213 *******
ok: [instance]
TASK [run_hook : Add parameters artifacts as extra variables] ******************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.193) 0:00:25.406 *******
ok: [instance]
TASK [run_hook : Ensure log directory exists] **********************************
Tuesday 07 October 2025 14:48:50 +0000 (0:00:00.020) 0:00:25.427 *******
ok: [instance]
TASK [run_hook : Ensure artifacts directory exists] ****************************
Tuesday 07 October 2025 14:48:51 +0000 (0:00:00.192) 0:00:25.619 *******
ok: [instance]
TASK [run_hook : Run hook without retry - Run hook with retry] *****************
Tuesday 07 October 2025 14:48:51 +0000 (0:00:00.190) 0:00:25.810 *******
Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_008_run_hook_without_retry_run.log
changed: [instance]
TASK [run_hook : Run hook with retry - Run hook with retry] ********************
Tuesday 07 October 2025 14:48:53 +0000 (0:00:01.951) 0:00:27.761 *******
skipping: [instance]
TASK [run_hook : Check if we have a file] **************************************
Tuesday 07 October 2025 14:48:53 +0000 (0:00:00.030) 0:00:27.792 *******
ok: [instance]
TASK [run_hook : Load generated content in main playbook] **********************
Tuesday 07 October 2025 14:48:53 +0000 (0:00:00.180) 0:00:27.972 *******
skipping: [instance]
TASK [Check if fake file exists for retry playbook] ****************************
Tuesday 07 October 2025 14:48:53 +0000 (0:00:00.021) 0:00:27.993 *******
ok: [instance]
TASK [Ensure file exists and was created on retry] *****************************
Tuesday 07 October 2025 14:48:53 +0000 (0:00:00.186) 0:00:28.180 *******
ok: [instance] => changed=false
msg: All assertions passed
TASK [Remove generated file] ***************************************************
Tuesday 07 October 2025 14:48:53 +0000 (0:00:00.019) 0:00:28.200 *******
changed: [instance]
PLAY RECAP *********************************************************************
instance : ok=112 changed=10 unreachable=0 failed=0 skipped=22 rescued=0 ignored=0
Tuesday 07 October 2025 14:48:53 +0000 (0:00:00.196) 0:00:28.396 *******
===============================================================================
run_hook : Run hook without retry - 03 single hook ---------------------- 2.01s
run_hook : Run hook without retry - Run dummy-3 ------------------------- 1.97s
run_hook : Run hook without retry - Run hook with retry ----------------- 1.95s
run_hook : Run hook without retry - 01 my hook -------------------------- 1.94s
run_hook : Run hook without retry - Hook as param ----------------------- 1.94s
run_hook : Run hook without retry - Run dummy-2 ------------------------- 1.92s
run_hook : Run hook without retry - Dummy-5 ----------------------------- 1.91s
Gathering Facts --------------------------------------------------------- 0.81s
run_hook : Run hook without retry - 01 Default noop hook ---------------- 0.61s
run_hook : Run hook without retry - 02 Re-run noop ---------------------- 0.60s
run_hook : Ensure log directory exists ---------------------------------- 0.30s
run_hook : Get file stat ------------------------------------------------ 0.29s
run_hook : Get parameters files ----------------------------------------- 0.28s
run_hook : Get parameters files ----------------------------------------- 0.22s
run_hook : Ensure log directory exists ---------------------------------- 0.21s
run_hook : Get file stat ------------------------------------------------ 0.21s
run_hook : Check if we have a file -------------------------------------- 0.20s
run_hook : Ensure log directory exists ---------------------------------- 0.20s
run_hook : Check if we have a file -------------------------------------- 0.20s
run_hook : Ensure log directory exists ---------------------------------- 0.20s