2026-01-29 19:32:41.938264 | Job console starting... 2026-01-29 19:32:42.154978 | Updating repositories 2026-01-29 19:32:42.878767 | Preparing job workspace 2026-01-29 19:32:49.811255 | Running Ansible setup... 2026-01-29 19:32:52.468713 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-01-29 19:32:52.936025 | 2026-01-29 19:32:52.936126 | PLAY [localhost] 2026-01-29 19:32:52.943934 | 2026-01-29 19:32:52.943999 | TASK [Gathering Facts] 2026-01-29 19:32:53.698632 | localhost | ok 2026-01-29 19:32:53.711256 | 2026-01-29 19:32:53.711346 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 19:32:53.998750 | localhost -> localhost | changed 2026-01-29 19:32:54.003427 | 2026-01-29 19:32:54.003493 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 19:32:54.633073 | localhost -> localhost | changed 2026-01-29 19:32:54.640646 | 2026-01-29 19:32:54.640712 | TASK [Setup log path fact] 2026-01-29 19:32:54.656494 | localhost | ok 2026-01-29 19:32:54.666186 | 2026-01-29 19:32:54.666248 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 19:32:54.681857 | localhost | ok 2026-01-29 19:32:54.688369 | 2026-01-29 19:32:54.688434 | TASK [emit-job-header : Print job information] 2026-01-29 19:32:54.714130 | # Job Information 2026-01-29 19:32:54.714232 | Ansible Version: 2.15.12 2026-01-29 19:32:54.714260 | Job: cifmw-molecule-build_openstack_packages 2026-01-29 19:32:54.714280 | Pipeline: github-check 2026-01-29 19:32:54.714317 | Executor: ibm-bm4-ze.softwarefactory-project.io 2026-01-29 19:32:54.714340 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3640 2026-01-29 19:32:54.714360 | Log URL (when completed): https://logserver.rdoproject.org/181/rdoproject.org/18171fd4db1141699c8a85c8fe22935a/ 2026-01-29 19:32:54.714378 | Event ID: 20e7afa0-fd49-11f0-9e65-1375fafa31af 2026-01-29 19:32:54.717640 | 2026-01-29 19:32:54.717701 | LOOP [emit-job-header : Print node information] 2026-01-29 19:32:54.792887 | localhost | ok: 2026-01-29 19:32:54.793115 | localhost | # Node Information 2026-01-29 19:32:54.793146 | localhost | Inventory Hostname: controller 2026-01-29 19:32:54.793171 | localhost | Hostname: np0005601479 2026-01-29 19:32:54.793191 | localhost | Username: zuul 2026-01-29 19:32:54.793209 | localhost | Distro: CentOS 9 2026-01-29 19:32:54.793225 | localhost | Provider: ibm-bm4-nodepool 2026-01-29 19:32:54.793240 | localhost | Region: regionOne 2026-01-29 19:32:54.793254 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2026-01-29 19:32:54.793268 | localhost | Product Name: OpenStack Compute 2026-01-29 19:32:54.793282 | localhost | Interface IP: 192.168.26.198 2026-01-29 19:32:54.817160 | 2026-01-29 19:32:54.817242 | PLAY [all] 2026-01-29 19:32:54.822730 | 2026-01-29 19:32:54.822789 | TASK [Gather network facts] 2026-01-29 19:32:55.165329 | controller | ok 2026-01-29 19:32:55.177486 | 2026-01-29 19:32:55.177541 | TASK [include_role : start-zuul-console] 2026-01-29 19:32:55.193759 | controller | ok 2026-01-29 19:32:55.204924 | 2026-01-29 19:32:55.204989 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 19:32:55.475773 | controller | ok 2026-01-29 19:32:55.483397 | 2026-01-29 19:32:55.483456 | TASK [include_role : add-build-sshkey] 2026-01-29 19:32:55.499910 | controller | ok 2026-01-29 19:32:55.510914 | 2026-01-29 19:32:55.510972 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 19:32:55.685208 | controller -> localhost | ok 2026-01-29 19:32:55.690393 | 2026-01-29 19:32:55.690455 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 19:32:55.707004 | controller | ok 2026-01-29 19:32:55.719342 | controller | included: /var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 19:32:55.724268 | 2026-01-29 19:32:55.724345 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 19:32:56.100817 | controller -> localhost | Generating public/private rsa key pair. 2026-01-29 19:32:56.100986 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/18171fd4db1141699c8a85c8fe22935a_id_rsa. 2026-01-29 19:32:56.101018 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/18171fd4db1141699c8a85c8fe22935a_id_rsa.pub. 2026-01-29 19:32:56.101041 | controller -> localhost | The key fingerprint is: 2026-01-29 19:32:56.101061 | controller -> localhost | SHA256:Zy93RBw+mj9Nm6ss3SJnE48Qo/uTzrlaAr+isTXIG08 zuul-build-sshkey 2026-01-29 19:32:56.101080 | controller -> localhost | The key's randomart image is: 2026-01-29 19:32:56.101099 | controller -> localhost | +---[RSA 3072]----+ 2026-01-29 19:32:56.101116 | controller -> localhost | | . | 2026-01-29 19:32:56.101133 | controller -> localhost | | o . | 2026-01-29 19:32:56.101149 | controller -> localhost | | = | 2026-01-29 19:32:56.101167 | controller -> localhost | | o + . | 2026-01-29 19:32:56.101184 | controller -> localhost | | .S + = . .| 2026-01-29 19:32:56.101200 | controller -> localhost | | . . o+ o + oo| 2026-01-29 19:32:56.101216 | controller -> localhost | | = E oo.* Oo.| 2026-01-29 19:32:56.101231 | controller -> localhost | | O...=BoO +.| 2026-01-29 19:32:56.101247 | controller -> localhost | | +...o+*Bo+. | 2026-01-29 19:32:56.101265 | controller -> localhost | +----[SHA256]-----+ 2026-01-29 19:32:56.101334 | controller -> localhost | ok: Runtime: 0:00:00.082031 2026-01-29 19:32:56.106378 | 2026-01-29 19:32:56.106437 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 19:32:56.123056 | controller | ok 2026-01-29 19:32:56.131290 | controller | included: /var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 19:32:56.138088 | 2026-01-29 19:32:56.138148 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 19:32:56.150727 | controller | skipping: Conditional result was False 2026-01-29 19:32:56.156275 | 2026-01-29 19:32:56.156356 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 19:32:56.487796 | controller | changed 2026-01-29 19:32:56.493227 | 2026-01-29 19:32:56.493286 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 19:32:56.663142 | controller | ok 2026-01-29 19:32:56.667765 | 2026-01-29 19:32:56.667825 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 19:32:57.172957 | controller | changed 2026-01-29 19:32:57.177577 | 2026-01-29 19:32:57.177648 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 19:32:57.682178 | controller | changed 2026-01-29 19:32:57.687125 | 2026-01-29 19:32:57.687194 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 19:32:57.700891 | controller | skipping: Conditional result was False 2026-01-29 19:32:57.706607 | 2026-01-29 19:32:57.706667 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 19:32:58.006327 | controller -> localhost | changed 2026-01-29 19:32:58.014943 | 2026-01-29 19:32:58.015003 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 19:32:58.241695 | controller -> localhost | Identity added: /var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/18171fd4db1141699c8a85c8fe22935a_id_rsa (zuul-build-sshkey) 2026-01-29 19:32:58.242029 | controller -> localhost | ok: Runtime: 0:00:00.007567 2026-01-29 19:32:58.247710 | 2026-01-29 19:32:58.247773 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 19:32:58.510423 | controller | ok 2026-01-29 19:32:58.514639 | 2026-01-29 19:32:58.514699 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 19:32:58.538907 | controller | skipping: Conditional result was False 2026-01-29 19:32:58.547631 | 2026-01-29 19:32:58.547702 | TASK [include_role : validate-host] 2026-01-29 19:32:58.564898 | controller | ok 2026-01-29 19:32:58.583266 | 2026-01-29 19:32:58.583344 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 19:32:58.610190 | controller | ok 2026-01-29 19:32:58.614190 | 2026-01-29 19:32:58.614250 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 19:32:58.830019 | controller -> localhost | ok 2026-01-29 19:32:58.835149 | 2026-01-29 19:32:58.835209 | TASK [validate-host : Collect information about the host] 2026-01-29 19:32:59.403081 | controller | ok 2026-01-29 19:32:59.410381 | 2026-01-29 19:32:59.410449 | TASK [validate-host : Sanitize hostname] 2026-01-29 19:32:59.478388 | controller | ok 2026-01-29 19:32:59.482997 | 2026-01-29 19:32:59.483060 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 19:32:59.853598 | controller -> localhost | changed 2026-01-29 19:32:59.877826 | 2026-01-29 19:32:59.877927 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 19:33:00.180362 | controller | ok 2026-01-29 19:33:00.184707 | 2026-01-29 19:33:00.184768 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 19:33:00.522435 | controller -> localhost | changed 2026-01-29 19:33:00.531131 | 2026-01-29 19:33:00.531193 | TASK [include_role : prepare-workspace-openshift] 2026-01-29 19:33:00.543969 | controller | skipping: Conditional result was False 2026-01-29 19:33:00.548555 | 2026-01-29 19:33:00.548619 | TASK [include_role : remove-zuul-sshkey] 2026-01-29 19:33:00.561152 | controller | skipping: Conditional result was False 2026-01-29 19:33:00.565989 | 2026-01-29 19:33:00.566056 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-01-29 19:33:00.745128 | controller | ok: "logs" 2026-01-29 19:33:00.745425 | controller | ok: All items complete 2026-01-29 19:33:00.745462 | 2026-01-29 19:33:00.892346 | controller | ok: "artifacts" 2026-01-29 19:33:01.039353 | controller | ok: "docs" 2026-01-29 19:33:01.049919 | 2026-01-29 19:33:01.050018 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-01-29 19:33:01.229825 | controller | changed: "logs" 2026-01-29 19:33:01.379969 | controller | changed: "artifacts" 2026-01-29 19:33:01.530729 | controller | changed: "docs" 2026-01-29 19:33:01.549967 | 2026-01-29 19:33:01.550058 | PLAY RECAP 2026-01-29 19:33:01.550099 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-01-29 19:33:01.550126 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-29 19:33:01.550144 | 2026-01-29 19:33:01.621584 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-01-29 19:33:01.622317 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-01-29 19:33:02.122333 | 2026-01-29 19:33:02.122443 | PLAY [all] 2026-01-29 19:33:02.139996 | 2026-01-29 19:33:02.140070 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-01-29 19:33:02.189172 | controller | ok 2026-01-29 19:33:02.193660 | 2026-01-29 19:33:02.193737 | TASK [mirror-info-fork : Create /etc/ci] 2026-01-29 19:33:02.496151 | controller | changed 2026-01-29 19:33:02.501157 | 2026-01-29 19:33:02.501224 | TASK [mirror-info-fork : Install ci_mirror script] 2026-01-29 19:33:03.211485 | controller | changed 2026-01-29 19:33:03.220637 | 2026-01-29 19:33:03.220708 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2026-01-29 19:33:03.549211 | controller | changed: 2026-01-29 19:33:03.549464 | controller | { 2026-01-29 19:33:03.549496 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2026-01-29 19:33:03.549527 | controller | } 2026-01-29 19:33:03.741715 | controller | changed: 2026-01-29 19:33:03.741804 | controller | { 2026-01-29 19:33:03.741835 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2026-01-29 19:33:03.741857 | controller | } 2026-01-29 19:33:03.929626 | controller | changed: 2026-01-29 19:33:03.929678 | controller | { 2026-01-29 19:33:03.929703 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2026-01-29 19:33:03.929723 | controller | } 2026-01-29 19:33:04.115844 | controller | changed: 2026-01-29 19:33:04.115904 | controller | { 2026-01-29 19:33:04.115932 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2026-01-29 19:33:04.115953 | controller | } 2026-01-29 19:33:04.297600 | controller | changed: 2026-01-29 19:33:04.297646 | controller | { 2026-01-29 19:33:04.297670 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2026-01-29 19:33:04.297688 | controller | } 2026-01-29 19:33:04.479480 | controller | changed: 2026-01-29 19:33:04.479527 | controller | { 2026-01-29 19:33:04.479552 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2026-01-29 19:33:04.479570 | controller | } 2026-01-29 19:33:04.662873 | controller | changed: 2026-01-29 19:33:04.662927 | controller | { 2026-01-29 19:33:04.662951 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2026-01-29 19:33:04.662969 | controller | } 2026-01-29 19:33:04.850290 | controller | changed: 2026-01-29 19:33:04.850356 | controller | { 2026-01-29 19:33:04.850383 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2026-01-29 19:33:04.850404 | controller | } 2026-01-29 19:33:05.038356 | controller | changed: 2026-01-29 19:33:05.038408 | controller | { 2026-01-29 19:33:05.038432 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2026-01-29 19:33:05.038450 | controller | } 2026-01-29 19:33:05.225507 | controller | changed: 2026-01-29 19:33:05.225559 | controller | { 2026-01-29 19:33:05.225584 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2026-01-29 19:33:05.225604 | controller | } 2026-01-29 19:33:05.420047 | controller | changed: 2026-01-29 19:33:05.420098 | controller | { 2026-01-29 19:33:05.420123 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2026-01-29 19:33:05.420141 | controller | } 2026-01-29 19:33:05.632925 | controller | changed: 2026-01-29 19:33:05.633311 | controller | { 2026-01-29 19:33:05.633353 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2026-01-29 19:33:05.633377 | controller | } 2026-01-29 19:33:05.809451 | controller | changed: 2026-01-29 19:33:05.809504 | controller | { 2026-01-29 19:33:05.809529 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2026-01-29 19:33:05.809549 | controller | } 2026-01-29 19:33:06.003316 | controller | changed: 2026-01-29 19:33:06.003366 | controller | { 2026-01-29 19:33:06.003391 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2026-01-29 19:33:06.003410 | controller | } 2026-01-29 19:33:06.192998 | controller | changed: 2026-01-29 19:33:06.193052 | controller | { 2026-01-29 19:33:06.193078 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2026-01-29 19:33:06.193097 | controller | } 2026-01-29 19:33:06.384551 | controller | changed: 2026-01-29 19:33:06.384608 | controller | { 2026-01-29 19:33:06.384633 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2026-01-29 19:33:06.384652 | controller | } 2026-01-29 19:33:06.575998 | controller | changed: 2026-01-29 19:33:06.576048 | controller | { 2026-01-29 19:33:06.576073 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2026-01-29 19:33:06.576093 | controller | } 2026-01-29 19:33:06.763536 | controller | changed: 2026-01-29 19:33:06.763581 | controller | { 2026-01-29 19:33:06.763605 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2026-01-29 19:33:06.763630 | controller | } 2026-01-29 19:33:06.950000 | controller | changed: 2026-01-29 19:33:06.950048 | controller | { 2026-01-29 19:33:06.950071 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2026-01-29 19:33:06.950088 | controller | } 2026-01-29 19:33:07.134751 | controller | changed: 2026-01-29 19:33:07.134800 | controller | { 2026-01-29 19:33:07.134826 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2026-01-29 19:33:07.134846 | controller | } 2026-01-29 19:33:07.326037 | controller | changed: 2026-01-29 19:33:07.326093 | controller | { 2026-01-29 19:33:07.326120 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2026-01-29 19:33:07.326140 | controller | } 2026-01-29 19:33:07.510825 | controller | changed: 2026-01-29 19:33:07.510873 | controller | { 2026-01-29 19:33:07.510905 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2026-01-29 19:33:07.510923 | controller | } 2026-01-29 19:33:07.705395 | controller | changed: 2026-01-29 19:33:07.705455 | controller | { 2026-01-29 19:33:07.705480 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2026-01-29 19:33:07.705501 | controller | } 2026-01-29 19:33:07.893630 | controller | changed: 2026-01-29 19:33:07.893681 | controller | { 2026-01-29 19:33:07.893708 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2026-01-29 19:33:07.893727 | controller | } 2026-01-29 19:33:08.077546 | controller | changed: 2026-01-29 19:33:08.077595 | controller | { 2026-01-29 19:33:08.077620 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2026-01-29 19:33:08.077638 | controller | } 2026-01-29 19:33:08.262394 | controller | changed: 2026-01-29 19:33:08.262442 | controller | { 2026-01-29 19:33:08.262465 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2026-01-29 19:33:08.262483 | controller | } 2026-01-29 19:33:08.280941 | 2026-01-29 19:33:08.281048 | TASK [Set timezone to UTC] 2026-01-29 19:33:08.635076 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2026-01-29 19:33:08.639567 | 2026-01-29 19:33:08.639632 | TASK [Create nodepool directory] 2026-01-29 19:33:08.830564 | controller | changed 2026-01-29 19:33:08.835624 | 2026-01-29 19:33:08.835690 | TASK [Create nodepool sub_nodes file] 2026-01-29 19:33:09.299468 | controller | changed 2026-01-29 19:33:09.303642 | 2026-01-29 19:33:09.303702 | TASK [Create nodepool sub_nodes_private file] 2026-01-29 19:33:09.757195 | controller | changed 2026-01-29 19:33:09.761632 | 2026-01-29 19:33:09.761694 | LOOP [Populate nodepool sub_nodes file] 2026-01-29 19:33:09.790927 | 2026-01-29 19:33:09.791040 | LOOP [Populate nodepool sub_nodes_private file] 2026-01-29 19:33:09.819062 | 2026-01-29 19:33:09.819176 | TASK [Create nodepool primary file] 2026-01-29 19:33:09.842376 | controller | skipping: Conditional result was False 2026-01-29 19:33:09.847244 | 2026-01-29 19:33:09.847329 | TASK [Create nodepool node_private for this node] 2026-01-29 19:33:10.330918 | controller | changed 2026-01-29 19:33:10.335983 | 2026-01-29 19:33:10.336039 | LOOP [Copy ssh keys to nodepool directory] 2026-01-29 19:33:10.619829 | controller | ok: Item: id_rsa Runtime: 0:00:00.004177 2026-01-29 19:33:10.620004 | 2026-01-29 19:33:10.768063 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.003480 2026-01-29 19:33:10.782461 | 2026-01-29 19:33:10.782566 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2026-01-29 19:33:11.267542 | controller | changed 2026-01-29 19:33:11.271980 | 2026-01-29 19:33:11.272045 | TASK [Validate sudoers config after edits] 2026-01-29 19:33:11.465098 | controller | /etc/sudoers: parsed OK 2026-01-29 19:33:11.465136 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2026-01-29 19:33:11.465143 | controller | /etc/sudoers.d/zuul: parsed OK 2026-01-29 19:33:11.465151 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2026-01-29 19:33:11.796119 | controller | ok: Runtime: 0:00:00.005222 2026-01-29 19:33:11.800988 | 2026-01-29 19:33:11.801089 | TASK [Show the environment passed in to job shell scripts] 2026-01-29 19:33:11.979570 | controller | SHELL=/bin/bash 2026-01-29 19:33:11.979612 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2026-01-29 19:33:11.979621 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2026-01-29 19:33:11.979627 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/40/3640/95cd86fe406021e02879a264a15ebff828dcfc1a 2026-01-29 19:33:11.979633 | controller | PWD=/home/zuul 2026-01-29 19:33:11.979638 | controller | ZUUL_PIPELINE=github-check 2026-01-29 19:33:11.979644 | controller | LOGNAME=zuul 2026-01-29 19:33:11.979649 | controller | XDG_SESSION_TYPE=tty 2026-01-29 19:33:11.979654 | controller | _=/usr/bin/env 2026-01-29 19:33:11.979698 | controller | MOTD_SHOWN=pam 2026-01-29 19:33:11.979705 | controller | HOME=/home/zuul 2026-01-29 19:33:11.979711 | controller | LANG=en_US.UTF-8 2026-01-29 19:33:11.979716 | controller | SSH_CONNECTION=192.168.26.12 58746 192.168.26.198 22 2026-01-29 19:33:11.979722 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2026-01-29 19:33:11.979730 | controller | ZUUL_CHANGE_IDS=3640,95cd86fe406021e02879a264a15ebff828dcfc1a 2026-01-29 19:33:11.979735 | controller | WORKSPACE=/home/zuul/workspace 2026-01-29 19:33:11.979740 | controller | XDG_SESSION_CLASS=user 2026-01-29 19:33:11.979746 | controller | SELINUX_ROLE_REQUESTED= 2026-01-29 19:33:11.979751 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2026-01-29 19:33:11.979756 | controller | USER=zuul 2026-01-29 19:33:11.979761 | controller | ZUUL_VOTING=True 2026-01-29 19:33:11.979766 | controller | BUILD_TIMEOUT=1800000 2026-01-29 19:33:11.979771 | controller | SELINUX_USE_CURRENT_RANGE= 2026-01-29 19:33:11.979776 | controller | SHLVL=1 2026-01-29 19:33:11.979781 | controller | ZUUL_PATCHSET=95cd86fe406021e02879a264a15ebff828dcfc1a 2026-01-29 19:33:11.979786 | controller | XDG_SESSION_ID=1 2026-01-29 19:33:11.979791 | controller | ZUUL_BRANCH=main 2026-01-29 19:33:11.979796 | controller | XDG_RUNTIME_DIR=/run/user/1000 2026-01-29 19:33:11.979801 | controller | SSH_CLIENT=192.168.26.12 58746 22 2026-01-29 19:33:11.979808 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2026-01-29 19:33:11.979813 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2026-01-29 19:33:11.979819 | controller | which_declare=declare -f 2026-01-29 19:33:11.979824 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-01-29 19:33:11.979830 | controller | SELINUX_LEVEL_REQUESTED= 2026-01-29 19:33:11.979835 | controller | ZUUL_CHANGE=3640 2026-01-29 19:33:11.979840 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2026-01-29 19:33:11.979845 | controller | ZUUL_UUID=18171fd4db1141699c8a85c8fe22935a 2026-01-29 19:33:11.979851 | controller | BASH_FUNC_which%%=() { ( alias; 2026-01-29 19:33:11.979856 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2026-01-29 19:33:11.979861 | controller | } 2026-01-29 19:33:12.326265 | controller | ok: Runtime: 0:00:00.005548 2026-01-29 19:33:12.330960 | 2026-01-29 19:33:12.331022 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2026-01-29 19:33:12.343757 | controller | skipping: Conditional result was False 2026-01-29 19:33:12.348511 | 2026-01-29 19:33:12.348572 | TASK [Symlink /home/zuul-worker/workspace] 2026-01-29 19:33:12.871731 | controller | skipping: Conditional result was False 2026-01-29 19:33:12.876892 | 2026-01-29 19:33:12.876954 | TASK [Ensure legacy workspace directory] 2026-01-29 19:33:13.047468 | controller | changed 2026-01-29 19:33:13.063929 | 2026-01-29 19:33:13.063986 | PLAY RECAP 2026-01-29 19:33:13.064028 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-01-29 19:33:13.064049 | 2026-01-29 19:33:13.133911 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-01-29 19:33:13.134656 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-01-29 19:33:13.607810 | 2026-01-29 19:33:13.607922 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2026-01-29 19:33:13.627225 | 2026-01-29 19:33:13.627318 | TASK [Create zuul-output directory] 2026-01-29 19:33:13.919805 | controller | changed 2026-01-29 19:33:13.924607 | 2026-01-29 19:33:13.924681 | TASK [Slurp Zuul inventory test] 2026-01-29 19:33:14.180758 | controller -> localhost | ok 2026-01-29 19:33:14.186503 | 2026-01-29 19:33:14.186565 | TASK [Save zuul inventory] 2026-01-29 19:33:14.852707 | controller | changed 2026-01-29 19:33:14.857126 | 2026-01-29 19:33:14.857187 | TASK [Save zuul vars without the change_message] 2026-01-29 19:33:15.393997 | controller | changed 2026-01-29 19:33:15.411390 | 2026-01-29 19:33:15.411443 | PLAY RECAP 2026-01-29 19:33:15.411484 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-29 19:33:15.411506 | 2026-01-29 19:33:15.476325 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-01-29 19:33:15.477037 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-01-29 19:33:16.000842 | 2026-01-29 19:33:16.000950 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2026-01-29 19:33:16.020592 | 2026-01-29 19:33:16.020665 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2026-01-29 19:33:16.038440 | controller | ok 2026-01-29 19:33:16.054509 | 2026-01-29 19:33:16.054593 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-01-29 19:33:16.077599 | controller | skipping: Conditional result was False 2026-01-29 19:33:16.083189 | 2026-01-29 19:33:16.083259 | TASK [mirror-info-fork : Create /etc/ci] 2026-01-29 19:33:16.374216 | controller | ok 2026-01-29 19:33:16.379180 | 2026-01-29 19:33:16.379243 | TASK [mirror-info-fork : Install ci_mirror script] 2026-01-29 19:33:16.943819 | controller | ok 2026-01-29 19:33:16.952846 | 2026-01-29 19:33:16.952914 | TASK [Prepare workspace] 2026-01-29 19:33:16.970052 | controller | ok 2026-01-29 19:33:16.985799 | 2026-01-29 19:33:16.985898 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-01-29 19:33:17.277089 | controller | ok 2026-01-29 19:33:17.282509 | 2026-01-29 19:33:17.282572 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-01-29 19:33:19.746504 | controller | Output suppressed because no_log was given 2026-01-29 19:33:19.754425 | 2026-01-29 19:33:19.754484 | LOOP [Create zuul-output directory] 2026-01-29 19:33:19.933522 | controller | changed: "/home/zuul/ci-framework-data/logs" 2026-01-29 19:33:20.078455 | controller | ok: "/home/zuul/zuul-output/logs" 2026-01-29 19:33:20.095012 | 2026-01-29 19:33:20.095232 | TASK [Install required packages] 2026-01-29 19:33:58.107826 | controller | changed 2026-01-29 19:33:58.112704 | 2026-01-29 19:33:58.112766 | TASK [Install venv] 2026-01-29 19:34:58.109856 | controller | changed 2026-01-29 19:34:58.134893 | 2026-01-29 19:34:58.134969 | PLAY RECAP 2026-01-29 19:34:58.135016 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-01-29 19:34:58.135039 | 2026-01-29 19:34:58.200479 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-01-29 19:34:58.201238 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2026-01-29 19:34:58.686962 | 2026-01-29 19:34:58.687053 | PLAY [Run ci/playbooks/molecule-test.yml] 2026-01-29 19:34:58.705491 | 2026-01-29 19:34:58.705562 | TASK [Gather required facts] 2026-01-29 19:34:59.139619 | controller | ok 2026-01-29 19:34:59.144376 | 2026-01-29 19:34:59.144446 | TASK [Load environment var if instructed to] 2026-01-29 19:34:59.168589 | controller | skipping: Conditional result was False 2026-01-29 19:34:59.173593 | 2026-01-29 19:34:59.173656 | TASK [Ensure group_vars dir exists] 2026-01-29 19:34:59.454805 | controller | ok 2026-01-29 19:34:59.460320 | 2026-01-29 19:34:59.460386 | TASK [Print related variables] 2026-01-29 19:34:59.488236 | controller | ok: 2026-01-29 19:34:59.488352 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml 2026-01-29 19:34:59.488383 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages 2026-01-29 19:34:59.492757 | 2026-01-29 19:34:59.492813 | TASK [Run molecule] 2026-01-29 19:35:00.378558 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2026-01-29 19:35:00.442702 | controller | INFO Performing prerun with role_name_check=0... 2026-01-29 19:35:17.088264 | controller | WARNING Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.088794 | controller | WARNING Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.089312 | controller | WARNING Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.089905 | controller | WARNING Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.090405 | controller | WARNING Another version of 'cifmw.general' 1.0.0+1f911626 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.0.0+1f911626 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.090893 | controller | WARNING Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.091365 | controller | WARNING Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.091842 | controller | WARNING Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.092312 | controller | WARNING Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.092784 | controller | WARNING Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.093264 | controller | WARNING Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.093731 | controller | WARNING Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.094197 | controller | WARNING Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.094674 | controller | WARNING Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.095137 | controller | WARNING Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections). 2026-01-29 19:35:17.104429 | controller | INFO Running default > prepare 2026-01-29 19:35:17.735349 | controller | 2026-01-29 19:35:17.735692 | controller | PLAY [Prepare] ***************************************************************** 2026-01-29 19:35:17.735926 | controller | 2026-01-29 19:35:17.736213 | controller | TASK [Gathering Facts] ********************************************************* 2026-01-29 19:35:17.736360 | controller | Thursday 29 January 2026 19:35:17 +0000 (0:00:00.021) 0:00:00.021 ****** 2026-01-29 19:35:18.520956 | controller | ok: [instance] 2026-01-29 19:35:18.539123 | controller | 2026-01-29 19:35:18.539143 | controller | TASK [test_deps : Gather facts if they don't exist] **************************** 2026-01-29 19:35:18.539150 | controller | Thursday 29 January 2026 19:35:18 +0000 (0:00:00.786) 0:00:00.807 ****** 2026-01-29 19:35:18.539159 | controller | skipping: [instance] 2026-01-29 19:35:18.578902 | controller | 2026-01-29 19:35:18.578932 | controller | TASK [test_deps : Gather variables for each operating system] ****************** 2026-01-29 19:35:18.578940 | controller | Thursday 29 January 2026 19:35:18 +0000 (0:00:00.018) 0:00:00.826 ****** 2026-01-29 19:35:18.578958 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml) 2026-01-29 19:35:18.578976 | controller | 2026-01-29 19:35:18.579080 | controller | TASK [test_deps : Detect mirrors file] ***************************************** 2026-01-29 19:35:18.579173 | controller | Thursday 29 January 2026 19:35:18 +0000 (0:00:00.040) 0:00:00.866 ****** 2026-01-29 19:35:18.834981 | controller | ok: [instance] 2026-01-29 19:35:18.835076 | controller | 2026-01-29 19:35:18.835182 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] *********** 2026-01-29 19:35:18.835274 | controller | Thursday 29 January 2026 19:35:18 +0000 (0:00:00.256) 0:00:01.122 ****** 2026-01-29 19:35:19.139031 | controller | ok: [instance] 2026-01-29 19:35:19.139106 | controller | 2026-01-29 19:35:19.139172 | controller | TASK [test_deps : Disable ubi 9 repos] ***************************************** 2026-01-29 19:35:19.139271 | controller | Thursday 29 January 2026 19:35:19 +0000 (0:00:00.303) 0:00:01.425 ****** 2026-01-29 19:35:19.804173 | controller | ok: [instance] => (item=ubi-9-appstream) 2026-01-29 19:35:19.804245 | controller | ok: [instance] => (item=ubi-9-baseos) 2026-01-29 19:35:19.804355 | controller | ok: [instance] => (item=ubi-9-codeready-builder) 2026-01-29 19:35:19.804443 | controller | 2026-01-29 19:35:19.804539 | controller | TASK [Deploy repo-setup] ******************************************************* 2026-01-29 19:35:19.804625 | controller | Thursday 29 January 2026 19:35:19 +0000 (0:00:00.665) 0:00:02.091 ****** 2026-01-29 19:35:19.855267 | controller | 2026-01-29 19:35:19.855415 | controller | TASK [repo_setup : Ensure directories are present] ***************************** 2026-01-29 19:35:19.855550 | controller | Thursday 29 January 2026 19:35:19 +0000 (0:00:00.051) 0:00:02.142 ****** 2026-01-29 19:35:20.343775 | controller | changed: [instance] => (item=tmp) 2026-01-29 19:35:20.343829 | controller | changed: [instance] => (item=artifacts/repositories) 2026-01-29 19:35:20.343914 | controller | changed: [instance] => (item=venv/repo_setup) 2026-01-29 19:35:20.343996 | controller | 2026-01-29 19:35:20.344097 | controller | TASK [repo_setup : Make sure git-core package is installed] ******************** 2026-01-29 19:35:20.344203 | controller | Thursday 29 January 2026 19:35:20 +0000 (0:00:00.488) 0:00:02.631 ****** 2026-01-29 19:35:21.090490 | controller | ok: [instance] 2026-01-29 19:35:21.090535 | controller | 2026-01-29 19:35:21.090594 | controller | TASK [repo_setup : Get repo-setup repository] ********************************** 2026-01-29 19:35:21.090689 | controller | Thursday 29 January 2026 19:35:21 +0000 (0:00:00.746) 0:00:03.377 ****** 2026-01-29 19:35:22.118210 | controller | changed: [instance] 2026-01-29 19:35:29.505242 | controller | 2026-01-29 19:35:29.505283 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************ 2026-01-29 19:35:29.505292 | controller | Thursday 29 January 2026 19:35:22 +0000 (0:00:01.027) 0:00:04.404 ****** 2026-01-29 19:35:29.505302 | controller | changed: [instance] 2026-01-29 19:35:30.164789 | controller | 2026-01-29 19:35:30.164823 | controller | TASK [repo_setup : Install repo-setup package] ********************************* 2026-01-29 19:35:30.164831 | controller | Thursday 29 January 2026 19:35:29 +0000 (0:00:07.387) 0:00:11.791 ****** 2026-01-29 19:35:30.164841 | controller | changed: [instance] 2026-01-29 19:35:30.186131 | controller | 2026-01-29 19:35:30.186163 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] *** 2026-01-29 19:35:30.186171 | controller | Thursday 29 January 2026 19:35:30 +0000 (0:00:00.659) 0:00:12.451 ****** 2026-01-29 19:35:30.186182 | controller | skipping: [instance] 2026-01-29 19:35:30.186200 | controller | 2026-01-29 19:35:30.186216 | controller | TASK [repo_setup : Run repo-setup] ********************************************* 2026-01-29 19:35:30.186224 | controller | Thursday 29 January 2026 19:35:30 +0000 (0:00:00.021) 0:00:12.473 ****** 2026-01-29 19:35:30.932414 | controller | changed: [instance] 2026-01-29 19:35:30.932463 | controller | 2026-01-29 19:35:30.932558 | controller | TASK [repo_setup : Get component repo] ***************************************** 2026-01-29 19:35:30.932689 | controller | Thursday 29 January 2026 19:35:30 +0000 (0:00:00.746) 0:00:13.219 ****** 2026-01-29 19:35:30.968887 | controller | skipping: [instance] 2026-01-29 19:35:31.003102 | controller | 2026-01-29 19:35:31.003122 | controller | TASK [repo_setup : Rename component repo] ************************************** 2026-01-29 19:35:31.003132 | controller | Thursday 29 January 2026 19:35:30 +0000 (0:00:00.036) 0:00:13.255 ****** 2026-01-29 19:35:31.003143 | controller | skipping: [instance] 2026-01-29 19:35:31.003197 | controller | 2026-01-29 19:35:31.003206 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] ******* 2026-01-29 19:35:31.003215 | controller | Thursday 29 January 2026 19:35:31 +0000 (0:00:00.034) 0:00:13.290 ****** 2026-01-29 19:35:31.039505 | controller | skipping: [instance] 2026-01-29 19:35:31.570996 | controller | 2026-01-29 19:35:31.571027 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************ 2026-01-29 19:35:31.571035 | controller | Thursday 29 January 2026 19:35:31 +0000 (0:00:00.036) 0:00:13.326 ****** 2026-01-29 19:35:31.571060 | controller | changed: [instance] 2026-01-29 19:35:31.989281 | controller | 2026-01-29 19:35:31.989309 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] ******************* 2026-01-29 19:35:31.989317 | controller | Thursday 29 January 2026 19:35:31 +0000 (0:00:00.531) 0:00:13.857 ****** 2026-01-29 19:35:31.989327 | controller | changed: [instance] 2026-01-29 19:35:32.015686 | controller | 2026-01-29 19:35:32.015713 | controller | TASK [repo_setup : Dump current-podified hash] ********************************* 2026-01-29 19:35:32.015722 | controller | Thursday 29 January 2026 19:35:31 +0000 (0:00:00.418) 0:00:14.276 ****** 2026-01-29 19:35:32.015734 | controller | skipping: [instance] 2026-01-29 19:35:32.041753 | controller | 2026-01-29 19:35:32.041774 | controller | TASK [repo_setup : Slurp current podified hash] ******************************** 2026-01-29 19:35:32.041783 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.026) 0:00:14.302 ****** 2026-01-29 19:35:32.041797 | controller | skipping: [instance] 2026-01-29 19:35:32.068205 | controller | 2026-01-29 19:35:32.068225 | controller | TASK [repo_setup : Update the value of full_hash] ****************************** 2026-01-29 19:35:32.068234 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.026) 0:00:14.328 ****** 2026-01-29 19:35:32.068255 | controller | skipping: [instance] 2026-01-29 19:35:32.103125 | controller | 2026-01-29 19:35:32.103155 | controller | TASK [repo_setup : Export hashes facts for further use] ************************ 2026-01-29 19:35:32.103163 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.026) 0:00:14.355 ****** 2026-01-29 19:35:32.103173 | controller | ok: [instance] 2026-01-29 19:35:32.103271 | controller | 2026-01-29 19:35:32.103293 | controller | TASK [repo_setup : Create download directory] ********************************** 2026-01-29 19:35:32.103306 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.034) 0:00:14.390 ****** 2026-01-29 19:35:32.128137 | controller | skipping: [instance] 2026-01-29 19:35:32.152811 | controller | 2026-01-29 19:35:32.152827 | controller | TASK [repo_setup : Print the URL to request] *********************************** 2026-01-29 19:35:32.152834 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.024) 0:00:14.415 ****** 2026-01-29 19:35:32.152848 | controller | skipping: [instance] 2026-01-29 19:35:32.177900 | controller | 2026-01-29 19:35:32.177917 | controller | TASK [Download the RPM] ******************************************************** 2026-01-29 19:35:32.177923 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.024) 0:00:14.439 ****** 2026-01-29 19:35:32.177931 | controller | skipping: [instance] 2026-01-29 19:35:32.202950 | controller | 2026-01-29 19:35:32.202967 | controller | TASK [repo_setup : Install RHOS Release tool] ********************************** 2026-01-29 19:35:32.202974 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.024) 0:00:14.464 ****** 2026-01-29 19:35:32.202982 | controller | skipping: [instance] 2026-01-29 19:35:32.227994 | controller | 2026-01-29 19:35:32.228011 | controller | TASK [repo_setup : Get rhos-release tool version] ****************************** 2026-01-29 19:35:32.228018 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.025) 0:00:14.489 ****** 2026-01-29 19:35:32.228027 | controller | skipping: [instance] 2026-01-29 19:35:32.264822 | controller | 2026-01-29 19:35:32.264849 | controller | TASK [repo_setup : Print rhos-release tool version] **************************** 2026-01-29 19:35:32.264856 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.024) 0:00:14.514 ****** 2026-01-29 19:35:32.264865 | controller | skipping: [instance] 2026-01-29 19:35:32.281544 | controller | 2026-01-29 19:35:32.281566 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args_override | default(cifmw_repo_setup_rhos_release_args) }}] *** 2026-01-29 19:35:32.281577 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.036) 0:00:14.551 ****** 2026-01-29 19:35:32.281588 | controller | skipping: [instance] 2026-01-29 19:35:32.454383 | controller | 2026-01-29 19:35:32.454401 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] *************************** 2026-01-29 19:35:32.454408 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.016) 0:00:14.568 ****** 2026-01-29 19:35:32.454417 | controller | ok: [instance] 2026-01-29 19:35:32.647166 | controller | 2026-01-29 19:35:32.647187 | controller | TASK [repo_setup : Use RDO proxy mirrors] ************************************** 2026-01-29 19:35:32.647195 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.172) 0:00:14.741 ****** 2026-01-29 19:35:32.647204 | controller | changed: [instance] 2026-01-29 19:35:32.848178 | controller | 2026-01-29 19:35:32.848197 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] *** 2026-01-29 19:35:32.848205 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.192) 0:00:14.934 ****** 2026-01-29 19:35:32.848213 | controller | changed: [instance] 2026-01-29 19:35:32.868762 | controller | 2026-01-29 19:35:32.868796 | controller | TASK [repo_setup : Check for gating.repo file on content provider] ************* 2026-01-29 19:35:32.868808 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.200) 0:00:15.135 ****** 2026-01-29 19:35:32.868823 | controller | skipping: [instance] 2026-01-29 19:35:32.889131 | controller | 2026-01-29 19:35:32.889164 | controller | TASK [repo_setup : Populate gating repo from content provider ip] ************** 2026-01-29 19:35:32.889172 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.020) 0:00:15.155 ****** 2026-01-29 19:35:32.889183 | controller | skipping: [instance] 2026-01-29 19:35:32.889206 | controller | 2026-01-29 19:35:32.889217 | controller | TASK [repo_setup : Check for DLRN repo at the destination] ********************* 2026-01-29 19:35:32.889325 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.020) 0:00:15.176 ****** 2026-01-29 19:35:32.909725 | controller | skipping: [instance] 2026-01-29 19:35:32.931156 | controller | 2026-01-29 19:35:32.931196 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] *** 2026-01-29 19:35:32.931208 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.020) 0:00:15.196 ****** 2026-01-29 19:35:32.931222 | controller | skipping: [instance] 2026-01-29 19:35:32.931269 | controller | 2026-01-29 19:35:32.931284 | controller | TASK [repo_setup : Check for DLRN component repo] ****************************** 2026-01-29 19:35:32.931295 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.021) 0:00:15.218 ****** 2026-01-29 19:35:32.952127 | controller | skipping: [instance] 2026-01-29 19:35:32.952335 | controller | 2026-01-29 19:35:32.952356 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] *** 2026-01-29 19:35:32.973105 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.021) 0:00:15.239 ****** 2026-01-29 19:35:32.973129 | controller | skipping: [instance] 2026-01-29 19:35:32.973225 | controller | 2026-01-29 19:35:32.973243 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ******** 2026-01-29 19:35:32.973253 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.020) 0:00:15.259 ****** 2026-01-29 19:35:32.989173 | controller | skipping: [instance] 2026-01-29 19:35:33.006896 | controller | 2026-01-29 19:35:33.006916 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ****** 2026-01-29 19:35:33.006924 | controller | Thursday 29 January 2026 19:35:32 +0000 (0:00:00.015) 0:00:15.275 ****** 2026-01-29 19:35:33.006934 | controller | skipping: [instance] 2026-01-29 19:35:33.007115 | controller | 2026-01-29 19:35:33.007279 | controller | TASK [repo_setup : Cleanup existing metadata] ********************************** 2026-01-29 19:35:33.007404 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.018) 0:00:15.294 ****** 2026-01-29 19:35:33.023066 | controller | skipping: [instance] 2026-01-29 19:35:33.023322 | controller | 2026-01-29 19:35:33.023464 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] ********* 2026-01-29 19:35:33.023589 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.015) 0:00:15.310 ****** 2026-01-29 19:35:33.043560 | controller | skipping: [instance] 2026-01-29 19:35:33.043729 | controller | 2026-01-29 19:35:33.043900 | controller | TASK [test_deps : Look for redhat-release rpm] ********************************* 2026-01-29 19:35:33.044082 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.020) 0:00:15.330 ****** 2026-01-29 19:35:33.063067 | controller | skipping: [instance] 2026-01-29 19:35:33.063242 | controller | 2026-01-29 19:35:33.063404 | controller | TASK [test_deps : Remove redhat-release] *************************************** 2026-01-29 19:35:33.063526 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.019) 0:00:15.350 ****** 2026-01-29 19:35:33.081834 | controller | skipping: [instance] 2026-01-29 19:35:33.100125 | controller | 2026-01-29 19:35:33.100151 | controller | TASK [test_deps : Install centos-stream-release] ******************************* 2026-01-29 19:35:33.100158 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.018) 0:00:15.368 ****** 2026-01-29 19:35:33.100167 | controller | skipping: [instance] 2026-01-29 19:35:33.100191 | controller | 2026-01-29 19:35:33.100379 | controller | TASK [test_deps : Install additional packages] ********************************* 2026-01-29 19:35:33.118700 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.018) 0:00:15.387 ****** 2026-01-29 19:35:33.118720 | controller | skipping: [instance] 2026-01-29 19:36:13.163147 | controller | 2026-01-29 19:36:13.163179 | controller | TASK [test_deps : Install selinux python libs] ********************************* 2026-01-29 19:36:13.163188 | controller | Thursday 29 January 2026 19:35:33 +0000 (0:00:00.018) 0:00:15.405 ****** 2026-01-29 19:36:13.163197 | controller | ok: [instance] 2026-01-29 19:36:13.163334 | controller | 2026-01-29 19:36:13.163345 | controller | TASK [test_deps : Install python yaml libs] ************************************ 2026-01-29 19:36:13.163353 | controller | Thursday 29 January 2026 19:36:13 +0000 (0:00:40.044) 0:00:55.449 ****** 2026-01-29 19:36:14.285126 | controller | ok: [instance] 2026-01-29 19:36:14.308861 | controller | 2026-01-29 19:36:14.308878 | controller | TASK [test_deps : Install extra packages] ************************************** 2026-01-29 19:36:14.308885 | controller | Thursday 29 January 2026 19:36:14 +0000 (0:00:01.122) 0:00:56.571 ****** 2026-01-29 19:36:14.308893 | controller | skipping: [instance] 2026-01-29 19:36:14.796846 | controller | 2026-01-29 19:36:14.796874 | controller | TASK [repo_setup : Ensure directories are present] ***************************** 2026-01-29 19:36:14.796883 | controller | Thursday 29 January 2026 19:36:14 +0000 (0:00:00.023) 0:00:56.595 ****** 2026-01-29 19:36:14.796894 | controller | ok: [instance] => (item=tmp) 2026-01-29 19:36:15.897125 | controller | ok: [instance] => (item=artifacts/repositories) 2026-01-29 19:36:15.897159 | controller | ok: [instance] => (item=venv/repo_setup) 2026-01-29 19:36:15.897167 | controller | 2026-01-29 19:36:15.897173 | controller | TASK [repo_setup : Make sure git-core package is installed] ******************** 2026-01-29 19:36:15.897184 | controller | Thursday 29 January 2026 19:36:14 +0000 (0:00:00.487) 0:00:57.082 ****** 2026-01-29 19:36:15.897195 | controller | ok: [instance] 2026-01-29 19:36:15.897214 | controller | 2026-01-29 19:36:15.897308 | controller | TASK [repo_setup : Get repo-setup repository] ********************************** 2026-01-29 19:36:15.897317 | controller | Thursday 29 January 2026 19:36:15 +0000 (0:00:01.101) 0:00:58.184 ****** 2026-01-29 19:36:16.323977 | controller | ok: [instance] 2026-01-29 19:36:16.324027 | controller | 2026-01-29 19:36:16.324159 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************ 2026-01-29 19:36:16.324252 | controller | Thursday 29 January 2026 19:36:16 +0000 (0:00:00.427) 0:00:58.611 ****** 2026-01-29 19:36:17.369716 | controller | ok: [instance] 2026-01-29 19:36:17.369766 | controller | 2026-01-29 19:36:17.369864 | controller | TASK [repo_setup : Install repo-setup package] ********************************* 2026-01-29 19:36:17.369958 | controller | Thursday 29 January 2026 19:36:17 +0000 (0:00:01.045) 0:00:59.656 ****** 2026-01-29 19:36:17.538199 | controller | ok: [instance] 2026-01-29 19:36:17.538255 | controller | 2026-01-29 19:36:17.538358 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] *** 2026-01-29 19:36:17.538449 | controller | Thursday 29 January 2026 19:36:17 +0000 (0:00:00.168) 0:00:59.825 ****** 2026-01-29 19:36:17.558263 | controller | skipping: [instance] 2026-01-29 19:36:17.558324 | controller | 2026-01-29 19:36:17.558431 | controller | TASK [repo_setup : Run repo-setup] ********************************************* 2026-01-29 19:36:17.558523 | controller | Thursday 29 January 2026 19:36:17 +0000 (0:00:00.020) 0:00:59.845 ****** 2026-01-29 19:36:18.292594 | controller | changed: [instance] 2026-01-29 19:36:18.292648 | controller | 2026-01-29 19:36:18.292742 | controller | TASK [repo_setup : Get component repo] ***************************************** 2026-01-29 19:36:18.292838 | controller | Thursday 29 January 2026 19:36:18 +0000 (0:00:00.734) 0:01:00.579 ****** 2026-01-29 19:36:18.320344 | controller | skipping: [instance] 2026-01-29 19:36:18.320412 | controller | 2026-01-29 19:36:18.320511 | controller | TASK [repo_setup : Rename component repo] ************************************** 2026-01-29 19:36:18.320605 | controller | Thursday 29 January 2026 19:36:18 +0000 (0:00:00.027) 0:01:00.607 ****** 2026-01-29 19:36:18.349709 | controller | skipping: [instance] 2026-01-29 19:36:18.349785 | controller | 2026-01-29 19:36:18.349885 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] ******* 2026-01-29 19:36:18.349979 | controller | Thursday 29 January 2026 19:36:18 +0000 (0:00:00.029) 0:01:00.637 ****** 2026-01-29 19:36:18.377209 | controller | skipping: [instance] 2026-01-29 19:36:18.377526 | controller | 2026-01-29 19:36:18.881921 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************ 2026-01-29 19:36:18.881949 | controller | Thursday 29 January 2026 19:36:18 +0000 (0:00:00.027) 0:01:00.664 ****** 2026-01-29 19:36:18.881961 | controller | changed: [instance] 2026-01-29 19:36:19.196031 | controller | 2026-01-29 19:36:19.196075 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] ******************* 2026-01-29 19:36:19.196084 | controller | Thursday 29 January 2026 19:36:18 +0000 (0:00:00.503) 0:01:01.168 ****** 2026-01-29 19:36:19.196093 | controller | changed: [instance] 2026-01-29 19:36:19.214151 | controller | 2026-01-29 19:36:19.214185 | controller | TASK [repo_setup : Dump current-podified hash] ********************************* 2026-01-29 19:36:19.214193 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.314) 0:01:01.482 ****** 2026-01-29 19:36:19.214203 | controller | skipping: [instance] 2026-01-29 19:36:19.214226 | controller | 2026-01-29 19:36:19.214234 | controller | TASK [repo_setup : Slurp current podified hash] ******************************** 2026-01-29 19:36:19.214391 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.018) 0:01:01.501 ****** 2026-01-29 19:36:19.233834 | controller | skipping: [instance] 2026-01-29 19:36:19.251872 | controller | 2026-01-29 19:36:19.251888 | controller | TASK [repo_setup : Update the value of full_hash] ****************************** 2026-01-29 19:36:19.251895 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.019) 0:01:01.520 ****** 2026-01-29 19:36:19.251903 | controller | skipping: [instance] 2026-01-29 19:36:19.278214 | controller | 2026-01-29 19:36:19.278234 | controller | TASK [repo_setup : Export hashes facts for further use] ************************ 2026-01-29 19:36:19.278241 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.018) 0:01:01.538 ****** 2026-01-29 19:36:19.278249 | controller | ok: [instance] 2026-01-29 19:36:19.293709 | controller | 2026-01-29 19:36:19.293724 | controller | TASK [repo_setup : Create download directory] ********************************** 2026-01-29 19:36:19.293731 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.026) 0:01:01.565 ****** 2026-01-29 19:36:19.293739 | controller | skipping: [instance] 2026-01-29 19:36:19.310130 | controller | 2026-01-29 19:36:19.310165 | controller | TASK [repo_setup : Print the URL to request] *********************************** 2026-01-29 19:36:19.310173 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.015) 0:01:01.580 ****** 2026-01-29 19:36:19.310183 | controller | skipping: [instance] 2026-01-29 19:36:19.310206 | controller | 2026-01-29 19:36:19.310214 | controller | TASK [Download the RPM] ******************************************************** 2026-01-29 19:36:19.310310 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.016) 0:01:01.597 ****** 2026-01-29 19:36:19.326963 | controller | skipping: [instance] 2026-01-29 19:36:19.342508 | controller | 2026-01-29 19:36:19.342524 | controller | TASK [repo_setup : Install RHOS Release tool] ********************************** 2026-01-29 19:36:19.342531 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.016) 0:01:01.613 ****** 2026-01-29 19:36:19.342538 | controller | skipping: [instance] 2026-01-29 19:36:19.358675 | controller | 2026-01-29 19:36:19.358689 | controller | TASK [repo_setup : Get rhos-release tool version] ****************************** 2026-01-29 19:36:19.358696 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.015) 0:01:01.629 ****** 2026-01-29 19:36:19.358704 | controller | skipping: [instance] 2026-01-29 19:36:19.376977 | controller | 2026-01-29 19:36:19.376993 | controller | TASK [repo_setup : Print rhos-release tool version] **************************** 2026-01-29 19:36:19.376999 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.015) 0:01:01.645 ****** 2026-01-29 19:36:19.377007 | controller | skipping: [instance] 2026-01-29 19:36:19.392979 | controller | 2026-01-29 19:36:19.393001 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args_override | default(cifmw_repo_setup_rhos_release_args) }}] *** 2026-01-29 19:36:19.393011 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.018) 0:01:01.664 ****** 2026-01-29 19:36:19.393022 | controller | skipping: [instance] 2026-01-29 19:36:19.562321 | controller | 2026-01-29 19:36:19.562342 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] *************************** 2026-01-29 19:36:19.562350 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.015) 0:01:01.679 ****** 2026-01-29 19:36:19.562358 | controller | ok: [instance] 2026-01-29 19:36:19.747790 | controller | 2026-01-29 19:36:19.747809 | controller | TASK [repo_setup : Use RDO proxy mirrors] ************************************** 2026-01-29 19:36:19.747816 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.169) 0:01:01.849 ****** 2026-01-29 19:36:19.747825 | controller | changed: [instance] 2026-01-29 19:36:19.962906 | controller | 2026-01-29 19:36:19.962959 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] *** 2026-01-29 19:36:19.962969 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.185) 0:01:02.034 ****** 2026-01-29 19:36:19.962983 | controller | changed: [instance] 2026-01-29 19:36:19.983379 | controller | 2026-01-29 19:36:19.983398 | controller | TASK [repo_setup : Check for gating.repo file on content provider] ************* 2026-01-29 19:36:19.983407 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.214) 0:01:02.249 ****** 2026-01-29 19:36:19.983417 | controller | skipping: [instance] 2026-01-29 19:36:20.006165 | controller | 2026-01-29 19:36:20.006214 | controller | TASK [repo_setup : Populate gating repo from content provider ip] ************** 2026-01-29 19:36:20.006223 | controller | Thursday 29 January 2026 19:36:19 +0000 (0:00:00.021) 0:01:02.270 ****** 2026-01-29 19:36:20.006237 | controller | skipping: [instance] 2026-01-29 19:36:20.029564 | controller | 2026-01-29 19:36:20.029591 | controller | TASK [repo_setup : Check for DLRN repo at the destination] ********************* 2026-01-29 19:36:20.029599 | controller | Thursday 29 January 2026 19:36:20 +0000 (0:00:00.022) 0:01:02.293 ****** 2026-01-29 19:36:20.029633 | controller | skipping: [instance] 2026-01-29 19:36:20.053825 | controller | 2026-01-29 19:36:20.053848 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] *** 2026-01-29 19:36:20.053858 | controller | Thursday 29 January 2026 19:36:20 +0000 (0:00:00.023) 0:01:02.316 ****** 2026-01-29 19:36:20.053870 | controller | skipping: [instance] 2026-01-29 19:36:20.054086 | controller | 2026-01-29 19:36:20.054303 | controller | TASK [repo_setup : Check for DLRN component repo] ****************************** 2026-01-29 19:36:20.054490 | controller | Thursday 29 January 2026 19:36:20 +0000 (0:00:00.024) 0:01:02.340 ****** 2026-01-29 19:36:20.108964 | controller | skipping: [instance] 2026-01-29 19:36:20.109152 | controller | 2026-01-29 19:36:20.109316 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] *** 2026-01-29 19:36:20.109467 | controller | Thursday 29 January 2026 19:36:20 +0000 (0:00:00.055) 0:01:02.396 ****** 2026-01-29 19:36:20.133516 | controller | skipping: [instance] 2026-01-29 19:36:20.133725 | controller | 2026-01-29 19:36:20.133872 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ******** 2026-01-29 19:36:20.133995 | controller | Thursday 29 January 2026 19:36:20 +0000 (0:00:00.024) 0:01:02.420 ****** 2026-01-29 19:36:20.395653 | controller | ok: [instance] 2026-01-29 19:36:21.876128 | controller | 2026-01-29 19:36:21.876160 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ****** 2026-01-29 19:36:21.876168 | controller | Thursday 29 January 2026 19:36:20 +0000 (0:00:00.261) 0:01:02.682 ****** 2026-01-29 19:36:21.876178 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos-addons.repo) 2026-01-29 19:36:21.876199 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos.repo) 2026-01-29 19:36:21.876207 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean.repo) 2026-01-29 19:36:21.876855 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean-master-testing.repo) 2026-01-29 19:36:22.273110 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-highavailability.repo) 2026-01-29 19:36:22.273140 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-powertools.repo) 2026-01-29 19:36:22.273148 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-appstream.repo) 2026-01-29 19:36:22.273154 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-baseos.repo) 2026-01-29 19:36:22.273159 | controller | 2026-01-29 19:36:22.273165 | controller | TASK [repo_setup : Cleanup existing metadata] ********************************** 2026-01-29 19:36:22.273175 | controller | Thursday 29 January 2026 19:36:21 +0000 (0:00:01.480) 0:01:04.162 ****** 2026-01-29 19:36:22.273184 | controller | changed: [instance] 2026-01-29 19:36:22.273206 | controller | 2026-01-29 19:36:22.273369 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] ********* 2026-01-29 19:36:22.469396 | controller | Thursday 29 January 2026 19:36:22 +0000 (0:00:00.397) 0:01:04.560 ****** 2026-01-29 19:36:22.469430 | controller | changed: [instance] 2026-01-29 19:36:22.469457 | controller | 2026-01-29 19:36:22.469554 | controller | PLAY RECAP ********************************************************************* 2026-01-29 19:36:22.469659 | controller | instance : ok=35 changed=17 unreachable=0 failed=0 skipped=50 rescued=0 ignored=0 2026-01-29 19:36:22.469744 | controller | 2026-01-29 19:36:22.469846 | controller | Thursday 29 January 2026 19:36:22 +0000 (0:00:00.196) 0:01:04.756 ****** 2026-01-29 19:36:22.469927 | controller | =============================================================================== 2026-01-29 19:36:22.470012 | controller | test_deps : Install selinux python libs -------------------------------- 40.04s 2026-01-29 19:36:22.470120 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.39s 2026-01-29 19:36:22.470204 | controller | repo_setup : Remove existing repos from /etc/yum.repos.d directory ------ 1.48s 2026-01-29 19:36:22.470288 | controller | test_deps : Install python yaml libs ------------------------------------ 1.12s 2026-01-29 19:36:22.470372 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.10s 2026-01-29 19:36:22.470457 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.05s 2026-01-29 19:36:22.470538 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.03s 2026-01-29 19:36:22.470634 | controller | Gathering Facts --------------------------------------------------------- 0.79s 2026-01-29 19:36:22.470722 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.75s 2026-01-29 19:36:22.470803 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.75s 2026-01-29 19:36:22.470884 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.73s 2026-01-29 19:36:22.470967 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.67s 2026-01-29 19:36:22.471067 | controller | repo_setup : Install repo-setup package --------------------------------- 0.66s 2026-01-29 19:36:22.471662 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s 2026-01-29 19:36:22.526829 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.50s 2026-01-29 19:36:22.526861 | controller | repo_setup : Ensure directories are present ----------------------------- 0.49s 2026-01-29 19:36:22.526868 | controller | repo_setup : Ensure directories are present ----------------------------- 0.49s 2026-01-29 19:36:22.526873 | controller | repo_setup : Get repo-setup repository ---------------------------------- 0.43s 2026-01-29 19:36:22.526879 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.42s 2026-01-29 19:36:22.526884 | controller | repo_setup : Cleanup existing metadata ---------------------------------- 0.40s 2026-01-29 19:36:22.526894 | controller | INFO Running default > converge 2026-01-29 19:36:22.958106 | controller | 2026-01-29 19:36:23.670066 | controller | PLAY [Converge] **************************************************************** 2026-01-29 19:36:23.670095 | controller | 2026-01-29 19:36:23.670103 | controller | TASK [Gathering Facts] ********************************************************* 2026-01-29 19:36:23.670108 | controller | Thursday 29 January 2026 19:36:22 +0000 (0:00:00.031) 0:00:00.031 ****** 2026-01-29 19:36:23.670118 | controller | ok: [instance] 2026-01-29 19:36:24.900016 | controller | 2026-01-29 19:36:24.900058 | controller | TASK [Clone neutron-tempest-plugin] ******************************************** 2026-01-29 19:36:24.900069 | controller | Thursday 29 January 2026 19:36:23 +0000 (0:00:00.712) 0:00:00.743 ****** 2026-01-29 19:36:24.900083 | controller | changed: [instance] 2026-01-29 19:36:24.921621 | controller | 2026-01-29 19:36:24.921655 | controller | TASK [Set cifmw_bop_openstack_project_path] ************************************ 2026-01-29 19:36:24.921664 | controller | Thursday 29 January 2026 19:36:24 +0000 (0:00:01.229) 0:00:01.973 ****** 2026-01-29 19:36:24.921674 | controller | ok: [instance] 2026-01-29 19:36:50.874723 | controller | 2026-01-29 19:36:50.874762 | controller | TASK [build_openstack_packages : Install Mock from DLRN repos] ***************** 2026-01-29 19:36:50.874771 | controller | Thursday 29 January 2026 19:36:24 +0000 (0:00:00.021) 0:00:01.995 ****** 2026-01-29 19:36:50.874782 | controller | changed: [instance] 2026-01-29 19:36:52.213715 | controller | 2026-01-29 19:36:52.213758 | controller | TASK [build_openstack_packages : Ensure DLRN package dependencies] ************* 2026-01-29 19:36:52.213767 | controller | Thursday 29 January 2026 19:36:50 +0000 (0:00:25.952) 0:00:27.948 ****** 2026-01-29 19:36:52.213777 | controller | changed: [instance] 2026-01-29 19:36:52.525122 | controller | 2026-01-29 19:36:52.525153 | controller | TASK [build_openstack_packages : Create mock group] **************************** 2026-01-29 19:36:52.525161 | controller | Thursday 29 January 2026 19:36:52 +0000 (0:00:01.338) 0:00:29.286 ****** 2026-01-29 19:36:52.525172 | controller | ok: [instance] 2026-01-29 19:36:52.525192 | controller | 2026-01-29 19:36:52.525201 | controller | TASK [build_openstack_packages : Add user to mock group] *********************** 2026-01-29 19:36:52.525273 | controller | Thursday 29 January 2026 19:36:52 +0000 (0:00:00.311) 0:00:29.598 ****** 2026-01-29 19:36:52.882871 | controller | changed: [instance] 2026-01-29 19:36:53.142722 | controller | 2026-01-29 19:36:53.142763 | controller | TASK [build_openstack_packages : Ensure DLRN dir is present] ******************* 2026-01-29 19:36:53.142771 | controller | Thursday 29 January 2026 19:36:52 +0000 (0:00:00.357) 0:00:29.956 ****** 2026-01-29 19:36:53.142785 | controller | changed: [instance] 2026-01-29 19:36:53.402686 | controller | 2026-01-29 19:36:53.402716 | controller | TASK [build_openstack_packages : Remove data files from previous runs] ********* 2026-01-29 19:36:53.402724 | controller | Thursday 29 January 2026 19:36:53 +0000 (0:00:00.259) 0:00:30.216 ****** 2026-01-29 19:36:53.402747 | controller | ok: [instance] 2026-01-29 19:36:57.051154 | controller | 2026-01-29 19:36:57.051186 | controller | TASK [build_openstack_packages : Create dlrn-venv] ***************************** 2026-01-29 19:36:57.051193 | controller | Thursday 29 January 2026 19:36:53 +0000 (0:00:00.259) 0:00:30.476 ****** 2026-01-29 19:36:57.051203 | controller | changed: [instance] 2026-01-29 19:36:57.051380 | controller | 2026-01-29 19:36:57.051413 | controller | TASK [build_openstack_packages : Fetch DLRN from source] *********************** 2026-01-29 19:36:57.077827 | controller | Thursday 29 January 2026 19:36:57 +0000 (0:00:03.648) 0:00:34.124 ****** 2026-01-29 19:36:57.077847 | controller | skipping: [instance] 2026-01-29 19:36:57.105809 | controller | 2026-01-29 19:36:57.105832 | controller | TASK [build_openstack_packages : Install DLRN requirements] ******************** 2026-01-29 19:36:57.105842 | controller | Thursday 29 January 2026 19:36:57 +0000 (0:00:00.026) 0:00:34.151 ****** 2026-01-29 19:36:57.105853 | controller | skipping: [instance] 2026-01-29 19:36:57.129695 | controller | 2026-01-29 19:36:57.129718 | controller | TASK [build_openstack_packages : Install DLRN from source] ********************* 2026-01-29 19:36:57.129744 | controller | Thursday 29 January 2026 19:36:57 +0000 (0:00:00.027) 0:00:34.179 ****** 2026-01-29 19:36:57.129757 | controller | skipping: [instance] 2026-01-29 19:37:11.581105 | controller | 2026-01-29 19:37:11.581139 | controller | TASK [build_openstack_packages : Install DLRN and rdopkg from pip] ************* 2026-01-29 19:37:11.581147 | controller | Thursday 29 January 2026 19:36:57 +0000 (0:00:00.024) 0:00:34.203 ****** 2026-01-29 19:37:11.581157 | controller | changed: [instance] 2026-01-29 19:37:12.097864 | controller | 2026-01-29 19:37:12.097893 | controller | TASK [build_openstack_packages : Drop in the templated version of projects.ini] *** 2026-01-29 19:37:12.097901 | controller | Thursday 29 January 2026 19:37:11 +0000 (0:00:14.451) 0:00:48.654 ****** 2026-01-29 19:37:12.097911 | controller | changed: [instance] 2026-01-29 19:37:12.433807 | controller | 2026-01-29 19:37:12.433831 | controller | TASK [build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir] *** 2026-01-29 19:37:12.433839 | controller | Thursday 29 January 2026 19:37:12 +0000 (0:00:00.516) 0:00:49.171 ****** 2026-01-29 19:37:12.433848 | controller | changed: [instance] 2026-01-29 19:37:15.157060 | controller | 2026-01-29 19:37:15.157092 | controller | TASK [build_openstack_packages : Fetch local rdoinfo copy] ********************* 2026-01-29 19:37:15.157100 | controller | Thursday 29 January 2026 19:37:12 +0000 (0:00:00.336) 0:00:49.507 ****** 2026-01-29 19:37:15.157110 | controller | changed: [instance] 2026-01-29 19:37:15.177946 | controller | 2026-01-29 19:37:15.177979 | controller | TASK [build_openstack_packages : Downstream related tasks] ********************* 2026-01-29 19:37:15.177992 | controller | Thursday 29 January 2026 19:37:15 +0000 (0:00:02.722) 0:00:52.230 ****** 2026-01-29 19:37:15.178016 | controller | skipping: [instance] 2026-01-29 19:37:15.460765 | controller | 2026-01-29 19:37:15.460784 | controller | TASK [build_openstack_packages : Find all the repos files] ********************* 2026-01-29 19:37:15.460791 | controller | Thursday 29 January 2026 19:37:15 +0000 (0:00:00.020) 0:00:52.251 ****** 2026-01-29 19:37:15.460799 | controller | ok: [instance] 2026-01-29 19:37:15.663079 | controller | 2026-01-29 19:37:15.663101 | controller | TASK [build_openstack_packages : Create local mock config] ********************* 2026-01-29 19:37:15.663109 | controller | Thursday 29 January 2026 19:37:15 +0000 (0:00:00.283) 0:00:52.534 ****** 2026-01-29 19:37:15.663117 | controller | changed: [instance] 2026-01-29 19:37:15.857141 | controller | 2026-01-29 19:37:15.857162 | controller | TASK [build_openstack_packages : Remove last """ from local mock config] ******* 2026-01-29 19:37:15.857170 | controller | Thursday 29 January 2026 19:37:15 +0000 (0:00:00.202) 0:00:52.736 ****** 2026-01-29 19:37:15.857178 | controller | changed: [instance] 2026-01-29 19:37:15.923238 | controller | 2026-01-29 19:37:15.923273 | controller | TASK [build_openstack_packages : Append repos into mock local config] ********** 2026-01-29 19:37:15.923292 | controller | Thursday 29 January 2026 19:37:15 +0000 (0:00:00.194) 0:00:52.930 ****** 2026-01-29 19:37:15.923312 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/delorean.repo) 2026-01-29 19:37:15.923345 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/delorean-antelope-testing.repo) 2026-01-29 19:37:15.923357 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-highavailability.repo) 2026-01-29 19:37:15.923366 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-powertools.repo) 2026-01-29 19:37:15.923376 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-appstream.repo) 2026-01-29 19:37:15.923651 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-baseos.repo) 2026-01-29 19:37:15.923674 | controller | 2026-01-29 19:37:16.160989 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2026-01-29 19:37:16.161019 | controller | Thursday 29 January 2026 19:37:15 +0000 (0:00:00.065) 0:00:52.996 ****** 2026-01-29 19:37:16.161031 | controller | ok: [instance] 2026-01-29 19:37:16.196149 | controller | 2026-01-29 19:37:16.196169 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2026-01-29 19:37:16.196176 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.238) 0:00:53.234 ****** 2026-01-29 19:37:16.196185 | controller | ok: [instance] 2026-01-29 19:37:16.362772 | controller | 2026-01-29 19:37:16.362790 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2026-01-29 19:37:16.362797 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.035) 0:00:53.269 ****** 2026-01-29 19:37:16.362806 | controller | ok: [instance] 2026-01-29 19:37:16.396813 | controller | 2026-01-29 19:37:16.396831 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2026-01-29 19:37:16.396839 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.166) 0:00:53.436 ****** 2026-01-29 19:37:16.396848 | controller | ok: [instance] 2026-01-29 19:37:16.556035 | controller | 2026-01-29 19:37:16.556073 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2026-01-29 19:37:16.556081 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.034) 0:00:53.470 ****** 2026-01-29 19:37:16.556091 | controller | ok: [instance] 2026-01-29 19:37:16.590752 | controller | 2026-01-29 19:37:16.590771 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2026-01-29 19:37:16.590788 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.159) 0:00:53.629 ****** 2026-01-29 19:37:16.590798 | controller | ok: [instance] 2026-01-29 19:37:16.753765 | controller | 2026-01-29 19:37:16.753792 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2026-01-29 19:37:16.753800 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.034) 0:00:53.664 ****** 2026-01-29 19:37:16.753809 | controller | ok: [instance] 2026-01-29 19:37:16.783581 | controller | 2026-01-29 19:37:16.783602 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2026-01-29 19:37:16.783618 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.163) 0:00:53.827 ****** 2026-01-29 19:37:16.783630 | controller | ok: [instance] 2026-01-29 19:37:16.942104 | controller | 2026-01-29 19:37:16.942128 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2026-01-29 19:37:16.942136 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.029) 0:00:53.857 ****** 2026-01-29 19:37:16.942145 | controller | ok: [instance] 2026-01-29 19:37:16.942165 | controller | 2026-01-29 19:37:16.942172 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2026-01-29 19:37:16.942225 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.158) 0:00:54.015 ****** 2026-01-29 19:37:16.972134 | controller | ok: [instance] 2026-01-29 19:37:16.972342 | controller | 2026-01-29 19:37:16.972366 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2026-01-29 19:37:17.132565 | controller | Thursday 29 January 2026 19:37:16 +0000 (0:00:00.030) 0:00:54.045 ****** 2026-01-29 19:37:17.132596 | controller | ok: [instance] 2026-01-29 19:37:17.162095 | controller | 2026-01-29 19:37:17.162133 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2026-01-29 19:37:17.162147 | controller | Thursday 29 January 2026 19:37:17 +0000 (0:00:00.160) 0:00:54.206 ****** 2026-01-29 19:37:17.162159 | controller | ok: [instance] 2026-01-29 19:37:17.436918 | controller | 2026-01-29 19:37:17.436950 | controller | TASK [build_openstack_packages : Append repo_content ending with """ in mock local config at last] *** 2026-01-29 19:37:17.436958 | controller | Thursday 29 January 2026 19:37:17 +0000 (0:00:00.029) 0:00:54.235 ****** 2026-01-29 19:37:17.436968 | controller | changed: [instance] 2026-01-29 19:37:19.191095 | controller | 2026-01-29 19:37:19.191124 | controller | TASK [build_openstack_packages : Check loop devices stat] ********************** 2026-01-29 19:37:19.191131 | controller | Thursday 29 January 2026 19:37:17 +0000 (0:00:00.274) 0:00:54.510 ****** 2026-01-29 19:37:19.191142 | controller | ok: [instance] => (item=0) 2026-01-29 19:37:19.223932 | controller | ok: [instance] => (item=1) 2026-01-29 19:37:19.223957 | controller | ok: [instance] => (item=2) 2026-01-29 19:37:19.223965 | controller | ok: [instance] => (item=3) 2026-01-29 19:37:19.223971 | controller | ok: [instance] => (item=4) 2026-01-29 19:37:19.223977 | controller | ok: [instance] => (item=5) 2026-01-29 19:37:19.223984 | controller | ok: [instance] => (item=6) 2026-01-29 19:37:19.223990 | controller | ok: [instance] => (item=7) 2026-01-29 19:37:19.223996 | controller | ok: [instance] => (item=8) 2026-01-29 19:37:19.224002 | controller | ok: [instance] => (item=9) 2026-01-29 19:37:19.224008 | controller | ok: [instance] => (item=10) 2026-01-29 19:37:19.224015 | controller | ok: [instance] => (item=11) 2026-01-29 19:37:19.224021 | controller | 2026-01-29 19:37:19.224028 | controller | TASK [build_openstack_packages : Set loop_devices_absent fact] ***************** 2026-01-29 19:37:19.224034 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:01.753) 0:00:56.263 ****** 2026-01-29 19:37:19.224064 | controller | ok: [instance] 2026-01-29 19:37:19.255217 | controller | 2026-01-29 19:37:19.255238 | controller | TASK [build_openstack_packages : Parse Zuul changes] *************************** 2026-01-29 19:37:19.255246 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.033) 0:00:56.297 ****** 2026-01-29 19:37:19.255258 | controller | skipping: [instance] 2026-01-29 19:37:19.273262 | controller | 2026-01-29 19:37:19.273280 | controller | TASK [build_openstack_packages : Print Zuul change list] *********************** 2026-01-29 19:37:19.273287 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.031) 0:00:56.328 ****** 2026-01-29 19:37:19.273296 | controller | ok: [instance] => 2026-01-29 19:37:19.286252 | controller | cifmw_bop_change_list: [] 2026-01-29 19:37:19.286270 | controller | 2026-01-29 19:37:19.286277 | controller | TASK [build_openstack_packages : Build DLRN packages from zuul changes] ******** 2026-01-29 19:37:19.286284 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.018) 0:00:56.346 ****** 2026-01-29 19:37:19.286295 | controller | skipping: [instance] 2026-01-29 19:37:19.286441 | controller | 2026-01-29 19:37:19.286594 | controller | TASK [build_openstack_packages : Build DLRN packages from Local change] ******** 2026-01-29 19:37:19.286757 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.013) 0:00:56.360 ****** 2026-01-29 19:37:19.333841 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/run_dlrn.yml for instance 2026-01-29 19:37:19.334004 | controller | 2026-01-29 19:37:19.334186 | controller | TASK [build_openstack_packages : Set proper branch name for stable opendev branches] *** 2026-01-29 19:37:19.334343 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.047) 0:00:56.407 ****** 2026-01-29 19:37:19.358336 | controller | skipping: [instance] 2026-01-29 19:37:19.358487 | controller | 2026-01-29 19:37:19.358644 | controller | TASK [build_openstack_packages : Set proper branch name for non-stable branches] *** 2026-01-29 19:37:19.358811 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.024) 0:00:56.432 ****** 2026-01-29 19:37:19.387816 | controller | ok: [instance] 2026-01-29 19:37:19.387963 | controller | 2026-01-29 19:37:19.388164 | controller | TASK [build_openstack_packages : Set RDO release for master openstack release] *** 2026-01-29 19:37:19.388322 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.029) 0:00:56.461 ****** 2026-01-29 19:37:19.407416 | controller | ok: [instance] 2026-01-29 19:37:19.423079 | controller | 2026-01-29 19:37:19.423099 | controller | TASK [build_openstack_packages : Set RDO release for non-master openstack release] *** 2026-01-29 19:37:19.423107 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.019) 0:00:56.481 ****** 2026-01-29 19:37:19.423117 | controller | skipping: [instance] 2026-01-29 19:37:19.440164 | controller | 2026-01-29 19:37:19.440202 | controller | TASK [build_openstack_packages : Make sure /usr/share/rhn/RHN-ORG-TRUSTED-SSL-CERT exists (RHEL)] *** 2026-01-29 19:37:19.440212 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.015) 0:00:56.496 ****** 2026-01-29 19:37:19.440224 | controller | skipping: [instance] 2026-01-29 19:37:19.440258 | controller | 2026-01-29 19:37:19.440268 | controller | TASK [build_openstack_packages : Override projects.ini settings] *************** 2026-01-29 19:37:19.917143 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.017) 0:00:56.514 ****** 2026-01-29 19:37:19.917178 | controller | ok: [instance] => (item={'regexp': 'baseurl=.*', 'line': 'baseurl=https://trunk.rdoproject.org/centos9-master'}) 2026-01-29 19:37:19.917201 | controller | ok: [instance] => (item={'regexp': 'distro=.*', 'line': 'distro=rpm-master'}) 2026-01-29 19:37:19.917207 | controller | ok: [instance] => (item={'regexp': 'source=.*', 'line': 'source=master'}) 2026-01-29 19:37:19.917213 | controller | 2026-01-29 19:37:19.917220 | controller | TASK [build_openstack_packages : Map project name to DLRN project name] ******** 2026-01-29 19:37:19.917237 | controller | Thursday 29 January 2026 19:37:19 +0000 (0:00:00.476) 0:00:56.990 ****** 2026-01-29 19:37:23.289352 | controller | ok: [instance] 2026-01-29 19:37:23.527143 | controller | 2026-01-29 19:37:23.527174 | controller | TASK [build_openstack_packages : Create data directory if doesn't exist yet] *** 2026-01-29 19:37:23.527183 | controller | Thursday 29 January 2026 19:37:23 +0000 (0:00:03.371) 0:01:00.362 ****** 2026-01-29 19:37:23.527193 | controller | changed: [instance] 2026-01-29 19:37:23.527268 | controller | 2026-01-29 19:37:23.527278 | controller | TASK [build_openstack_packages : Check for existing python-neutron-tests-tempest] *** 2026-01-29 19:37:23.527286 | controller | Thursday 29 January 2026 19:37:23 +0000 (0:00:00.237) 0:01:00.600 ****** 2026-01-29 19:37:23.725924 | controller | ok: [instance] 2026-01-29 19:37:24.295107 | controller | 2026-01-29 19:37:24.295136 | controller | TASK [build_openstack_packages : Sync python-neutron-tests-tempest from local repo] *** 2026-01-29 19:37:24.295144 | controller | Thursday 29 January 2026 19:37:23 +0000 (0:00:00.198) 0:01:00.798 ****** 2026-01-29 19:37:24.295154 | controller | changed: [instance] 2026-01-29 19:37:24.332135 | controller | 2026-01-29 19:37:24.332162 | controller | TASK [build_openstack_packages : Symlink python-neutron-tests-tempest from Zuul clonned repos for upstream] *** 2026-01-29 19:37:24.332173 | controller | Thursday 29 January 2026 19:37:24 +0000 (0:00:00.569) 0:01:01.368 ****** 2026-01-29 19:37:24.332185 | controller | skipping: [instance] 2026-01-29 19:37:24.332284 | controller | 2026-01-29 19:37:24.332305 | controller | TASK [build_openstack_packages : Update packages.yml to use zuul repo for python-neutron-tests-tempest] *** 2026-01-29 19:37:24.332319 | controller | Thursday 29 January 2026 19:37:24 +0000 (0:00:00.037) 0:01:01.405 ****** 2026-01-29 19:37:24.367102 | controller | skipping: [instance] 2026-01-29 19:37:24.367415 | controller | 2026-01-29 19:37:24.592003 | controller | TASK [build_openstack_packages : Find the last commit from the clonned repo] *** 2026-01-29 19:37:24.592027 | controller | Thursday 29 January 2026 19:37:24 +0000 (0:00:00.035) 0:01:01.440 ****** 2026-01-29 19:37:24.592037 | controller | changed: [instance] 2026-01-29 19:37:24.619233 | controller | 2026-01-29 19:37:24.619292 | controller | TASK [build_openstack_packages : Print the last commit of the git repo] ******** 2026-01-29 19:37:24.619303 | controller | Thursday 29 January 2026 19:37:24 +0000 (0:00:00.224) 0:01:01.665 ****** 2026-01-29 19:37:24.619318 | controller | ok: [instance] => 2026-01-29 19:37:24.619339 | controller | _commit.stdout: ae235c460f0136d0a109cd1e15d8585a7a667923 2026-01-29 19:37:24.619349 | controller | 2026-01-29 19:37:24.619395 | controller | TASK [build_openstack_packages : Ensure distgit repo is absent, DLRN takes care of cloning based on config] *** 2026-01-29 19:37:24.619407 | controller | Thursday 29 January 2026 19:37:24 +0000 (0:00:00.027) 0:01:01.692 ****** 2026-01-29 19:37:24.804638 | controller | ok: [instance] 2026-01-29 19:37:25.164509 | controller | 2026-01-29 19:37:25.164544 | controller | TASK [build_openstack_packages : Generate DLRN Script] ************************* 2026-01-29 19:37:25.164554 | controller | Thursday 29 January 2026 19:37:24 +0000 (0:00:00.184) 0:01:01.877 ****** 2026-01-29 19:37:25.164566 | controller | changed: [instance] 2026-01-29 19:37:25.209463 | controller | 2026-01-29 19:37:25.209481 | controller | TASK [build_openstack_packages : Print info about building] ******************** 2026-01-29 19:37:25.209488 | controller | Thursday 29 January 2026 19:37:25 +0000 (0:00:00.359) 0:01:02.237 ****** 2026-01-29 19:37:25.209496 | controller | ok: [instance] => 2026-01-29 19:37:25.420091 | controller | msg: Building change for python-neutron-tests-tempest 2026-01-29 19:37:25.420122 | controller | 2026-01-29 19:37:25.420130 | controller | TASK [build_openstack_packages : Ensure logs dir exists] *********************** 2026-01-29 19:37:25.420136 | controller | Thursday 29 January 2026 19:37:25 +0000 (0:00:00.045) 0:01:02.282 ****** 2026-01-29 19:37:25.420145 | controller | ok: [instance] 2026-01-29 19:42:19.490716 | controller | 2026-01-29 19:42:19.490750 | controller | TASK [build_openstack_packages : Run DLRN] ************************************* 2026-01-29 19:42:19.490758 | controller | Thursday 29 January 2026 19:37:25 +0000 (0:00:00.210) 0:01:02.493 ****** 2026-01-29 19:42:19.490768 | controller | fatal: [instance]: FAILED! => changed=true 2026-01-29 19:42:19.490791 | controller | cmd: |- 2026-01-29 19:42:19.490797 | controller | set -o pipefail && /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/logs/run_dlrn.sh 2>&1 | awk '{ print strftime("%Y-%m-%d %H:%M:%S |"), $0; fflush(); }' >> /home/zuul/ci-framework-data/logs/dlrn.log 2026-01-29 19:42:19.490803 | controller | delta: '0:04:53.890617' 2026-01-29 19:42:19.490808 | controller | end: '2026-01-29 19:42:19.468202' 2026-01-29 19:42:19.490813 | controller | msg: non-zero return code 2026-01-29 19:42:19.490818 | controller | rc: 1 2026-01-29 19:42:19.490824 | controller | start: '2026-01-29 19:37:25.577585' 2026-01-29 19:42:19.490829 | controller | stderr: '' 2026-01-29 19:42:19.490834 | controller | stderr_lines: 2026-01-29 19:42:19.490840 | controller | stdout: '' 2026-01-29 19:42:19.490861 | controller | stdout_lines: 2026-01-29 19:42:19.495032 | controller | 2026-01-29 19:42:19.670237 | controller | TASK [build_openstack_packages : Copy DLRN artifacts] ************************** 2026-01-29 19:42:19.670263 | controller | Thursday 29 January 2026 19:42:19 +0000 (0:04:54.075) 0:05:56.568 ****** 2026-01-29 19:42:19.670274 | controller | changed: [instance] 2026-01-29 19:42:19.685209 | controller | 2026-01-29 19:42:19.685224 | controller | TASK [build_openstack_packages : Fail the execution] *************************** 2026-01-29 19:42:19.685230 | controller | Thursday 29 January 2026 19:42:19 +0000 (0:00:00.174) 0:05:56.743 ****** 2026-01-29 19:42:19.685238 | controller | fatal: [instance]: FAILED! => changed=false 2026-01-29 19:42:19.690125 | controller | msg: DLRN run failed 2026-01-29 19:42:19.690159 | controller | 2026-01-29 19:42:19.739744 | controller | PLAY RECAP ********************************************************************* 2026-01-29 19:42:19.739764 | controller | instance : ok=54 changed=18 unreachable=0 failed=1 skipped=11 rescued=1 ignored=0 2026-01-29 19:42:19.739772 | controller | 2026-01-29 19:42:19.739786 | controller | Thursday 29 January 2026 19:42:19 +0000 (0:00:00.017) 0:05:56.761 ****** 2026-01-29 19:42:19.739793 | controller | =============================================================================== 2026-01-29 19:42:19.739799 | controller | build_openstack_packages : Run DLRN ----------------------------------- 294.08s 2026-01-29 19:42:19.739805 | controller | build_openstack_packages : Install Mock from DLRN repos ---------------- 25.95s 2026-01-29 19:42:19.739812 | controller | build_openstack_packages : Install DLRN and rdopkg from pip ------------ 14.45s 2026-01-29 19:42:19.739818 | controller | build_openstack_packages : Create dlrn-venv ----------------------------- 3.65s 2026-01-29 19:42:19.739824 | controller | build_openstack_packages : Map project name to DLRN project name -------- 3.37s 2026-01-29 19:42:19.739830 | controller | build_openstack_packages : Fetch local rdoinfo copy --------------------- 2.72s 2026-01-29 19:42:19.739836 | controller | build_openstack_packages : Check loop devices stat ---------------------- 1.75s 2026-01-29 19:42:19.739847 | controller | build_openstack_packages : Ensure DLRN package dependencies ------------- 1.34s 2026-01-29 19:42:19.739853 | controller | Clone neutron-tempest-plugin -------------------------------------------- 1.23s 2026-01-29 19:42:19.739860 | controller | Gathering Facts --------------------------------------------------------- 0.71s 2026-01-29 19:42:19.739866 | controller | build_openstack_packages : Sync python-neutron-tests-tempest from local repo --- 0.57s 2026-01-29 19:42:19.739872 | controller | build_openstack_packages : Drop in the templated version of projects.ini --- 0.52s 2026-01-29 19:42:19.739878 | controller | build_openstack_packages : Override projects.ini settings --------------- 0.48s 2026-01-29 19:42:19.739884 | controller | build_openstack_packages : Generate DLRN Script ------------------------- 0.36s 2026-01-29 19:42:19.739890 | controller | build_openstack_packages : Add user to mock group ----------------------- 0.36s 2026-01-29 19:42:19.739896 | controller | build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir --- 0.34s 2026-01-29 19:42:19.739902 | controller | build_openstack_packages : Create mock group ---------------------------- 0.31s 2026-01-29 19:42:19.739908 | controller | build_openstack_packages : Find all the repos files --------------------- 0.28s 2026-01-29 19:42:19.739914 | controller | build_openstack_packages : Append repo_content ending with """ in mock local config at last --- 0.27s 2026-01-29 19:42:19.739921 | controller | build_openstack_packages : Remove data files from previous runs --------- 0.26s 2026-01-29 19:42:19.739934 | controller | CRITICAL Ansible return code was 2, command was: ['ansible-playbook', '--inventory', '/home/zuul/.cache/molecule/build_openstack_packages/default/inventory', '--skip-tags', 'molecule-notest,notest', '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/molecule/default/converge.yml'] 2026-01-29 19:42:19.740154 | controller | WARNING An error occurred during the test sequence action: 'converge'. Cleaning up. 2026-01-29 19:42:19.748388 | controller | INFO Running default > cleanup 2026-01-29 19:42:19.748794 | controller | WARNING Skipping, cleanup playbook not configured. 2026-01-29 19:42:19.755980 | controller | INFO Running default > destroy 2026-01-29 19:42:19.756276 | controller | WARNING Skipping, instances are delegated. 2026-01-29 19:42:19.756568 | controller | INFO Pruning extra files from scenario ephemeral directory 2026-01-29 19:42:19.758010 | controller | INFO Writing /tmp/report.html report. 2026-01-29 19:42:20.008527 | controller | ERROR 2026-01-29 19:42:20.008631 | controller | { 2026-01-29 19:42:20.008669 | controller | "delta": "0:07:20.013363", 2026-01-29 19:42:20.008693 | controller | "end": "2026-01-29 19:42:19.799163", 2026-01-29 19:42:20.008714 | controller | "msg": "non-zero return code", 2026-01-29 19:42:20.008732 | controller | "rc": 1, 2026-01-29 19:42:20.008749 | controller | "start": "2026-01-29 19:34:59.785800" 2026-01-29 19:42:20.008766 | controller | } failure 2026-01-29 19:42:20.056607 | 2026-01-29 19:42:20.056655 | PLAY RECAP 2026-01-29 19:42:20.056692 | controller | ok: 3 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2026-01-29 19:42:20.056711 | 2026-01-29 19:42:20.111526 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2026-01-29 19:42:20.112254 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-01-29 19:42:20.586991 | 2026-01-29 19:42:20.587080 | PLAY [Run ci/playbooks/collect-logs.yml] 2026-01-29 19:42:20.605417 | 2026-01-29 19:42:20.605492 | TASK [Filter out host if needed] 2026-01-29 19:42:20.613103 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2026-01-29 19:42:20.617128 | 2026-01-29 19:42:20.617189 | TASK [Ensure file is present] 2026-01-29 19:42:20.888845 | controller | ok 2026-01-29 19:42:20.895354 | 2026-01-29 19:42:20.895449 | TASK [Manage molecule report file] 2026-01-29 19:42:21.419576 | controller | changed 2026-01-29 19:42:21.424553 | 2026-01-29 19:42:21.424613 | TASK [Check if we get ci-framework-data basedir] 2026-01-29 19:42:21.595451 | controller | ok 2026-01-29 19:42:21.600470 | 2026-01-29 19:42:21.600539 | TASK [Create ci-framework-data log directory for zuul] 2026-01-29 19:42:21.872284 | controller | changed 2026-01-29 19:42:21.877120 | 2026-01-29 19:42:21.877185 | TASK [Copy ci-framework interesting files] 2026-01-29 19:42:22.059810 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2026-01-29 19:42:22.398980 | controller | changed 2026-01-29 19:42:22.403736 | 2026-01-29 19:42:22.403804 | TASK [Get SELinux listing] 2026-01-29 19:42:22.926737 | controller | changed 2026-01-29 19:42:22.931718 | 2026-01-29 19:42:22.931781 | TASK [Generate log index] 2026-01-29 19:42:23.499239 | controller | changed 2026-01-29 19:42:23.503539 | 2026-01-29 19:42:23.503600 | TASK [Get some env related data] 2026-01-29 19:42:23.987077 | controller | /home/zuul/.local/bin/ansible 2026-01-29 19:42:25.029647 | controller | changed 2026-01-29 19:42:25.034336 | 2026-01-29 19:42:25.034394 | TASK [Generate list of logs to collect in home directory] 2026-01-29 19:42:25.306895 | controller | ok: All paths examined 2026-01-29 19:42:25.311795 | 2026-01-29 19:42:25.311858 | LOOP [Copy logs from home directory] 2026-01-29 19:42:25.586117 | controller | changed: 2026-01-29 19:42:25.586264 | controller | { 2026-01-29 19:42:25.586316 | controller | "atime": 1769715281.7076457, 2026-01-29 19:42:25.586338 | controller | "ctime": 1769715297.6956327, 2026-01-29 19:42:25.586355 | controller | "dev": 64513, 2026-01-29 19:42:25.586371 | controller | "gid": 1000, 2026-01-29 19:42:25.586385 | controller | "gr_name": "zuul", 2026-01-29 19:42:25.586400 | controller | "inode": 1295832, 2026-01-29 19:42:25.586415 | controller | "isblk": false, 2026-01-29 19:42:25.586429 | controller | "ischr": false, 2026-01-29 19:42:25.586443 | controller | "isdir": false, 2026-01-29 19:42:25.586456 | controller | "isfifo": false, 2026-01-29 19:42:25.586469 | controller | "isgid": false, 2026-01-29 19:42:25.586483 | controller | "islnk": false, 2026-01-29 19:42:25.586495 | controller | "isreg": true, 2026-01-29 19:42:25.586508 | controller | "issock": false, 2026-01-29 19:42:25.586521 | controller | "isuid": false, 2026-01-29 19:42:25.586533 | controller | "mode": "0644", 2026-01-29 19:42:25.586545 | controller | "mtime": 1769715297.6956327, 2026-01-29 19:42:25.586557 | controller | "nlink": 1, 2026-01-29 19:42:25.586570 | controller | "path": "/home/zuul/ansible.log", 2026-01-29 19:42:25.586586 | controller | "pw_name": "zuul", 2026-01-29 19:42:25.586600 | controller | "rgrp": true, 2026-01-29 19:42:25.586613 | controller | "roth": true, 2026-01-29 19:42:25.586626 | controller | "rusr": true, 2026-01-29 19:42:25.586639 | controller | "size": 6749, 2026-01-29 19:42:25.586651 | controller | "uid": 1000, 2026-01-29 19:42:25.586664 | controller | "wgrp": false, 2026-01-29 19:42:25.586676 | controller | "woth": false, 2026-01-29 19:42:25.586691 | controller | "wusr": true, 2026-01-29 19:42:25.586704 | controller | "xgrp": false, 2026-01-29 19:42:25.586716 | controller | "xoth": false, 2026-01-29 19:42:25.586728 | controller | "xusr": false 2026-01-29 19:42:25.586741 | controller | } 2026-01-29 19:42:25.613833 | 2026-01-29 19:42:25.613925 | TASK [Copy crio stats log file] 2026-01-29 19:42:25.627963 | controller | skipping: Conditional result was False 2026-01-29 19:42:25.633526 | 2026-01-29 19:42:25.633592 | TASK [Get SELinux related data] 2026-01-29 19:42:25.830600 | controller | 2026-01-29 19:42:26.155716 | controller | ERROR 2026-01-29 19:42:26.155873 | controller | { 2026-01-29 19:42:26.155909 | controller | "delta": "0:00:00.008504", 2026-01-29 19:42:26.155934 | controller | "end": "2026-01-29 19:42:25.831618", 2026-01-29 19:42:26.155955 | controller | "msg": "non-zero return code", 2026-01-29 19:42:26.155974 | controller | "rc": 1, 2026-01-29 19:42:26.155993 | controller | "start": "2026-01-29 19:42:25.823114" 2026-01-29 19:42:26.156012 | controller | } 2026-01-29 19:42:26.156036 | controller | ERROR: Ignoring Errors 2026-01-29 19:42:26.160708 | 2026-01-29 19:42:26.160774 | TASK [Create system configuration directory] 2026-01-29 19:42:26.331155 | controller | changed 2026-01-29 19:42:26.335387 | 2026-01-29 19:42:26.335453 | TASK [Get some of the system configurations] 2026-01-29 19:42:26.859978 | controller | changed 2026-01-29 19:42:26.864536 | 2026-01-29 19:42:26.864597 | TASK [Copy generated documentation if available] 2026-01-29 19:42:26.878078 | controller | skipping: Conditional result was False 2026-01-29 19:42:26.882951 | 2026-01-29 19:42:26.883012 | TASK [Copy generated AsciiDoc documentation if available] 2026-01-29 19:42:26.896339 | controller | skipping: Conditional result was False 2026-01-29 19:42:26.901204 | 2026-01-29 19:42:26.901276 | TASK [Compress logs bigger than 2MB] 2026-01-29 19:42:27.425578 | controller | changed 2026-01-29 19:42:27.430040 | 2026-01-29 19:42:27.430095 | TASK [Copy files from workspace on node] 2026-01-29 19:42:27.447462 | controller | ok 2026-01-29 19:42:27.467539 | 2026-01-29 19:42:27.467604 | TASK [fetch-output : Set log path for multiple nodes] 2026-01-29 19:42:27.481444 | controller | skipping: Conditional result was False 2026-01-29 19:42:27.486734 | 2026-01-29 19:42:27.486802 | TASK [fetch-output : Set log path for single node] 2026-01-29 19:42:27.514692 | controller | ok 2026-01-29 19:42:27.519007 | 2026-01-29 19:42:27.519069 | LOOP [fetch-output : Ensure local output dirs] 2026-01-29 19:42:27.696391 | controller -> localhost | ok: "/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/logs" 2026-01-29 19:42:27.696624 | controller -> localhost | changed: All items complete 2026-01-29 19:42:27.696656 | 2026-01-29 19:42:27.858417 | controller -> localhost | changed: "/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/artifacts" 2026-01-29 19:42:28.032312 | controller -> localhost | changed: "/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/docs" 2026-01-29 19:42:28.046758 | 2026-01-29 19:42:28.046862 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-29 19:42:28.614006 | controller | changed: 2026-01-29 19:42:28.614373 | controller | .d..t...... ./ 2026-01-29 19:42:28.614421 | controller | >f+++++++++ README.html 2026-01-29 19:42:28.614446 | controller | >f+++++++++ ansible-execution.log 2026-01-29 19:42:28.614468 | controller | >f+++++++++ ansible.log 2026-01-29 19:42:28.614488 | controller | >f+++++++++ dmesg.log 2026-01-29 19:42:28.614507 | controller | >f+++++++++ installed-pkgs.log 2026-01-29 19:42:28.614529 | controller | >f+++++++++ python.log 2026-01-29 19:42:28.614550 | controller | >f+++++++++ registries.conf 2026-01-29 19:42:28.614567 | controller | >f+++++++++ report.html 2026-01-29 19:42:28.614586 | controller | >f+++++++++ selinux-denials.log 2026-01-29 19:42:28.614603 | controller | >f+++++++++ selinux-listing.log 2026-01-29 19:42:28.614620 | controller | cd+++++++++ ci-framework-data/ 2026-01-29 19:42:28.614636 | controller | cd+++++++++ ci-framework-data/artifacts/ 2026-01-29 19:42:28.614651 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2026-01-29 19:42:28.614667 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2026-01-29 19:42:28.614682 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2026-01-29 19:42:28.614697 | controller | cd+++++++++ ci-framework-data/logs/ 2026-01-29 19:42:28.614712 | controller | >f+++++++++ ci-framework-data/logs/dlrn.log 2026-01-29 19:42:28.614727 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2026-01-29 19:42:28.614742 | controller | cd+++++++++ ci-framework-data/logs/component_logs/ 2026-01-29 19:42:28.614756 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ 2026-01-29 19:42:28.614770 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ae/ 2026-01-29 19:42:28.614785 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ 2026-01-29 19:42:28.614800 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/ 2026-01-29 19:42:28.614816 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/build.log 2026-01-29 19:42:28.614837 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/commit.yaml 2026-01-29 19:42:28.614854 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/hw_info.log 2026-01-29 19:42:28.614869 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/installed_pkgs.log 2026-01-29 19:42:28.614884 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/mock.log 2026-01-29 19:42:28.614900 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/notes.log 2026-01-29 19:42:28.614915 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/python-neutron-tests-tempest-3.0.1-0.20260129193727.ae235c4.el9.src.rpm 2026-01-29 19:42:28.614934 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/root.log 2026-01-29 19:42:28.614949 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/rpmbuild.log 2026-01-29 19:42:28.614964 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/state.log 2026-01-29 19:42:28.614979 | controller | cd+++++++++ registries.conf.d/ 2026-01-29 19:42:28.614994 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2026-01-29 19:42:28.615008 | controller | cd+++++++++ system-config/ 2026-01-29 19:42:28.615022 | controller | cd+++++++++ system-config/libvirt/ 2026-01-29 19:42:28.615036 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2026-01-29 19:42:28.615050 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2026-01-29 19:42:28.957055 | controller | changed: .d..t...... ./ 2026-01-29 19:42:29.321933 | controller | changed: .d..t...... ./ 2026-01-29 19:42:29.333387 | 2026-01-29 19:42:29.333485 | TASK [Return artifact to Zuul] 2026-01-29 19:42:29.361366 | controller | ok 2026-01-29 19:42:29.378824 | 2026-01-29 19:42:29.378873 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2026-01-29 19:42:29.378958 | 2026-01-29 19:42:29.378982 | PLAY RECAP 2026-01-29 19:42:29.379014 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2026-01-29 19:42:29.379031 | 2026-01-29 19:42:29.448720 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-01-29 19:42:29.449467 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-01-29 19:42:29.909871 | 2026-01-29 19:42:29.909993 | PLAY [all] 2026-01-29 19:42:29.926804 | 2026-01-29 19:42:29.926870 | TASK [include_role : fetch-output] 2026-01-29 19:42:29.954555 | controller | ok 2026-01-29 19:42:29.969388 | 2026-01-29 19:42:29.969462 | TASK [fetch-output : Set log path for multiple nodes] 2026-01-29 19:42:30.002952 | controller | skipping: Conditional result was False 2026-01-29 19:42:30.007958 | 2026-01-29 19:42:30.008026 | TASK [fetch-output : Set log path for single node] 2026-01-29 19:42:30.035621 | controller | ok 2026-01-29 19:42:30.040006 | 2026-01-29 19:42:30.040072 | LOOP [fetch-output : Ensure local output dirs] 2026-01-29 19:42:30.326455 | controller -> localhost | ok: "/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/logs" 2026-01-29 19:42:30.489266 | controller -> localhost | ok: "/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/artifacts" 2026-01-29 19:42:30.654961 | controller -> localhost | ok: "/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/docs" 2026-01-29 19:42:30.668165 | 2026-01-29 19:42:30.668283 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-29 19:42:31.160228 | controller | ok 2026-01-29 19:42:31.160432 | controller | ok: All items complete 2026-01-29 19:42:31.160461 | 2026-01-29 19:42:31.501624 | controller | ok 2026-01-29 19:42:31.862854 | controller | ok 2026-01-29 19:42:31.878223 | 2026-01-29 19:42:31.878314 | TASK [include_role : fetch-output-openshift] 2026-01-29 19:42:31.891025 | controller | skipping: Conditional result was False 2026-01-29 19:42:31.896004 | 2026-01-29 19:42:31.896070 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-01-29 19:42:32.192013 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.005012 2026-01-29 19:42:32.370444 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006511 2026-01-29 19:42:32.396495 | 2026-01-29 19:42:32.396571 | PLAY [all] 2026-01-29 19:42:32.409032 | 2026-01-29 19:42:32.409093 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-29 19:42:32.832000 | controller | changed 2026-01-29 19:42:32.854782 | 2026-01-29 19:42:32.854845 | PLAY RECAP 2026-01-29 19:42:32.854889 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-01-29 19:42:32.854910 | 2026-01-29 19:42:32.929096 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-01-29 19:42:32.930078 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-01-29 19:42:33.468182 | 2026-01-29 19:42:33.468355 | PLAY [localhost] 2026-01-29 19:42:33.485123 | 2026-01-29 19:42:33.485198 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-29 19:42:33.796196 | localhost | changed 2026-01-29 19:42:33.800414 | 2026-01-29 19:42:33.800487 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-29 19:42:33.828326 | localhost | ok 2026-01-29 19:42:33.835462 | 2026-01-29 19:42:33.835526 | TASK [add-fileserver : Create SSH private key tempfile] 2026-01-29 19:42:34.127243 | localhost | changed 2026-01-29 19:42:34.132568 | 2026-01-29 19:42:34.132636 | TASK [add-fileserver : Create SSH private key from secret] 2026-01-29 19:42:34.658591 | localhost | changed 2026-01-29 19:42:34.664428 | 2026-01-29 19:42:34.664535 | TASK [add-fileserver : Add fileserver ssh key] 2026-01-29 19:42:35.001503 | localhost | Identity added: /var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/tmp/ansible.2evjhq_q (/var/lib/zuul/builds/18171fd4db1141699c8a85c8fe22935a/work/tmp/ansible.2evjhq_q) 2026-01-29 19:42:35.001802 | localhost | ok: Runtime: 0:00:00.008924 2026-01-29 19:42:35.006203 | 2026-01-29 19:42:35.006287 | TASK [add-fileserver : Remove SSH private key from disk] 2026-01-29 19:42:35.219665 | localhost | ok: Runtime: 0:00:00.004525 2026-01-29 19:42:35.224478 | 2026-01-29 19:42:35.224546 | TASK [add-fileserver : Add fileserver to inventory] 2026-01-29 19:42:35.274808 | localhost | changed 2026-01-29 19:42:35.279904 | 2026-01-29 19:42:35.279966 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-01-29 19:42:35.592987 | localhost | changed 2026-01-29 19:42:35.611575 | 2026-01-29 19:42:35.611639 | PLAY [localhost] 2026-01-29 19:42:35.623168 | 2026-01-29 19:42:35.623239 | TASK [Generate bulk log download script] 2026-01-29 19:42:35.643485 | localhost | ok 2026-01-29 19:42:35.654306 | 2026-01-29 19:42:35.654373 | TASK [local-log-download : Check API endpoint is defined] 2026-01-29 19:42:35.683266 | localhost | ok: All assertions passed 2026-01-29 19:42:35.687612 | 2026-01-29 19:42:35.687676 | TASK [local-log-download : Create download script] 2026-01-29 19:42:36.017351 | localhost -> localhost | changed 2026-01-29 19:42:36.025517 | 2026-01-29 19:42:36.025578 | TASK [Register quick-download link] 2026-01-29 19:42:36.045016 | localhost | ok 2026-01-29 19:42:36.093026 | 2026-01-29 19:42:36.093134 | PLAY [logserver.rdoproject.org] 2026-01-29 19:42:36.102042 | 2026-01-29 19:42:36.102101 | TASK [Set zuul-log-path fact] 2026-01-29 19:42:36.120241 | logserver.rdoproject.org | ok 2026-01-29 19:42:36.129580 | 2026-01-29 19:42:36.129646 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 19:42:36.158241 | logserver.rdoproject.org | ok 2026-01-29 19:42:36.163744 | 2026-01-29 19:42:36.163815 | TASK [upload-logs : Create log directories] 2026-01-29 19:42:37.734505 | logserver.rdoproject.org | changed 2026-01-29 19:42:37.737796 | 2026-01-29 19:42:37.737862 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-29 19:42:37.947403 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.003990 2026-01-29 19:42:37.952527 | 2026-01-29 19:42:37.952594 | TASK [upload-logs : Upload logs to log server] 2026-01-29 19:42:39.575145 | logserver.rdoproject.org | Output suppressed because no_log was given 2026-01-29 19:42:39.577800 | 2026-01-29 19:42:39.577861 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 19:42:39.612934 | logserver.rdoproject.org | skipping: Conditional result was False 2026-01-29 19:42:39.620418 | logserver.rdoproject.org | skipping: Conditional result was False 2026-01-29 19:42:39.625144 | 2026-01-29 19:42:39.625225 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 19:42:39.657530 | logserver.rdoproject.org | skipping: Conditional result was False 2026-01-29 19:42:39.657718 | 2026-01-29 19:42:39.660677 | logserver.rdoproject.org | skipping: Conditional result was False 2026-01-29 19:42:39.672066 | 2026-01-29 19:42:39.672148 | LOOP [upload-logs : Upload console log and json output]