PLAY [Prepare] *****************************************************************

TASK [Gathering Facts] *********************************************************
Thursday 02 October 2025  15:31:47 +0000 (0:00:00.012)       0:00:00.012 ******
ok: [instance]

TASK [test_deps : Gather facts if they don't exist] ****************************
Thursday 02 October 2025  15:31:47 +0000 (0:00:00.831)       0:00:00.844 ******
skipping: [instance]

TASK [test_deps : Gather variables for each operating system] ******************
Thursday 02 October 2025  15:31:47 +0000 (0:00:00.017)       0:00:00.862 ******
ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)

TASK [test_deps : Detect mirrors file] *****************************************
Thursday 02 October 2025  15:31:47 +0000 (0:00:00.041)       0:00:00.903 ******
ok: [instance]

TASK [test_deps : Disable ubi host subscription-manager integration] ***********
Thursday 02 October 2025  15:31:48 +0000 (0:00:00.289)       0:00:01.192 ******
ok: [instance]

TASK [test_deps : Disable ubi 9 repos] *****************************************
Thursday 02 October 2025  15:31:48 +0000 (0:00:00.313)       0:00:01.506 ******
ok: [instance] => (item=ubi-9-appstream)
ok: [instance] => (item=ubi-9-baseos)
ok: [instance] => (item=ubi-9-codeready-builder)

TASK [Deploy repo-setup] *******************************************************
Thursday 02 October 2025  15:31:49 +0000 (0:00:00.699)       0:00:02.206 ******

TASK [repo_setup : Ensure directories are present] *****************************
Thursday 02 October 2025  15:31:49 +0000 (0:00:00.060)       0:00:02.266 ******
changed: [instance] => (item=tmp)
changed: [instance] => (item=artifacts/repositories)
changed: [instance] => (item=venv/repo_setup)

TASK [repo_setup : Make sure git-core package is installed] ********************
Thursday 02 October 2025  15:31:49 +0000 (0:00:00.556)       0:00:02.823 ******
ok: [instance]

TASK [repo_setup : Get repo-setup repository] **********************************
Thursday 02 October 2025  15:31:50 +0000 (0:00:00.805)       0:00:03.628 ******
changed: [instance]

TASK [repo_setup : Initialize python venv and install requirements] ************
Thursday 02 October 2025  15:31:51 +0000 (0:00:01.164)       0:00:04.793 ******
changed: [instance]

TASK [repo_setup : Install repo-setup package] *********************************
Thursday 02 October 2025  15:31:59 +0000 (0:00:08.012)       0:00:12.805 ******
changed: [instance]

TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
Thursday 02 October 2025  15:32:00 +0000 (0:00:00.727)       0:00:13.532 ******
skipping: [instance]

TASK [repo_setup : Run repo-setup] *********************************************
Thursday 02 October 2025  15:32:00 +0000 (0:00:00.026)       0:00:13.559 ******
changed: [instance]

TASK [repo_setup : Get component repo] *****************************************
Thursday 02 October 2025  15:32:01 +0000 (0:00:00.836)       0:00:14.395 ******
skipping: [instance]

TASK [repo_setup : Rename component repo] **************************************
Thursday 02 October 2025  15:32:01 +0000 (0:00:00.044)       0:00:14.440 ******
skipping: [instance]

TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
Thursday 02 October 2025  15:32:01 +0000 (0:00:00.038)       0:00:14.478 ******
skipping: [instance]

TASK [repo_setup : Run repo-setup-get-hash] ************************************
Thursday 02 October 2025  15:32:01 +0000 (0:00:00.038)       0:00:14.517 ******
changed: [instance]

TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.562)       0:00:15.079 ******
changed: [instance]

TASK [repo_setup : Dump current-podified hash] *********************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.464)       0:00:15.544 ******
skipping: [instance]

TASK [repo_setup : Slurp current podified hash] ********************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.037)       0:00:15.581 ******
skipping: [instance]

TASK [repo_setup : Update the value of full_hash] ******************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.037)       0:00:15.618 ******
skipping: [instance]

TASK [repo_setup : Export hashes facts for further use] ************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.036)       0:00:15.654 ******
ok: [instance]

TASK [repo_setup : Create download directory] **********************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.049)       0:00:15.704 ******
skipping: [instance]

TASK [repo_setup : Print the URL to request] ***********************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.030)       0:00:15.735 ******
skipping: [instance]

TASK [Download the RPM] ********************************************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.029)       0:00:15.764 ******
skipping: [instance]

TASK [repo_setup : Install RHOS Release tool] **********************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.028)       0:00:15.793 ******
skipping: [instance]

TASK [repo_setup : Get rhos-release tool version] ******************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.031)       0:00:15.825 ******
skipping: [instance]

TASK [repo_setup : Print rhos-release tool version] ****************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.034)       0:00:15.860 ******
skipping: [instance]

TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.035)       0:00:15.896 ******
skipping: [instance]

TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
Thursday 02 October 2025  15:32:02 +0000 (0:00:00.032)       0:00:15.928 ******
ok: [instance]

TASK [repo_setup : Use RDO proxy mirrors] **************************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.194)       0:00:16.123 ******
changed: [instance]

TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.224)       0:00:16.348 ******
changed: [instance]

TASK [repo_setup : Check for gating.repo file on content provider] *************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.239)       0:00:16.587 ******
skipping: [instance]

TASK [repo_setup : Populate gating repo from content provider ip] **************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.021)       0:00:16.609 ******
skipping: [instance]

TASK [repo_setup : Check for DLRN repo at the destination] *********************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.020)       0:00:16.629 ******
skipping: [instance]

TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.020)       0:00:16.649 ******
skipping: [instance]

TASK [repo_setup : Check for DLRN component repo] ******************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.020)       0:00:16.670 ******
skipping: [instance]

TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.022)       0:00:16.692 ******
skipping: [instance]

TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.026)       0:00:16.718 ******
skipping: [instance]

TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.019)       0:00:16.738 ******
skipping: [instance]

TASK [repo_setup : Cleanup existing metadata] **********************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.033)       0:00:16.771 ******
skipping: [instance]

TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.019)       0:00:16.791 ******
skipping: [instance]

TASK [test_deps : Look for redhat-release rpm] *********************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.031)       0:00:16.822 ******
skipping: [instance]

TASK [test_deps : Remove redhat-release] ***************************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.041)       0:00:16.864 ******
skipping: [instance]

TASK [test_deps : Install centos-stream-release] *******************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.033)       0:00:16.898 ******
skipping: [instance]

TASK [test_deps : Install additional packages] *********************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.030)       0:00:16.928 ******
skipping: [instance]

TASK [test_deps : Install selinux python libs] *********************************
Thursday 02 October 2025  15:32:03 +0000 (0:00:00.032)       0:00:16.960 ******
ok: [instance]

TASK [test_deps : Install python yaml libs] ************************************
Thursday 02 October 2025  15:32:45 +0000 (0:00:42.030)       0:00:58.991 ******
ok: [instance]

TASK [test_deps : Install extra packages] **************************************
Thursday 02 October 2025  15:32:47 +0000 (0:00:01.157)       0:01:00.149 ******
skipping: [instance]

TASK [Ensure cifmw_ceph_client_config_home exists on all clients] **************
Thursday 02 October 2025  15:32:47 +0000 (0:00:00.039)       0:01:00.188 ******
changed: [instance]

PLAY RECAP *********************************************************************
instance                   : ok=20   changed=10   unreachable=0    failed=0    skipped=30   rescued=0    ignored=0

Thursday 02 October 2025  15:32:47 +0000 (0:00:00.214)       0:01:00.402 ******
===============================================================================
test_deps : Install selinux python libs -------------------------------- 42.03s
repo_setup : Initialize python venv and install requirements ------------ 8.01s
repo_setup : Get repo-setup repository ---------------------------------- 1.16s
test_deps : Install python yaml libs ------------------------------------ 1.16s
repo_setup : Run repo-setup --------------------------------------------- 0.84s
Gathering Facts --------------------------------------------------------- 0.83s
repo_setup : Make sure git-core package is installed -------------------- 0.81s
repo_setup : Install repo-setup package --------------------------------- 0.73s
test_deps : Disable ubi 9 repos ----------------------------------------- 0.70s
repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s
repo_setup : Ensure directories are present ----------------------------- 0.56s
repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.46s
test_deps : Disable ubi host subscription-manager integration ----------- 0.31s
test_deps : Detect mirrors file ----------------------------------------- 0.29s
repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.24s
repo_setup : Use RDO proxy mirrors -------------------------------------- 0.22s
Ensure cifmw_ceph_client_config_home exists on all clients -------------- 0.21s
repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.19s
Deploy repo-setup ------------------------------------------------------- 0.06s
repo_setup : Export hashes facts for further use ------------------------ 0.05s

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

TASK [Gathering Facts] *********************************************************
Thursday 02 October 2025  15:32:47 +0000 (0:00:00.014)       0:00:00.014 ******
ok: [instance]

TASK [cifmw_ceph_client : Check if the input variables exist] ******************
Thursday 02 October 2025  15:32:48 +0000 (0:00:00.802)       0:00:00.817 ******
skipping: [instance]

TASK [cifmw_ceph_client : Load variables produced by the cephadm provisioning process] ***
Thursday 02 October 2025  15:32:48 +0000 (0:00:00.021)       0:00:00.838 ******
skipping: [instance]

TASK [cifmw_ceph_client : Render keys provided for the Ceph cluster] ***********
Thursday 02 October 2025  15:32:48 +0000 (0:00:00.020)       0:00:00.859 ******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_ceph_client/tasks/create_keys.yml for instance

TASK [cifmw_ceph_client : Create cephx key(s)] *********************************
Thursday 02 October 2025  15:32:48 +0000 (0:00:00.029)       0:00:00.888 ******
changed: [instance] => (item={'caps': {'mgr': 'allow *', 'mon': 'profile rbd', 'osd': 'profile rbd pool=vms, profile rbd pool=volumes, profile rbd pool=metrics, profile rbd pool=backups, profile rbd pool=pool2, profile rbd pool=pool3, profile rbd pool=altrbd'}, 'key': 'AQC+vYNXgDAgAhAAc8UoYt+OTz5uhV7ItLdwUw==', 'mode': '0600', 'name': 'client.glance'})
changed: [instance] => (item={'caps': {'mgr': 'allow *', 'mon': 'profile rbd', 'osd': 'profile rbd pool=images'}, 'key': 'AQBRgQ9eAAAAABAAv84zEilJYZPNuJ0Iwn9Ndg==', 'mode': '0600', 'name': 'client.manila'})

TASK [cifmw_ceph_client : Render ceph config for the Ceph Clients] *************
Thursday 02 October 2025  15:32:49 +0000 (0:00:00.920)       0:00:01.808 ******
included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_ceph_client/tasks/create_ceph_conf.yml for instance

TASK [cifmw_ceph_client : Create ceph.conf] ************************************
Thursday 02 October 2025  15:32:49 +0000 (0:00:00.019)       0:00:01.828 ******
changed: [instance]

TASK [cifmw_ceph_client : Create edpm-values-post-ceph ConfigMap if sample path provided] ***
Thursday 02 October 2025  15:32:50 +0000 (0:00:00.386)       0:00:02.215 ******
skipping: [instance]

TASK [cifmw_ceph_client : Create edpm-service-values-post-ceph ConfigMap if sample path provided] ***
Thursday 02 October 2025  15:32:50 +0000 (0:00:00.020)       0:00:02.236 ******
skipping: [instance]

TASK [Check current file] ******************************************************
Thursday 02 October 2025  15:32:50 +0000 (0:00:00.024)       0:00:02.260 ******
ok: [instance] => (item=ceph.client.glance.keyring)
ok: [instance] => (item=ceph.client.manila.keyring)
ok: [instance] => (item=ceph.conf)

TASK [Fail if file not found] **************************************************
Thursday 02 October 2025  15:32:50 +0000 (0:00:00.544)       0:00:02.805 ******
skipping: [instance] => (item={'changed': False, 'stat': {'exists': True, 'path': '/tmp/ceph.client.glance.keyring', 'mode': '0600', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 1000, 'gid': 1000, 'size': 302, 'inode': 146825378, 'dev': 64513, 'nlink': 1, 'atime': 1759419169.3144627, 'mtime': 1759419169.0474603, 'ctime': 1759419169.3164625, 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': False, 'xgrp': False, 'woth': False, 'roth': False, 'xoth': False, 'isuid': False, 'isgid': False, 'blocks': 8, 'block_size': 4096, 'device_type': 0, 'readable': True, 'writeable': True, 'executable': False, 'pw_name': 'zuul', 'gr_name': 'zuul', 'checksum': 'e7164142ee2f357bf32771e16ce9bcaf223d404e', 'mimetype': 'text/plain', 'charset': 'us-ascii', 'version': '873328239', 'attributes': [], 'attr_flags': ''}, 'invocation': {'module_args': {'path': '/tmp/ceph.client.glance.keyring', 'follow': False, 'get_md5': False, 'get_checksum': True, 'get_mime': True, 'get_attributes': True, 'checksum_algorithm': 'sha1'}}, 'failed': False, 'item': 'ceph.client.glance.keyring', 'ansible_loop_var': 'item'})
skipping: [instance] => (item={'changed': False, 'stat': {'exists': True, 'path': '/tmp/ceph.client.manila.keyring', 'mode': '0600', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 1000, 'gid': 1000, 'size': 154, 'inode': 163593792, 'dev': 64513, 'nlink': 1, 'atime': 1759419169.6514657, 'mtime': 1759419169.5044644, 'ctime': 1759419169.6534657, 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': False, 'xgrp': False, 'woth': False, 'roth': False, 'xoth': False, 'isuid': False, 'isgid': False, 'blocks': 8, 'block_size': 4096, 'device_type': 0, 'readable': True, 'writeable': True, 'executable': False, 'pw_name': 'zuul', 'gr_name': 'zuul', 'checksum': 'd6d4783ea1936e82934ab1c7b21cc940553e7bd8', 'mimetype': 'text/plain', 'charset': 'us-ascii', 'version': '2330242156', 'attributes': [], 'attr_flags': ''}, 'invocation': {'module_args': {'path': '/tmp/ceph.client.manila.keyring', 'follow': False, 'get_md5': False, 'get_checksum': True, 'get_mime': True, 'get_attributes': True, 'checksum_algorithm': 'sha1'}}, 'failed': False, 'item': 'ceph.client.manila.keyring', 'ansible_loop_var': 'item'})
skipping: [instance] => (item={'changed': False, 'stat': {'exists': True, 'path': '/tmp/ceph.conf', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 0, 'gid': 0, 'size': 386, 'inode': 8534747, 'dev': 64513, 'nlink': 1, 'atime': 1759419170.0594692, 'mtime': 1759419169.908468, 'ctime': 1759419170.0634694, 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False, 'blocks': 8, 'block_size': 4096, 'device_type': 0, 'readable': True, 'writeable': False, 'executable': False, 'pw_name': 'root', 'gr_name': 'root', 'checksum': 'e31ff745c34475be37b341f51eb9c14b9adbb4f9', 'mimetype': 'text/plain', 'charset': 'us-ascii', 'version': '3630026325', 'attributes': [], 'attr_flags': ''}, 'invocation': {'module_args': {'path': '/tmp/ceph.conf', 'follow': False, 'get_md5': False, 'get_checksum': True, 'get_mime': True, 'get_attributes': True, 'checksum_algorithm': 'sha1'}}, 'failed': False, 'item': 'ceph.conf', 'ansible_loop_var': 'item'})
skipping: [instance]

TASK [Show the content of the generated Ceph config file] **********************
Thursday 02 October 2025  15:32:50 +0000 (0:00:00.029)       0:00:02.834 ******
ok: [instance]

TASK [Debug ceph config] *******************************************************
Thursday 02 October 2025  15:32:50 +0000 (0:00:00.285)       0:00:03.119 ******
ok: [instance] =>
  msg: |-
    # Ansible managed: Do NOT edit this file manually!

    [global]

    fsid = 1dee28aa-2eba-11eb-b30b-244200b898e6
    mon host = 172.16.3.10,172.16.3.11,172.16.3.12
    [client]
    rbd_cache = True
    rbd_cache_writethrough_until_flush = True
    rbd_concurrent_management_ops = 20


    [client.libvirt]
    admin socket = /var/run/ceph/$cluster-$type.$id.$pid.$cctid.asok
    log file = /var/log/ceph/qemu-guest-$pid.log

PLAY RECAP *********************************************************************
instance                   : ok=8    changed=2    unreachable=0    failed=0    skipped=5    rescued=0    ignored=0

Thursday 02 October 2025  15:32:51 +0000 (0:00:00.041)       0:00:03.161 ******
===============================================================================
cifmw_ceph_client : Create cephx key(s) --------------------------------- 0.92s
Gathering Facts --------------------------------------------------------- 0.80s
Check current file ------------------------------------------------------ 0.54s
cifmw_ceph_client : Create ceph.conf ------------------------------------ 0.39s
Show the content of the generated Ceph config file ---------------------- 0.29s
Debug ceph config ------------------------------------------------------- 0.04s
Fail if file not found -------------------------------------------------- 0.03s
cifmw_ceph_client : Render keys provided for the Ceph cluster ----------- 0.03s
cifmw_ceph_client : Create edpm-service-values-post-ceph ConfigMap if sample path provided --- 0.02s
cifmw_ceph_client : Check if the input variables exist ------------------ 0.02s
cifmw_ceph_client : Create edpm-values-post-ceph ConfigMap if sample path provided --- 0.02s
cifmw_ceph_client : Load variables produced by the cephadm provisioning process --- 0.02s
cifmw_ceph_client : Render ceph config for the Ceph Clients ------------- 0.02s