2026-03-19 14:51:42.849519 | Job console starting...
2026-03-19 14:51:44.211369 | Updating repositories
2026-03-19 14:51:44.947508 | Preparing job workspace
2026-03-19 14:51:51.548023 | Running Ansible setup...
2026-03-19 14:51:54.234520 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-03-19 14:51:54.696347 | 
2026-03-19 14:51:54.696457 | PLAY [localhost]
2026-03-19 14:51:54.704157 | 
2026-03-19 14:51:54.704223 | TASK [Gathering Facts]
2026-03-19 14:51:55.456975 | localhost | ok
2026-03-19 14:51:55.469339 | 
2026-03-19 14:51:55.469411 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-19 14:51:55.755599 | localhost -> localhost | changed
2026-03-19 14:51:55.760461 | 
2026-03-19 14:51:55.760529 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-19 14:51:56.381476 | localhost -> localhost | changed
2026-03-19 14:51:56.389111 | 
2026-03-19 14:51:56.389175 | TASK [Setup log path fact]
2026-03-19 14:51:56.405738 | localhost | ok
2026-03-19 14:51:56.415740 | 
2026-03-19 14:51:56.415815 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-19 14:51:56.432603 | localhost | ok
2026-03-19 14:51:56.439311 | 
2026-03-19 14:51:56.439374 | TASK [emit-job-header : Print job information]
2026-03-19 14:51:56.465596 | # Job Information
2026-03-19 14:51:56.465708 | Ansible Version: 2.15.12
2026-03-19 14:51:56.465735 | Job: cifmw-molecule-build_openstack_packages
2026-03-19 14:51:56.465766 | Pipeline: github-check
2026-03-19 14:51:56.465787 | Executor: ibm-bm3-ze.softwarefactory-project.io
2026-03-19 14:51:56.465804 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3772
2026-03-19 14:51:56.465821 | Log URL (when completed): https://logserver.rdoproject.org/d53/rdoproject.org/d53f3edb63104eda82e285c3913ed6fe/
2026-03-19 14:51:56.465838 | Event ID: ece68340-23a2-11f1-8f5d-899c9706a60d
2026-03-19 14:51:56.469213 | 
2026-03-19 14:51:56.469287 | LOOP [emit-job-header : Print node information]
2026-03-19 14:51:56.546619 | localhost | ok:
2026-03-19 14:51:56.546766 | localhost | # Node Information
2026-03-19 14:51:56.546795 | localhost | Inventory Hostname: controller
2026-03-19 14:51:56.546817 | localhost | Hostname: np0005652081
2026-03-19 14:51:56.546835 | localhost | Username: zuul
2026-03-19 14:51:56.546853 | localhost | Distro: CentOS 9
2026-03-19 14:51:56.546869 | localhost | Provider: ibm-bm3-nodepool
2026-03-19 14:51:56.546883 | localhost | Region: regionOne
2026-03-19 14:51:56.546897 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2026-03-19 14:51:56.546911 | localhost | Product Name: OpenStack Compute
2026-03-19 14:51:56.546926 | localhost | Interface IP: 192.168.25.124
2026-03-19 14:51:56.570675 | 
2026-03-19 14:51:56.570740 | PLAY [all]
2026-03-19 14:51:56.576442 | 
2026-03-19 14:51:56.576499 | TASK [Gather network facts]
2026-03-19 14:51:56.919739 | controller | ok
2026-03-19 14:51:56.931940 | 
2026-03-19 14:51:56.931999 | TASK [include_role : start-zuul-console]
2026-03-19 14:51:56.948623 | controller | ok
2026-03-19 14:51:56.959036 | 
2026-03-19 14:51:56.959094 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-03-19 14:51:57.249988 | controller | ok
2026-03-19 14:51:57.257312 | 
2026-03-19 14:51:57.257373 | TASK [include_role : add-build-sshkey]
2026-03-19 14:51:57.273521 | controller | ok
2026-03-19 14:51:57.284616 | 
2026-03-19 14:51:57.284675 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-19 14:51:57.458981 | controller -> localhost | ok
2026-03-19 14:51:57.464086 | 
2026-03-19 14:51:57.464148 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-19 14:51:57.480826 | controller | ok
2026-03-19 14:51:57.493731 | controller | included: /var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-19 14:51:57.499037 | 
2026-03-19 14:51:57.499098 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-19 14:51:58.057875 | controller -> localhost | Generating public/private rsa key pair.
2026-03-19 14:51:58.058031 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/d53f3edb63104eda82e285c3913ed6fe_id_rsa.
2026-03-19 14:51:58.058061 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/d53f3edb63104eda82e285c3913ed6fe_id_rsa.pub.
2026-03-19 14:51:58.058083 | controller -> localhost | The key fingerprint is:
2026-03-19 14:51:58.058102 | controller -> localhost | SHA256:vVzByW3jKJm/wguwZCDXzGVCfpQ6DrfvqZrETmRcixs zuul-build-sshkey
2026-03-19 14:51:58.058120 | controller -> localhost | The key's randomart image is:
2026-03-19 14:51:58.058137 | controller -> localhost | +---[RSA 3072]----+
2026-03-19 14:51:58.058152 | controller -> localhost | |     .o +.       |
2026-03-19 14:51:58.058168 | controller -> localhost | |     = =.  o o   |
2026-03-19 14:51:58.058184 | controller -> localhost | |  . o *..   = +  |
2026-03-19 14:51:58.058200 | controller -> localhost | |   +.++o . o = . |
2026-03-19 14:51:58.058215 | controller -> localhost | |    E+=oS = o .  |
2026-03-19 14:51:58.058230 | controller -> localhost | |   + =oo . =     |
2026-03-19 14:51:58.058245 | controller -> localhost | |    = ....o .    |
2026-03-19 14:51:58.058259 | controller -> localhost | |   + .  .oo  .   |
2026-03-19 14:51:58.058297 | controller -> localhost | |    +..oo .o.    |
2026-03-19 14:51:58.058313 | controller -> localhost | +----[SHA256]-----+
2026-03-19 14:51:58.058351 | controller -> localhost | ok: Runtime: 0:00:00.264745
2026-03-19 14:51:58.063235 | 
2026-03-19 14:51:58.063311 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-19 14:51:58.080224 | controller | ok
2026-03-19 14:51:58.088490 | controller | included: /var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-19 14:51:58.095324 | 
2026-03-19 14:51:58.095381 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-19 14:51:58.108695 | controller | skipping: Conditional result was False
2026-03-19 14:51:58.113735 | 
2026-03-19 14:51:58.113803 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-19 14:51:58.455659 | controller | changed
2026-03-19 14:51:58.459788 | 
2026-03-19 14:51:58.459847 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-19 14:51:58.639359 | controller | ok
2026-03-19 14:51:58.643599 | 
2026-03-19 14:51:58.643660 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-19 14:51:59.219513 | controller | changed
2026-03-19 14:51:59.223903 | 
2026-03-19 14:51:59.223965 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-19 14:51:59.769595 | controller | changed
2026-03-19 14:51:59.774031 | 
2026-03-19 14:51:59.774095 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-19 14:51:59.787688 | controller | skipping: Conditional result was False
2026-03-19 14:51:59.793372 | 
2026-03-19 14:51:59.793437 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-19 14:52:00.059415 | controller -> localhost | changed
2026-03-19 14:52:00.068350 | 
2026-03-19 14:52:00.068412 | TASK [add-build-sshkey : Add back temp key]
2026-03-19 14:52:00.273662 | controller -> localhost | Identity added: /var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/d53f3edb63104eda82e285c3913ed6fe_id_rsa (zuul-build-sshkey)
2026-03-19 14:52:00.273827 | controller -> localhost | ok: Runtime: 0:00:00.006428
2026-03-19 14:52:00.279254 | 
2026-03-19 14:52:00.279341 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-19 14:52:00.550074 | controller | ok
2026-03-19 14:52:00.554062 | 
2026-03-19 14:52:00.554120 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-19 14:52:00.577392 | controller | skipping: Conditional result was False
2026-03-19 14:52:00.585573 | 
2026-03-19 14:52:00.585640 | TASK [include_role : validate-host]
2026-03-19 14:52:00.602797 | controller | ok
2026-03-19 14:52:00.620476 | 
2026-03-19 14:52:00.620538 | TASK [validate-host : Define zuul_info_dir fact]
2026-03-19 14:52:00.647772 | controller | ok
2026-03-19 14:52:00.651765 | 
2026-03-19 14:52:00.651824 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-03-19 14:52:00.826698 | controller -> localhost | ok
2026-03-19 14:52:00.831736 | 
2026-03-19 14:52:00.831805 | TASK [validate-host : Collect information about the host]
2026-03-19 14:52:01.430862 | controller | ok
2026-03-19 14:52:01.437911 | 
2026-03-19 14:52:01.437975 | TASK [validate-host : Sanitize hostname]
2026-03-19 14:52:01.495401 | controller | ok
2026-03-19 14:52:01.500715 | 
2026-03-19 14:52:01.500787 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-03-19 14:52:01.858113 | controller -> localhost | changed
2026-03-19 14:52:01.862219 | 
2026-03-19 14:52:01.862288 | TASK [validate-host : Collect information about zuul worker]
2026-03-19 14:52:02.154087 | controller | ok
2026-03-19 14:52:02.158085 | 
2026-03-19 14:52:02.158144 | TASK [validate-host : Write out all zuul information for each host]
2026-03-19 14:52:02.485585 | controller -> localhost | changed
2026-03-19 14:52:02.494105 | 
2026-03-19 14:52:02.494165 | TASK [include_role : prepare-workspace-openshift]
2026-03-19 14:52:02.507219 | controller | skipping: Conditional result was False
2026-03-19 14:52:02.512210 | 
2026-03-19 14:52:02.512289 | TASK [include_role : remove-zuul-sshkey]
2026-03-19 14:52:02.525212 | controller | skipping: Conditional result was False
2026-03-19 14:52:02.530019 | 
2026-03-19 14:52:02.530079 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-19 14:52:02.710262 | controller | ok: "logs"
2026-03-19 14:52:02.710510 | controller | ok: All items complete
2026-03-19 14:52:02.710538 | 
2026-03-19 14:52:02.866083 | controller | ok: "artifacts"
2026-03-19 14:52:03.023282 | controller | ok: "docs"
2026-03-19 14:52:03.036655 | 
2026-03-19 14:52:03.036738 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-19 14:52:03.238434 | controller | changed: "logs"
2026-03-19 14:52:03.409885 | controller | changed: "artifacts"
2026-03-19 14:52:03.577086 | controller | changed: "docs"
2026-03-19 14:52:03.596487 | 
2026-03-19 14:52:03.596562 | PLAY RECAP
2026-03-19 14:52:03.596603 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-03-19 14:52:03.596630 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-19 14:52:03.596647 | 
2026-03-19 14:52:03.663251 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-03-19 14:52:03.663908 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-03-19 14:52:04.173775 | 
2026-03-19 14:52:04.173881 | PLAY [all]
2026-03-19 14:52:04.192633 | 
2026-03-19 14:52:04.192706 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-03-19 14:52:04.241281 | controller | ok
2026-03-19 14:52:04.246071 | 
2026-03-19 14:52:04.246149 | TASK [mirror-info-fork : Create /etc/ci]
2026-03-19 14:52:04.578567 | controller | changed
2026-03-19 14:52:04.584050 | 
2026-03-19 14:52:04.584337 | TASK [mirror-info-fork : Install ci_mirror script]
2026-03-19 14:52:05.311811 | controller | changed
2026-03-19 14:52:05.320198 | 
2026-03-19 14:52:05.320289 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-03-19 14:52:05.645644 | controller | changed:
2026-03-19 14:52:05.645827 | controller | {
2026-03-19 14:52:05.645857 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-03-19 14:52:05.645884 | controller | }
2026-03-19 14:52:05.839278 | controller | changed:
2026-03-19 14:52:05.839329 | controller | {
2026-03-19 14:52:05.839354 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-03-19 14:52:05.839374 | controller | }
2026-03-19 14:52:06.029858 | controller | changed:
2026-03-19 14:52:06.029905 | controller | {
2026-03-19 14:52:06.029929 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-03-19 14:52:06.029948 | controller | }
2026-03-19 14:52:06.215203 | controller | changed:
2026-03-19 14:52:06.215255 | controller | {
2026-03-19 14:52:06.215302 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-03-19 14:52:06.215324 | controller | }
2026-03-19 14:52:06.409013 | controller | changed:
2026-03-19 14:52:06.409157 | controller | {
2026-03-19 14:52:06.409190 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-03-19 14:52:06.409211 | controller | }
2026-03-19 14:52:06.596574 | controller | changed:
2026-03-19 14:52:06.596621 | controller | {
2026-03-19 14:52:06.596646 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-03-19 14:52:06.596664 | controller | }
2026-03-19 14:52:06.781910 | controller | changed:
2026-03-19 14:52:06.781957 | controller | {
2026-03-19 14:52:06.781980 | 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-03-19 14:52:06.781999 | controller | }
2026-03-19 14:52:06.970231 | controller | changed:
2026-03-19 14:52:06.970292 | controller | {
2026-03-19 14:52:06.970320 | 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-03-19 14:52:06.970340 | controller | }
2026-03-19 14:52:07.173638 | controller | changed:
2026-03-19 14:52:07.173692 | controller | {
2026-03-19 14:52:07.173716 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-03-19 14:52:07.173735 | controller | }
2026-03-19 14:52:07.368204 | controller | changed:
2026-03-19 14:52:07.368249 | controller | {
2026-03-19 14:52:07.368293 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-03-19 14:52:07.368316 | controller | }
2026-03-19 14:52:07.575619 | controller | changed:
2026-03-19 14:52:07.575666 | controller | {
2026-03-19 14:52:07.575690 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-03-19 14:52:07.575707 | controller | }
2026-03-19 14:52:07.802497 | controller | changed:
2026-03-19 14:52:07.802560 | controller | {
2026-03-19 14:52:07.802584 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-03-19 14:52:07.802603 | controller | }
2026-03-19 14:52:07.977211 | controller | changed:
2026-03-19 14:52:07.977261 | controller | {
2026-03-19 14:52:07.977306 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com"
2026-03-19 14:52:07.977326 | controller | }
2026-03-19 14:52:08.166346 | controller | changed:
2026-03-19 14:52:08.166393 | controller | {
2026-03-19 14:52:08.166417 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-03-19 14:52:08.166434 | controller | }
2026-03-19 14:52:08.371049 | controller | changed:
2026-03-19 14:52:08.371095 | controller | {
2026-03-19 14:52:08.371118 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-03-19 14:52:08.371135 | controller | }
2026-03-19 14:52:08.557409 | controller | changed:
2026-03-19 14:52:08.557455 | controller | {
2026-03-19 14:52:08.557479 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-03-19 14:52:08.557497 | controller | }
2026-03-19 14:52:08.741952 | controller | changed:
2026-03-19 14:52:08.741998 | controller | {
2026-03-19 14:52:08.742022 | 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-03-19 14:52:08.742041 | controller | }
2026-03-19 14:52:08.927519 | controller | changed:
2026-03-19 14:52:08.927567 | controller | {
2026-03-19 14:52:08.927592 | 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-03-19 14:52:08.927617 | controller | }
2026-03-19 14:52:09.112449 | controller | changed:
2026-03-19 14:52:09.112503 | controller | {
2026-03-19 14:52:09.112532 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-03-19 14:52:09.112557 | controller | }
2026-03-19 14:52:09.297239 | controller | changed:
2026-03-19 14:52:09.297300 | controller | {
2026-03-19 14:52:09.297335 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-03-19 14:52:09.297354 | controller | }
2026-03-19 14:52:09.486193 | controller | changed:
2026-03-19 14:52:09.486243 | controller | {
2026-03-19 14:52:09.486287 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-03-19 14:52:09.486310 | controller | }
2026-03-19 14:52:09.682423 | controller | changed:
2026-03-19 14:52:09.682510 | controller | {
2026-03-19 14:52:09.682533 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-03-19 14:52:09.682551 | controller | }
2026-03-19 14:52:09.870171 | controller | changed:
2026-03-19 14:52:09.870239 | controller | {
2026-03-19 14:52:09.870282 | 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-03-19 14:52:09.870310 | controller | }
2026-03-19 14:52:10.062696 | controller | changed:
2026-03-19 14:52:10.062757 | controller | {
2026-03-19 14:52:10.062785 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-03-19 14:52:10.062804 | controller | }
2026-03-19 14:52:10.254473 | controller | changed:
2026-03-19 14:52:10.254525 | controller | {
2026-03-19 14:52:10.254551 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-03-19 14:52:10.254570 | controller | }
2026-03-19 14:52:10.443978 | controller | changed:
2026-03-19 14:52:10.444066 | controller | {
2026-03-19 14:52:10.444091 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-03-19 14:52:10.444109 | controller | }
2026-03-19 14:52:10.466967 | 
2026-03-19 14:52:10.467068 | TASK [Set timezone to UTC]
2026-03-19 14:52:10.829808 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-03-19 14:52:10.834383 | 
2026-03-19 14:52:10.834447 | TASK [Create nodepool directory]
2026-03-19 14:52:11.014228 | controller | changed
2026-03-19 14:52:11.018986 | 
2026-03-19 14:52:11.019046 | TASK [Create nodepool sub_nodes file]
2026-03-19 14:52:11.514639 | controller | changed
2026-03-19 14:52:11.519231 | 
2026-03-19 14:52:11.519313 | TASK [Create nodepool sub_nodes_private file]
2026-03-19 14:52:12.013119 | controller | changed
2026-03-19 14:52:12.018019 | 
2026-03-19 14:52:12.018076 | LOOP [Populate nodepool sub_nodes file]
2026-03-19 14:52:12.045868 | 
2026-03-19 14:52:12.045986 | LOOP [Populate nodepool sub_nodes_private file]
2026-03-19 14:52:12.073792 | 
2026-03-19 14:52:12.073912 | TASK [Create nodepool primary file]
2026-03-19 14:52:12.087541 | controller | skipping: Conditional result was False
2026-03-19 14:52:12.092240 | 
2026-03-19 14:52:12.092324 | TASK [Create nodepool node_private for this node]
2026-03-19 14:52:12.584219 | controller | changed
2026-03-19 14:52:12.589152 | 
2026-03-19 14:52:12.589225 | LOOP [Copy ssh keys to nodepool directory]
2026-03-19 14:52:12.877904 | controller | ok: Item: id_rsa Runtime: 0:00:00.004221
2026-03-19 14:52:12.878092 | 
2026-03-19 14:52:13.025257 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004855
2026-03-19 14:52:13.034424 | 
2026-03-19 14:52:13.034526 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-03-19 14:52:13.540099 | controller | changed
2026-03-19 14:52:13.544897 | 
2026-03-19 14:52:13.544966 | TASK [Validate sudoers config after edits]
2026-03-19 14:52:13.752463 | controller | /etc/sudoers: parsed OK
2026-03-19 14:52:13.752534 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-03-19 14:52:13.752545 | controller | /etc/sudoers.d/zuul: parsed OK
2026-03-19 14:52:13.752551 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-03-19 14:52:14.069570 | controller | ok: Runtime: 0:00:00.006852
2026-03-19 14:52:14.074561 | 
2026-03-19 14:52:14.074623 | TASK [Show the environment passed in to job shell scripts]
2026-03-19 14:52:14.275794 | controller | SHELL=/bin/bash
2026-03-19 14:52:14.275856 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-03-19 14:52:14.275865 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-03-19 14:52:14.275873 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/72/3772/0fbb2f7390c82f6d3bab0954ff33cde1104d9381
2026-03-19 14:52:14.275879 | controller | PWD=/home/zuul
2026-03-19 14:52:14.275885 | controller | ZUUL_PIPELINE=github-check
2026-03-19 14:52:14.275891 | controller | LOGNAME=zuul
2026-03-19 14:52:14.275897 | controller | XDG_SESSION_TYPE=tty
2026-03-19 14:52:14.275947 | controller | _=/usr/bin/env
2026-03-19 14:52:14.275956 | controller | MOTD_SHOWN=pam
2026-03-19 14:52:14.275962 | controller | HOME=/home/zuul
2026-03-19 14:52:14.275968 | controller | LANG=en_US.UTF-8
2026-03-19 14:52:14.275973 | controller | SSH_CONNECTION=192.168.25.12 49732 192.168.25.124 22
2026-03-19 14:52:14.275979 | 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-03-19 14:52:14.275988 | controller | ZUUL_CHANGE_IDS=3772,0fbb2f7390c82f6d3bab0954ff33cde1104d9381
2026-03-19 14:52:14.275993 | controller | WORKSPACE=/home/zuul/workspace
2026-03-19 14:52:14.275999 | controller | XDG_SESSION_CLASS=user
2026-03-19 14:52:14.276005 | controller | SELINUX_ROLE_REQUESTED=
2026-03-19 14:52:14.276010 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-03-19 14:52:14.276016 | controller | USER=zuul
2026-03-19 14:52:14.276021 | controller | ZUUL_VOTING=True
2026-03-19 14:52:14.276026 | controller | BUILD_TIMEOUT=1800000
2026-03-19 14:52:14.276032 | controller | SELINUX_USE_CURRENT_RANGE=
2026-03-19 14:52:14.276037 | controller | SHLVL=1
2026-03-19 14:52:14.276043 | controller | ZUUL_PATCHSET=0fbb2f7390c82f6d3bab0954ff33cde1104d9381
2026-03-19 14:52:14.276048 | controller | XDG_SESSION_ID=1
2026-03-19 14:52:14.276054 | controller | ZUUL_BRANCH=main
2026-03-19 14:52:14.276059 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-03-19 14:52:14.276065 | controller | SSH_CLIENT=192.168.25.12 49732 22
2026-03-19 14:52:14.276070 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-03-19 14:52:14.276076 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-03-19 14:52:14.276083 | controller | which_declare=declare -f
2026-03-19 14:52:14.276089 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-03-19 14:52:14.276095 | controller | SELINUX_LEVEL_REQUESTED=
2026-03-19 14:52:14.276101 | controller | ZUUL_CHANGE=3772
2026-03-19 14:52:14.276106 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-03-19 14:52:14.276111 | controller | ZUUL_UUID=d53f3edb63104eda82e285c3913ed6fe
2026-03-19 14:52:14.276117 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-03-19 14:52:14.276123 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-03-19 14:52:14.276128 | controller | }
2026-03-19 14:52:14.596149 | controller | ok: Runtime: 0:00:00.006156
2026-03-19 14:52:14.600803 | 
2026-03-19 14:52:14.600868 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-03-19 14:52:14.613950 | controller | skipping: Conditional result was False
2026-03-19 14:52:14.618561 | 
2026-03-19 14:52:14.618622 | TASK [Symlink /home/zuul-worker/workspace]
2026-03-19 14:52:15.142168 | controller | skipping: Conditional result was False
2026-03-19 14:52:15.147182 | 
2026-03-19 14:52:15.147244 | TASK [Ensure legacy workspace directory]
2026-03-19 14:52:15.326772 | controller | changed
2026-03-19 14:52:15.343688 | 
2026-03-19 14:52:15.343761 | PLAY RECAP
2026-03-19 14:52:15.343808 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-03-19 14:52:15.343830 | 
2026-03-19 14:52:15.413315 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-03-19 14:52:15.414047 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-03-19 14:52:15.878890 | 
2026-03-19 14:52:15.878980 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-03-19 14:52:15.896786 | 
2026-03-19 14:52:15.896851 | TASK [Create zuul-output directory]
2026-03-19 14:52:16.180380 | controller | changed
2026-03-19 14:52:16.184792 | 
2026-03-19 14:52:16.184864 | TASK [Slurp Zuul inventory test]
2026-03-19 14:52:16.422899 | controller -> localhost | ok
2026-03-19 14:52:16.428780 | 
2026-03-19 14:52:16.428842 | TASK [Save zuul inventory]
2026-03-19 14:52:17.097172 | controller | changed
2026-03-19 14:52:17.101592 | 
2026-03-19 14:52:17.101656 | TASK [Save zuul vars without the change_message]
2026-03-19 14:52:17.657067 | controller | changed
2026-03-19 14:52:17.672712 | 
2026-03-19 14:52:17.672771 | PLAY RECAP
2026-03-19 14:52:17.672810 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-19 14:52:17.672831 | 
2026-03-19 14:52:17.729481 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-03-19 14:52:17.730177 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-03-19 14:52:18.217521 | 
2026-03-19 14:52:18.217613 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-03-19 14:52:18.236146 | 
2026-03-19 14:52:18.236213 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-03-19 14:52:18.253764 | controller | ok
2026-03-19 14:52:18.268614 | 
2026-03-19 14:52:18.268687 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-03-19 14:52:18.291612 | controller | skipping: Conditional result was False
2026-03-19 14:52:18.296906 | 
2026-03-19 14:52:18.296971 | TASK [mirror-info-fork : Create /etc/ci]
2026-03-19 14:52:18.577473 | controller | ok
2026-03-19 14:52:18.582509 | 
2026-03-19 14:52:18.582574 | TASK [mirror-info-fork : Install ci_mirror script]
2026-03-19 14:52:19.147243 | controller | ok
2026-03-19 14:52:19.156361 | 
2026-03-19 14:52:19.156435 | TASK [Prepare workspace]
2026-03-19 14:52:19.173659 | controller | ok
2026-03-19 14:52:19.189184 | 
2026-03-19 14:52:19.189245 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-19 14:52:19.460721 | controller | ok
2026-03-19 14:52:19.466377 | 
2026-03-19 14:52:19.466440 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-19 14:52:21.696964 | controller | Output suppressed because no_log was given
2026-03-19 14:52:21.705342 | 
2026-03-19 14:52:21.705404 | LOOP [Create zuul-output directory]
2026-03-19 14:52:21.883471 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-03-19 14:52:22.030710 | controller | ok: "/home/zuul/zuul-output/logs"
2026-03-19 14:52:22.040077 | 
2026-03-19 14:52:22.040190 | TASK [Install required packages]
2026-03-19 14:53:02.124531 | controller | changed
2026-03-19 14:53:02.129170 | 
2026-03-19 14:53:02.129228 | TASK [Install venv]
2026-03-19 14:54:06.216370 | controller | changed
2026-03-19 14:54:06.238504 | 
2026-03-19 14:54:06.238560 | PLAY RECAP
2026-03-19 14:54:06.238603 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-19 14:54:06.238624 | 
2026-03-19 14:54:06.304886 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-03-19 14:54:06.305715 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-03-19 14:54:06.775813 | 
2026-03-19 14:54:06.775932 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-03-19 14:54:06.795039 | 
2026-03-19 14:54:06.795108 | TASK [Gather required facts]
2026-03-19 14:54:07.251352 | controller | ok
2026-03-19 14:54:07.256510 | 
2026-03-19 14:54:07.256579 | TASK [Load environment var if instructed to]
2026-03-19 14:54:07.280020 | controller | skipping: Conditional result was False
2026-03-19 14:54:07.284768 | 
2026-03-19 14:54:07.284828 | TASK [Ensure group_vars dir exists]
2026-03-19 14:54:07.565049 | controller | ok
2026-03-19 14:54:07.570402 | 
2026-03-19 14:54:07.570464 | TASK [Print related variables]
2026-03-19 14:54:07.597783 | controller | ok:
2026-03-19 14:54:07.597889 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-03-19 14:54:07.597917 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages
2026-03-19 14:54:07.602102 | 
2026-03-19 14:54:07.602162 | TASK [Run molecule]
2026-03-19 14:54:08.558373 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-03-19 14:54:08.629121 | controller | INFO     Performing prerun with role_name_check=0...
2026-03-19 14:54:29.942516 | 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-03-19 14:54:29.942896 | 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-03-19 14:54:29.943314 | 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-03-19 14:54:29.943721 | 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-03-19 14:54:29.944153 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+30a09e6a was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.0.0+30a09e6a (/home/zuul/.ansible/collections/ansible_collections).
2026-03-19 14:54:29.944561 | 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-03-19 14:54:29.944964 | 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-03-19 14:54:29.945364 | 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-03-19 14:54:29.945753 | 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-03-19 14:54:29.946117 | 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-03-19 14:54:29.946512 | 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-03-19 14:54:29.946936 | 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-03-19 14:54:29.947341 | 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-03-19 14:54:29.947731 | 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-03-19 14:54:29.948148 | 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-03-19 14:54:29.956920 | controller | INFO     Running default > prepare
2026-03-19 14:54:30.598672 | controller |
2026-03-19 14:54:30.598770 | controller | PLAY [Prepare] *****************************************************************
2026-03-19 14:54:30.598874 | controller |
2026-03-19 14:54:30.598967 | controller | TASK [Gathering Facts] *********************************************************
2026-03-19 14:54:30.599042 | controller | Thursday 19 March 2026  14:54:30 +0000 (0:00:00.021)       0:00:00.021 ********
2026-03-19 14:54:31.389695 | controller | ok: [instance]
2026-03-19 14:54:31.389736 | controller |
2026-03-19 14:54:31.389822 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2026-03-19 14:54:31.389916 | controller | Thursday 19 March 2026  14:54:31 +0000 (0:00:00.791)       0:00:00.813 ********
2026-03-19 14:54:31.406740 | controller | skipping: [instance]
2026-03-19 14:54:31.406834 | controller |
2026-03-19 14:54:31.406935 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2026-03-19 14:54:31.407029 | controller | Thursday 19 March 2026  14:54:31 +0000 (0:00:00.017)       0:00:00.831 ********
2026-03-19 14:54:31.445269 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2026-03-19 14:54:31.445343 | controller |
2026-03-19 14:54:31.445435 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2026-03-19 14:54:31.445528 | controller | Thursday 19 March 2026  14:54:31 +0000 (0:00:00.038)       0:00:00.869 ********
2026-03-19 14:54:31.706710 | controller | ok: [instance]
2026-03-19 14:54:31.706793 | controller |
2026-03-19 14:54:31.706895 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2026-03-19 14:54:31.706988 | controller | Thursday 19 March 2026  14:54:31 +0000 (0:00:00.261)       0:00:01.130 ********
2026-03-19 14:54:31.994708 | controller | ok: [instance]
2026-03-19 14:54:31.994821 | controller |
2026-03-19 14:54:31.994920 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2026-03-19 14:54:31.995016 | controller | Thursday 19 March 2026  14:54:31 +0000 (0:00:00.287)       0:00:01.418 ********
2026-03-19 14:54:32.634953 | controller | ok: [instance] => (item=ubi-9-appstream)
2026-03-19 14:54:32.635011 | controller | ok: [instance] => (item=ubi-9-baseos)
2026-03-19 14:54:32.635110 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2026-03-19 14:54:32.635191 | controller |
2026-03-19 14:54:32.635289 | controller | TASK [Deploy repo-setup] *******************************************************
2026-03-19 14:54:32.635379 | controller | Thursday 19 March 2026  14:54:32 +0000 (0:00:00.640)       0:00:02.058 ********
2026-03-19 14:54:32.686049 | controller |
2026-03-19 14:54:32.686197 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-03-19 14:54:32.686348 | controller | Thursday 19 March 2026  14:54:32 +0000 (0:00:00.051)       0:00:02.110 ********
2026-03-19 14:54:33.175837 | controller | changed: [instance] => (item=tmp)
2026-03-19 14:54:33.175894 | controller | changed: [instance] => (item=artifacts/repositories)
2026-03-19 14:54:33.175988 | controller | changed: [instance] => (item=venv/repo_setup)
2026-03-19 14:54:33.176074 | controller |
2026-03-19 14:54:33.176164 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-03-19 14:54:33.176265 | controller | Thursday 19 March 2026  14:54:33 +0000 (0:00:00.489)       0:00:02.599 ********
2026-03-19 14:54:33.946806 | controller | ok: [instance]
2026-03-19 14:54:33.946868 | controller |
2026-03-19 14:54:33.946969 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-03-19 14:54:33.947064 | controller | Thursday 19 March 2026  14:54:33 +0000 (0:00:00.771)       0:00:03.370 ********
2026-03-19 14:54:35.044158 | controller | changed: [instance]
2026-03-19 14:54:42.506612 | controller |
2026-03-19 14:54:42.506653 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-03-19 14:54:42.506661 | controller | Thursday 19 March 2026  14:54:35 +0000 (0:00:01.096)       0:00:04.467 ********
2026-03-19 14:54:42.506672 | controller | changed: [instance]
2026-03-19 14:54:43.149505 | controller |
2026-03-19 14:54:43.149543 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-03-19 14:54:43.149551 | controller | Thursday 19 March 2026  14:54:42 +0000 (0:00:07.462)       0:00:11.930 ********
2026-03-19 14:54:43.149560 | controller | changed: [instance]
2026-03-19 14:54:43.170391 | controller |
2026-03-19 14:54:43.170414 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-03-19 14:54:43.170422 | controller | Thursday 19 March 2026  14:54:43 +0000 (0:00:00.642)       0:00:12.573 ********
2026-03-19 14:54:43.170431 | controller | skipping: [instance]
2026-03-19 14:54:43.962817 | controller |
2026-03-19 14:54:43.962849 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-03-19 14:54:43.962857 | controller | Thursday 19 March 2026  14:54:43 +0000 (0:00:00.021)       0:00:12.594 ********
2026-03-19 14:54:43.962873 | controller | changed: [instance]
2026-03-19 14:54:43.962890 | controller |
2026-03-19 14:54:43.962897 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-03-19 14:54:43.963023 | controller | Thursday 19 March 2026  14:54:43 +0000 (0:00:00.792)       0:00:13.386 ********
2026-03-19 14:54:43.998156 | controller | skipping: [instance]
2026-03-19 14:54:44.032793 | controller |
2026-03-19 14:54:44.032809 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-03-19 14:54:44.032816 | controller | Thursday 19 March 2026  14:54:43 +0000 (0:00:00.035)       0:00:13.421 ********
2026-03-19 14:54:44.032824 | controller | skipping: [instance]
2026-03-19 14:54:44.033135 | controller |
2026-03-19 14:54:44.067479 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-03-19 14:54:44.067502 | controller | Thursday 19 March 2026  14:54:44 +0000 (0:00:00.035)       0:00:13.456 ********
2026-03-19 14:54:44.067515 | controller | skipping: [instance]
2026-03-19 14:54:44.588815 | controller |
2026-03-19 14:54:44.588846 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-03-19 14:54:44.588854 | controller | Thursday 19 March 2026  14:54:44 +0000 (0:00:00.034)       0:00:13.491 ********
2026-03-19 14:54:44.588864 | controller | changed: [instance]
2026-03-19 14:54:44.589193 | controller |
2026-03-19 14:54:45.006656 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-03-19 14:54:45.006689 | controller | Thursday 19 March 2026  14:54:44 +0000 (0:00:00.521)       0:00:14.012 ********
2026-03-19 14:54:45.006701 | controller | changed: [instance]
2026-03-19 14:54:45.035322 | controller |
2026-03-19 14:54:45.035345 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-03-19 14:54:45.035354 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.417)       0:00:14.430 ********
2026-03-19 14:54:45.035365 | controller | skipping: [instance]
2026-03-19 14:54:45.062087 | controller |
2026-03-19 14:54:45.062105 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-03-19 14:54:45.062112 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.028)       0:00:14.459 ********
2026-03-19 14:54:45.062124 | controller | skipping: [instance]
2026-03-19 14:54:45.087821 | controller |
2026-03-19 14:54:45.087845 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-03-19 14:54:45.087854 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.027)       0:00:14.486 ********
2026-03-19 14:54:45.087866 | controller | skipping: [instance]
2026-03-19 14:54:45.088133 | controller |
2026-03-19 14:54:45.122844 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-03-19 14:54:45.122880 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.025)       0:00:14.511 ********
2026-03-19 14:54:45.122892 | controller | ok: [instance]
2026-03-19 14:54:45.122938 | controller |
2026-03-19 14:54:45.122961 | controller | TASK [repo_setup : Create download directory] **********************************
2026-03-19 14:54:45.122975 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.034)       0:00:14.546 ********
2026-03-19 14:54:45.148871 | controller | skipping: [instance]
2026-03-19 14:54:45.148915 | controller |
2026-03-19 14:54:45.148990 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-03-19 14:54:45.149080 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.026)       0:00:14.572 ********
2026-03-19 14:54:45.175143 | controller | skipping: [instance]
2026-03-19 14:54:45.175189 | controller |
2026-03-19 14:54:45.175330 | controller | TASK [Download the RPM] ********************************************************
2026-03-19 14:54:45.175420 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.026)       0:00:14.599 ********
2026-03-19 14:54:45.203103 | controller | skipping: [instance]
2026-03-19 14:54:45.203148 | controller |
2026-03-19 14:54:45.203648 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-03-19 14:54:45.228796 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.028)       0:00:14.627 ********
2026-03-19 14:54:45.228816 | controller | skipping: [instance]
2026-03-19 14:54:45.228884 | controller |
2026-03-19 14:54:45.228979 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-03-19 14:54:45.229071 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.025)       0:00:14.653 ********
2026-03-19 14:54:45.254649 | controller | skipping: [instance]
2026-03-19 14:54:45.254731 | controller |
2026-03-19 14:54:45.254852 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-03-19 14:54:45.254952 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.025)       0:00:14.678 ********
2026-03-19 14:54:45.281899 | controller | skipping: [instance]
2026-03-19 14:54:45.281983 | controller |
2026-03-19 14:54:45.282081 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-03-19 14:54:45.282173 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.027)       0:00:14.706 ********
2026-03-19 14:54:45.307930 | controller | skipping: [instance]
2026-03-19 14:54:45.308019 | controller |
2026-03-19 14:54:45.308123 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-03-19 14:54:45.308227 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.025)       0:00:14.732 ********
2026-03-19 14:54:45.474896 | controller | ok: [instance]
2026-03-19 14:54:45.474948 | controller |
2026-03-19 14:54:45.475061 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-03-19 14:54:45.475162 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.166)       0:00:14.899 ********
2026-03-19 14:54:45.698840 | controller | changed: [instance]
2026-03-19 14:54:45.698912 | controller |
2026-03-19 14:54:45.699026 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-03-19 14:54:45.699162 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.223)       0:00:15.123 ********
2026-03-19 14:54:45.918813 | controller | changed: [instance]
2026-03-19 14:54:45.918863 | controller |
2026-03-19 14:54:45.918965 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-03-19 14:54:45.919055 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.219)       0:00:15.343 ********
2026-03-19 14:54:45.939505 | controller | skipping: [instance]
2026-03-19 14:54:45.939591 | controller |
2026-03-19 14:54:45.939688 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-03-19 14:54:45.939820 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.020)       0:00:15.363 ********
2026-03-19 14:54:45.961258 | controller | skipping: [instance]
2026-03-19 14:54:45.961358 | controller |
2026-03-19 14:54:45.961463 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-03-19 14:54:45.961563 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.021)       0:00:15.385 ********
2026-03-19 14:54:45.983127 | controller | skipping: [instance]
2026-03-19 14:54:45.983233 | controller |
2026-03-19 14:54:45.983338 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-03-19 14:54:45.983436 | controller | Thursday 19 March 2026  14:54:45 +0000 (0:00:00.021)       0:00:15.407 ********
2026-03-19 14:54:46.004629 | controller | skipping: [instance]
2026-03-19 14:54:46.004721 | controller |
2026-03-19 14:54:46.004862 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-03-19 14:54:46.004962 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.021)       0:00:15.428 ********
2026-03-19 14:54:46.026205 | controller | skipping: [instance]
2026-03-19 14:54:46.026285 | controller |
2026-03-19 14:54:46.026386 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-03-19 14:54:46.026487 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.021)       0:00:15.450 ********
2026-03-19 14:54:46.047585 | controller | skipping: [instance]
2026-03-19 14:54:46.047679 | controller |
2026-03-19 14:54:46.047807 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-03-19 14:54:46.047907 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.021)       0:00:15.471 ********
2026-03-19 14:54:46.063826 | controller | skipping: [instance]
2026-03-19 14:54:46.064129 | controller |
2026-03-19 14:54:46.091607 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-03-19 14:54:46.091624 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.016)       0:00:15.487 ********
2026-03-19 14:54:46.091635 | controller | skipping: [instance]
2026-03-19 14:54:46.107407 | controller |
2026-03-19 14:54:46.107429 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-03-19 14:54:46.107438 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.027)       0:00:15.515 ********
2026-03-19 14:54:46.107449 | controller | skipping: [instance]
2026-03-19 14:54:46.126528 | controller |
2026-03-19 14:54:46.126545 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-03-19 14:54:46.126552 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.015)       0:00:15.531 ********
2026-03-19 14:54:46.126561 | controller | skipping: [instance]
2026-03-19 14:54:46.154609 | controller |
2026-03-19 14:54:46.154626 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2026-03-19 14:54:46.154633 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.019)       0:00:15.550 ********
2026-03-19 14:54:46.154642 | controller | skipping: [instance]
2026-03-19 14:54:46.183064 | controller |
2026-03-19 14:54:46.183082 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2026-03-19 14:54:46.183090 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.028)       0:00:15.578 ********
2026-03-19 14:54:46.183098 | controller | skipping: [instance]
2026-03-19 14:54:46.210627 | controller |
2026-03-19 14:54:46.210644 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2026-03-19 14:54:46.210651 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.028)       0:00:15.607 ********
2026-03-19 14:54:46.210660 | controller | skipping: [instance]
2026-03-19 14:54:46.237729 | controller |
2026-03-19 14:54:46.237759 | controller | TASK [test_deps : Install additional packages] *********************************
2026-03-19 14:54:46.237768 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.027)       0:00:15.634 ********
2026-03-19 14:54:46.237776 | controller | skipping: [instance]
2026-03-19 14:55:32.702350 | controller |
2026-03-19 14:55:32.702382 | controller | TASK [test_deps : Install selinux python libs] *********************************
2026-03-19 14:55:32.702390 | controller | Thursday 19 March 2026  14:54:46 +0000 (0:00:00.027)       0:00:15.661 ********
2026-03-19 14:55:32.702400 | controller | ok: [instance]
2026-03-19 14:55:33.828286 | controller |
2026-03-19 14:55:33.828314 | controller | TASK [test_deps : Install python yaml libs] ************************************
2026-03-19 14:55:33.828322 | controller | Thursday 19 March 2026  14:55:32 +0000 (0:00:46.464)       0:01:02.126 ********
2026-03-19 14:55:33.828331 | controller | ok: [instance]
2026-03-19 14:55:33.859084 | controller |
2026-03-19 14:55:33.859101 | controller | TASK [test_deps : Install extra packages] **************************************
2026-03-19 14:55:33.859108 | controller | Thursday 19 March 2026  14:55:33 +0000 (0:00:01.126)       0:01:03.252 ********
2026-03-19 14:55:33.859117 | controller | skipping: [instance]
2026-03-19 14:55:34.351980 | controller |
2026-03-19 14:55:34.351999 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-03-19 14:55:34.352006 | controller | Thursday 19 March 2026  14:55:33 +0000 (0:00:00.031)       0:01:03.283 ********
2026-03-19 14:55:34.352015 | controller | ok: [instance] => (item=tmp)
2026-03-19 14:55:35.468647 | controller | ok: [instance] => (item=artifacts/repositories)
2026-03-19 14:55:35.468675 | controller | ok: [instance] => (item=venv/repo_setup)
2026-03-19 14:55:35.468682 | controller |
2026-03-19 14:55:35.468689 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-03-19 14:55:35.468700 | controller | Thursday 19 March 2026  14:55:34 +0000 (0:00:00.492)       0:01:03.775 ********
2026-03-19 14:55:35.468710 | controller | ok: [instance]
2026-03-19 14:55:35.902410 | controller |
2026-03-19 14:55:35.902446 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-03-19 14:55:35.902455 | controller | Thursday 19 March 2026  14:55:35 +0000 (0:00:01.116)       0:01:04.892 ********
2026-03-19 14:55:35.902469 | controller | ok: [instance]
2026-03-19 14:55:36.926693 | controller |
2026-03-19 14:55:36.926723 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-03-19 14:55:36.926731 | controller | Thursday 19 March 2026  14:55:35 +0000 (0:00:00.433)       0:01:05.326 ********
2026-03-19 14:55:36.926756 | controller | ok: [instance]
2026-03-19 14:55:37.090943 | controller |
2026-03-19 14:55:37.090963 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-03-19 14:55:37.090971 | controller | Thursday 19 March 2026  14:55:36 +0000 (0:00:01.024)       0:01:06.350 ********
2026-03-19 14:55:37.090980 | controller | ok: [instance]
2026-03-19 14:55:37.111690 | controller |
2026-03-19 14:55:37.111709 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-03-19 14:55:37.111716 | controller | Thursday 19 March 2026  14:55:37 +0000 (0:00:00.164)       0:01:06.514 ********
2026-03-19 14:55:37.111725 | controller | skipping: [instance]
2026-03-19 14:55:37.866829 | controller |
2026-03-19 14:55:37.866863 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-03-19 14:55:37.866871 | controller | Thursday 19 March 2026  14:55:37 +0000 (0:00:00.020)       0:01:06.535 ********
2026-03-19 14:55:37.866881 | controller | changed: [instance]
2026-03-19 14:55:37.866899 | controller |
2026-03-19 14:55:37.866912 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-03-19 14:55:37.866928 | controller | Thursday 19 March 2026  14:55:37 +0000 (0:00:00.755)       0:01:07.290 ********
2026-03-19 14:55:37.903312 | controller | skipping: [instance]
2026-03-19 14:55:37.903388 | controller |
2026-03-19 14:55:37.903508 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-03-19 14:55:37.903601 | controller | Thursday 19 March 2026  14:55:37 +0000 (0:00:00.036)       0:01:07.327 ********
2026-03-19 14:55:37.939890 | controller | skipping: [instance]
2026-03-19 14:55:37.974821 | controller |
2026-03-19 14:55:37.974848 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-03-19 14:55:37.974855 | controller | Thursday 19 March 2026  14:55:37 +0000 (0:00:00.036)       0:01:07.363 ********
2026-03-19 14:55:37.974865 | controller | skipping: [instance]
2026-03-19 14:55:37.975096 | controller |
2026-03-19 14:55:37.975116 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-03-19 14:55:38.475283 | controller | Thursday 19 March 2026  14:55:37 +0000 (0:00:00.035)       0:01:07.398 ********
2026-03-19 14:55:38.475312 | controller | changed: [instance]
2026-03-19 14:55:38.816412 | controller |
2026-03-19 14:55:38.816452 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-03-19 14:55:38.816461 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.500)       0:01:07.899 ********
2026-03-19 14:55:38.816472 | controller | changed: [instance]
2026-03-19 14:55:38.843850 | controller |
2026-03-19 14:55:38.843889 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-03-19 14:55:38.843900 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.340)       0:01:08.240 ********
2026-03-19 14:55:38.843912 | controller | skipping: [instance]
2026-03-19 14:55:38.843944 | controller |
2026-03-19 14:55:38.844167 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-03-19 14:55:38.870650 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.027)       0:01:08.267 ********
2026-03-19 14:55:38.870670 | controller | skipping: [instance]
2026-03-19 14:55:38.897035 | controller |
2026-03-19 14:55:38.897049 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-03-19 14:55:38.897055 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.026)       0:01:08.294 ********
2026-03-19 14:55:38.897063 | controller | skipping: [instance]
2026-03-19 14:55:38.932415 | controller |
2026-03-19 14:55:38.932468 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-03-19 14:55:38.932493 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.026)       0:01:08.320 ********
2026-03-19 14:55:38.932511 | controller | ok: [instance]
2026-03-19 14:55:38.957620 | controller |
2026-03-19 14:55:38.957652 | controller | TASK [repo_setup : Create download directory] **********************************
2026-03-19 14:55:38.957665 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.035)       0:01:08.356 ********
2026-03-19 14:55:38.957682 | controller | skipping: [instance]
2026-03-19 14:55:38.981854 | controller |
2026-03-19 14:55:38.981894 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-03-19 14:55:38.981904 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.025)       0:01:08.381 ********
2026-03-19 14:55:38.981917 | controller | skipping: [instance]
2026-03-19 14:55:38.982043 | controller |
2026-03-19 14:55:38.982055 | controller | TASK [Download the RPM] ********************************************************
2026-03-19 14:55:38.982071 | controller | Thursday 19 March 2026  14:55:38 +0000 (0:00:00.024)       0:01:08.405 ********
2026-03-19 14:55:39.006414 | controller | skipping: [instance]
2026-03-19 14:55:39.030834 | controller |
2026-03-19 14:55:39.030866 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-03-19 14:55:39.030874 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.024)       0:01:08.430 ********
2026-03-19 14:55:39.030884 | controller | skipping: [instance]
2026-03-19 14:55:39.031016 | controller |
2026-03-19 14:55:39.031045 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-03-19 14:55:39.031064 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.024)       0:01:08.454 ********
2026-03-19 14:55:39.054667 | controller | skipping: [instance]
2026-03-19 14:55:39.079557 | controller |
2026-03-19 14:55:39.079572 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-03-19 14:55:39.079580 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.024)       0:01:08.478 ********
2026-03-19 14:55:39.079588 | controller | skipping: [instance]
2026-03-19 14:55:39.106789 | controller |
2026-03-19 14:55:39.106805 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-03-19 14:55:39.106812 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.024)       0:01:08.503 ********
2026-03-19 14:55:39.106820 | controller | skipping: [instance]
2026-03-19 14:55:39.106974 | controller |
2026-03-19 14:55:39.106986 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-03-19 14:55:39.275825 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.027)       0:01:08.530 ********
2026-03-19 14:55:39.275865 | controller | ok: [instance]
2026-03-19 14:55:39.275890 | controller |
2026-03-19 14:55:39.275897 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-03-19 14:55:39.275903 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.169)       0:01:08.699 ********
2026-03-19 14:55:39.458279 | controller | changed: [instance]
2026-03-19 14:55:39.657321 | controller |
2026-03-19 14:55:39.657345 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-03-19 14:55:39.657353 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.182)       0:01:08.882 ********
2026-03-19 14:55:39.657362 | controller | changed: [instance]
2026-03-19 14:55:39.678124 | controller |
2026-03-19 14:55:39.678144 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-03-19 14:55:39.678151 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.199)       0:01:09.081 ********
2026-03-19 14:55:39.678160 | controller | skipping: [instance]
2026-03-19 14:55:39.701337 | controller |
2026-03-19 14:55:39.701356 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-03-19 14:55:39.701364 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.020)       0:01:09.102 ********
2026-03-19 14:55:39.701373 | controller | skipping: [instance]
2026-03-19 14:55:39.724698 | controller |
2026-03-19 14:55:39.724716 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-03-19 14:55:39.724723 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.023)       0:01:09.125 ********
2026-03-19 14:55:39.724731 | controller | skipping: [instance]
2026-03-19 14:55:39.747525 | controller |
2026-03-19 14:55:39.747543 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-03-19 14:55:39.747550 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.023)       0:01:09.148 ********
2026-03-19 14:55:39.747559 | controller | skipping: [instance]
2026-03-19 14:55:39.771534 | controller |
2026-03-19 14:55:39.771550 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-03-19 14:55:39.771558 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.022)       0:01:09.171 ********
2026-03-19 14:55:39.771566 | controller | skipping: [instance]
2026-03-19 14:55:39.795822 | controller |
2026-03-19 14:55:39.795857 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-03-19 14:55:39.795865 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.023)       0:01:09.195 ********
2026-03-19 14:55:39.795877 | controller | skipping: [instance]
2026-03-19 14:55:40.052191 | controller |
2026-03-19 14:55:40.052231 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-03-19 14:55:40.052239 | controller | Thursday 19 March 2026  14:55:39 +0000 (0:00:00.024)       0:01:09.219 ********
2026-03-19 14:55:40.052250 | controller | ok: [instance]
2026-03-19 14:55:40.052268 | controller |
2026-03-19 14:55:40.052339 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-03-19 14:55:40.052432 | controller | Thursday 19 March 2026  14:55:40 +0000 (0:00:00.256)       0:01:09.476 ********
2026-03-19 14:55:41.512813 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos-addons.repo)
2026-03-19 14:55:41.513514 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos.repo)
2026-03-19 14:55:41.513543 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean.repo)
2026-03-19 14:55:41.513550 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean-master-testing.repo)
2026-03-19 14:55:41.513561 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-highavailability.repo)
2026-03-19 14:55:41.933279 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-powertools.repo)
2026-03-19 14:55:41.933305 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-appstream.repo)
2026-03-19 14:55:41.933313 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-baseos.repo)
2026-03-19 14:55:41.933318 | controller |
2026-03-19 14:55:41.933323 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-03-19 14:55:41.933333 | controller | Thursday 19 March 2026  14:55:41 +0000 (0:00:01.460)       0:01:10.936 ********
2026-03-19 14:55:41.933343 | controller | changed: [instance]
2026-03-19 14:55:42.141378 | controller |
2026-03-19 14:55:42.141396 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-03-19 14:55:42.141403 | controller | Thursday 19 March 2026  14:55:41 +0000 (0:00:00.420)       0:01:11.357 ********
2026-03-19 14:55:42.141412 | controller | changed: [instance]
2026-03-19 14:55:42.191647 | controller |
2026-03-19 14:55:42.191666 | controller | PLAY RECAP *********************************************************************
2026-03-19 14:55:42.191674 | controller | instance                   : ok=35   changed=17   unreachable=0    failed=0    skipped=50   rescued=0    ignored=0
2026-03-19 14:55:42.191679 | controller |
2026-03-19 14:55:42.191685 | controller | Thursday 19 March 2026  14:55:42 +0000 (0:00:00.206)       0:01:11.563 ********
2026-03-19 14:55:42.191690 | controller | ===============================================================================
2026-03-19 14:55:42.191695 | controller | test_deps : Install selinux python libs -------------------------------- 46.46s
2026-03-19 14:55:42.191700 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.46s
2026-03-19 14:55:42.191705 | controller | repo_setup : Remove existing repos from /etc/yum.repos.d directory ------ 1.46s
2026-03-19 14:55:42.191710 | controller | test_deps : Install python yaml libs ------------------------------------ 1.13s
2026-03-19 14:55:42.191715 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.12s
2026-03-19 14:55:42.191720 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.10s
2026-03-19 14:55:42.191729 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.02s
2026-03-19 14:55:42.191735 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.79s
2026-03-19 14:55:42.191767 | controller | Gathering Facts --------------------------------------------------------- 0.79s
2026-03-19 14:55:42.191776 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.77s
2026-03-19 14:55:42.191781 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.76s
2026-03-19 14:55:42.191786 | controller | repo_setup : Install repo-setup package --------------------------------- 0.64s
2026-03-19 14:55:42.191791 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.64s
2026-03-19 14:55:42.191796 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.52s
2026-03-19 14:55:42.191801 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.50s
2026-03-19 14:55:42.191806 | controller | repo_setup : Ensure directories are present ----------------------------- 0.49s
2026-03-19 14:55:42.191811 | controller | repo_setup : Ensure directories are present ----------------------------- 0.49s
2026-03-19 14:55:42.191816 | controller | repo_setup : Get repo-setup repository ---------------------------------- 0.43s
2026-03-19 14:55:42.191822 | controller | repo_setup : Cleanup existing metadata ---------------------------------- 0.42s
2026-03-19 14:55:42.191827 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.42s
2026-03-19 14:55:42.191835 | controller | INFO     Running default > converge
2026-03-19 14:55:42.651186 | controller |
2026-03-19 14:55:42.651356 | controller | PLAY [Converge] ****************************************************************
2026-03-19 14:55:42.651484 | controller |
2026-03-19 14:55:42.651610 | controller | TASK [Gathering Facts] *********************************************************
2026-03-19 14:55:42.651730 | controller | Thursday 19 March 2026  14:55:42 +0000 (0:00:00.031)       0:00:00.031 ********
2026-03-19 14:55:43.378770 | controller | ok: [instance]
2026-03-19 14:55:44.720321 | controller |
2026-03-19 14:55:44.720348 | controller | TASK [Clone neutron-tempest-plugin] ********************************************
2026-03-19 14:55:44.720356 | controller | Thursday 19 March 2026  14:55:43 +0000 (0:00:00.727)       0:00:00.759 ********
2026-03-19 14:55:44.720371 | controller | changed: [instance]
2026-03-19 14:55:44.744783 | controller |
2026-03-19 14:55:44.744807 | controller | TASK [Set cifmw_bop_openstack_project_path] ************************************
2026-03-19 14:55:44.744816 | controller | Thursday 19 March 2026  14:55:44 +0000 (0:00:01.341)       0:00:02.100 ********
2026-03-19 14:55:44.744828 | controller | ok: [instance]
2026-03-19 14:56:16.071786 | controller |
2026-03-19 14:56:16.071818 | controller | TASK [build_openstack_packages : Install Mock from DLRN repos] *****************
2026-03-19 14:56:16.071827 | controller | Thursday 19 March 2026  14:55:44 +0000 (0:00:00.024)       0:00:02.125 ********
2026-03-19 14:56:16.071837 | controller | changed: [instance]
2026-03-19 14:56:17.457833 | controller |
2026-03-19 14:56:17.457866 | controller | TASK [build_openstack_packages : Ensure DLRN package dependencies] *************
2026-03-19 14:56:17.457875 | controller | Thursday 19 March 2026  14:56:16 +0000 (0:00:31.326)       0:00:33.452 ********
2026-03-19 14:56:17.457886 | controller | changed: [instance]
2026-03-19 14:56:17.458242 | controller |
2026-03-19 14:56:17.767051 | controller | TASK [build_openstack_packages : Create mock group] ****************************
2026-03-19 14:56:17.767082 | controller | Thursday 19 March 2026  14:56:17 +0000 (0:00:01.386)       0:00:34.838 ********
2026-03-19 14:56:17.767094 | controller | ok: [instance]
2026-03-19 14:56:18.127208 | controller |
2026-03-19 14:56:18.127237 | controller | TASK [build_openstack_packages : Add user to mock group] ***********************
2026-03-19 14:56:18.127245 | controller | Thursday 19 March 2026  14:56:17 +0000 (0:00:00.309)       0:00:35.147 ********
2026-03-19 14:56:18.127256 | controller | changed: [instance]
2026-03-19 14:56:18.413047 | controller |
2026-03-19 14:56:18.413078 | controller | TASK [build_openstack_packages : Ensure DLRN dir is present] *******************
2026-03-19 14:56:18.413087 | controller | Thursday 19 March 2026  14:56:18 +0000 (0:00:00.360)       0:00:35.507 ********
2026-03-19 14:56:18.413097 | controller | changed: [instance]
2026-03-19 14:56:18.689760 | controller |
2026-03-19 14:56:18.689790 | controller | TASK [build_openstack_packages : Remove data files from previous runs] *********
2026-03-19 14:56:18.689799 | controller | Thursday 19 March 2026  14:56:18 +0000 (0:00:00.285)       0:00:35.793 ********
2026-03-19 14:56:18.689810 | controller | ok: [instance]
2026-03-19 14:56:22.328547 | controller |
2026-03-19 14:56:22.328575 | controller | TASK [build_openstack_packages : Create dlrn-venv] *****************************
2026-03-19 14:56:22.328584 | controller | Thursday 19 March 2026  14:56:18 +0000 (0:00:00.276)       0:00:36.070 ********
2026-03-19 14:56:22.328594 | controller | changed: [instance]
2026-03-19 14:56:22.354811 | controller |
2026-03-19 14:56:22.354830 | controller | TASK [build_openstack_packages : Fetch DLRN from source] ***********************
2026-03-19 14:56:22.354837 | controller | Thursday 19 March 2026  14:56:22 +0000 (0:00:03.638)       0:00:39.709 ********
2026-03-19 14:56:22.354846 | controller | skipping: [instance]
2026-03-19 14:56:22.381243 | controller |
2026-03-19 14:56:22.381266 | controller | TASK [build_openstack_packages : Install DLRN requirements] ********************
2026-03-19 14:56:22.381281 | controller | Thursday 19 March 2026  14:56:22 +0000 (0:00:00.026)       0:00:39.735 ********
2026-03-19 14:56:22.381293 | controller | skipping: [instance]
2026-03-19 14:56:22.381314 | controller |
2026-03-19 14:56:22.381411 | controller | TASK [build_openstack_packages : Install DLRN from source] *********************
2026-03-19 14:56:22.381510 | controller | Thursday 19 March 2026  14:56:22 +0000 (0:00:00.026)       0:00:39.762 ********
2026-03-19 14:56:22.407117 | controller | skipping: [instance]
2026-03-19 14:56:22.407181 | controller |
2026-03-19 14:56:22.407313 | controller | TASK [build_openstack_packages : Install DLRN and rdopkg from pip] *************
2026-03-19 14:56:22.407375 | controller | Thursday 19 March 2026  14:56:22 +0000 (0:00:00.026)       0:00:39.788 ********
2026-03-19 14:56:36.626274 | controller | changed: [instance]
2026-03-19 14:56:37.157643 | controller |
2026-03-19 14:56:37.157673 | controller | TASK [build_openstack_packages : Drop in the templated version of projects.ini] ***
2026-03-19 14:56:37.157681 | controller | Thursday 19 March 2026  14:56:36 +0000 (0:00:14.218)       0:00:54.006 ********
2026-03-19 14:56:37.157691 | controller | changed: [instance]
2026-03-19 14:56:37.493557 | controller |
2026-03-19 14:56:37.493576 | controller | TASK [build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir] ***
2026-03-19 14:56:37.493583 | controller | Thursday 19 March 2026  14:56:37 +0000 (0:00:00.531)       0:00:54.538 ********
2026-03-19 14:56:37.493592 | controller | changed: [instance]
2026-03-19 14:56:40.162274 | controller |
2026-03-19 14:56:40.162307 | controller | TASK [build_openstack_packages : Fetch local rdoinfo copy] *********************
2026-03-19 14:56:40.162315 | controller | Thursday 19 March 2026  14:56:37 +0000 (0:00:00.336)       0:00:54.874 ********
2026-03-19 14:56:40.162326 | controller | changed: [instance]
2026-03-19 14:56:40.185856 | controller |
2026-03-19 14:56:40.185910 | controller | TASK [build_openstack_packages : Downstream related tasks] *********************
2026-03-19 14:56:40.185922 | controller | Thursday 19 March 2026  14:56:40 +0000 (0:00:02.668)       0:00:57.542 ********
2026-03-19 14:56:40.185942 | controller | skipping: [instance]
2026-03-19 14:56:40.448805 | controller |
2026-03-19 14:56:40.448834 | controller | TASK [build_openstack_packages : Find all the repos files] *********************
2026-03-19 14:56:40.448842 | controller | Thursday 19 March 2026  14:56:40 +0000 (0:00:00.023)       0:00:57.566 ********
2026-03-19 14:56:40.448858 | controller | ok: [instance]
2026-03-19 14:56:40.448885 | controller |
2026-03-19 14:56:40.448979 | controller | TASK [build_openstack_packages : Create local mock config] *********************
2026-03-19 14:56:40.449070 | controller | Thursday 19 March 2026  14:56:40 +0000 (0:00:00.263)       0:00:57.829 ********
2026-03-19 14:56:40.622164 | controller | changed: [instance]
2026-03-19 14:56:40.622228 | controller |
2026-03-19 14:56:40.622325 | controller | TASK [build_openstack_packages : Remove last """ from local mock config] *******
2026-03-19 14:56:40.622425 | controller | Thursday 19 March 2026  14:56:40 +0000 (0:00:00.173)       0:00:58.003 ********
2026-03-19 14:56:40.792534 | controller | changed: [instance]
2026-03-19 14:56:40.792580 | controller |
2026-03-19 14:56:40.792693 | controller | TASK [build_openstack_packages : Append repos into mock local config] **********
2026-03-19 14:56:40.792865 | controller | Thursday 19 March 2026  14:56:40 +0000 (0:00:00.170)       0:00:58.173 ********
2026-03-19 14:56:40.847916 | 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-03-19 14:56:40.847970 | 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-03-19 14:56:40.847985 | 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-03-19 14:56:40.847994 | 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-03-19 14:56:40.848000 | 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-03-19 14:56:40.848007 | 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-03-19 14:56:40.848013 | controller |
2026-03-19 14:56:40.848023 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-03-19 14:56:41.079765 | controller | Thursday 19 March 2026  14:56:40 +0000 (0:00:00.054)       0:00:58.228 ********
2026-03-19 14:56:41.079800 | controller | ok: [instance]
2026-03-19 14:56:41.111047 | controller |
2026-03-19 14:56:41.111064 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-03-19 14:56:41.111071 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.232)       0:00:58.460 ********
2026-03-19 14:56:41.111079 | controller | ok: [instance]
2026-03-19 14:56:41.284851 | controller |
2026-03-19 14:56:41.284893 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-03-19 14:56:41.284902 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.031)       0:00:58.491 ********
2026-03-19 14:56:41.284912 | controller | ok: [instance]
2026-03-19 14:56:41.284936 | controller |
2026-03-19 14:56:41.284944 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-03-19 14:56:41.285025 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.174)       0:00:58.665 ********
2026-03-19 14:56:41.319244 | controller | ok: [instance]
2026-03-19 14:56:41.482706 | controller |
2026-03-19 14:56:41.482724 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-03-19 14:56:41.482733 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.034)       0:00:58.699 ********
2026-03-19 14:56:41.482759 | controller | ok: [instance]
2026-03-19 14:56:41.512843 | controller |
2026-03-19 14:56:41.512878 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-03-19 14:56:41.512910 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.163)       0:00:58.863 ********
2026-03-19 14:56:41.512924 | controller | ok: [instance]
2026-03-19 14:56:41.672284 | controller |
2026-03-19 14:56:41.672308 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-03-19 14:56:41.672316 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.030)       0:00:58.893 ********
2026-03-19 14:56:41.672325 | controller | ok: [instance]
2026-03-19 14:56:41.700818 | controller |
2026-03-19 14:56:41.700848 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-03-19 14:56:41.700856 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.159)       0:00:59.053 ********
2026-03-19 14:56:41.700871 | controller | ok: [instance]
2026-03-19 14:56:41.700901 | controller |
2026-03-19 14:56:41.700910 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-03-19 14:56:41.701013 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.028)       0:00:59.081 ********
2026-03-19 14:56:41.861100 | controller | ok: [instance]
2026-03-19 14:56:41.890276 | controller |
2026-03-19 14:56:41.890300 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-03-19 14:56:41.890311 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.160)       0:00:59.241 ********
2026-03-19 14:56:41.890323 | controller | ok: [instance]
2026-03-19 14:56:42.051596 | controller |
2026-03-19 14:56:42.051614 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-03-19 14:56:42.051621 | controller | Thursday 19 March 2026  14:56:41 +0000 (0:00:00.028)       0:00:59.270 ********
2026-03-19 14:56:42.051631 | controller | ok: [instance]
2026-03-19 14:56:42.080381 | controller |
2026-03-19 14:56:42.080405 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-03-19 14:56:42.080420 | controller | Thursday 19 March 2026  14:56:42 +0000 (0:00:00.161)       0:00:59.432 ********
2026-03-19 14:56:42.080433 | controller | ok: [instance]
2026-03-19 14:56:42.355140 | controller |
2026-03-19 14:56:42.355159 | controller | TASK [build_openstack_packages : Append repo_content ending with """ in mock local config at last] ***
2026-03-19 14:56:42.355167 | controller | Thursday 19 March 2026  14:56:42 +0000 (0:00:00.028)       0:00:59.460 ********
2026-03-19 14:56:42.355175 | controller | changed: [instance]
2026-03-19 14:56:44.188827 | controller |
2026-03-19 14:56:44.188854 | controller | TASK [build_openstack_packages : Check loop devices stat] **********************
2026-03-19 14:56:44.188862 | controller | Thursday 19 March 2026  14:56:42 +0000 (0:00:00.274)       0:00:59.735 ********
2026-03-19 14:56:44.188872 | controller | ok: [instance] => (item=0)
2026-03-19 14:56:44.189306 | controller | ok: [instance] => (item=1)
2026-03-19 14:56:44.189317 | controller | ok: [instance] => (item=2)
2026-03-19 14:56:44.189323 | controller | ok: [instance] => (item=3)
2026-03-19 14:56:44.189331 | controller | ok: [instance] => (item=4)
2026-03-19 14:56:44.189337 | controller | ok: [instance] => (item=5)
2026-03-19 14:56:44.189342 | controller | ok: [instance] => (item=6)
2026-03-19 14:56:44.189347 | controller | ok: [instance] => (item=7)
2026-03-19 14:56:44.189351 | controller | ok: [instance] => (item=8)
2026-03-19 14:56:44.189356 | controller | ok: [instance] => (item=9)
2026-03-19 14:56:44.189364 | controller | ok: [instance] => (item=10)
2026-03-19 14:56:44.223821 | controller | ok: [instance] => (item=11)
2026-03-19 14:56:44.223854 | controller |
2026-03-19 14:56:44.223862 | controller | TASK [build_openstack_packages : Set loop_devices_absent fact] *****************
2026-03-19 14:56:44.223869 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:01.832)       0:01:01.568 ********
2026-03-19 14:56:44.223879 | controller | ok: [instance]
2026-03-19 14:56:44.223902 | controller |
2026-03-19 14:56:44.223919 | controller | TASK [build_openstack_packages : Parse Zuul changes] ***************************
2026-03-19 14:56:44.224010 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.035)       0:01:01.604 ********
2026-03-19 14:56:44.256801 | controller | skipping: [instance]
2026-03-19 14:56:44.276552 | controller |
2026-03-19 14:56:44.276573 | controller | TASK [build_openstack_packages : Print Zuul change list] ***********************
2026-03-19 14:56:44.276583 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.032)       0:01:01.637 ********
2026-03-19 14:56:44.276594 | controller | ok: [instance] =>
2026-03-19 14:56:44.276797 | controller |   cifmw_bop_change_list: []
2026-03-19 14:56:44.276945 | controller |
2026-03-19 14:56:44.277079 | controller | TASK [build_openstack_packages : Build DLRN packages from zuul changes] ********
2026-03-19 14:56:44.277209 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.020)       0:01:01.657 ********
2026-03-19 14:56:44.290886 | controller | skipping: [instance]
2026-03-19 14:56:44.291063 | controller |
2026-03-19 14:56:44.291221 | controller | TASK [build_openstack_packages : Build DLRN packages from Local change] ********
2026-03-19 14:56:44.291375 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.014)       0:01:01.671 ********
2026-03-19 14:56:44.340239 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/run_dlrn.yml for instance
2026-03-19 14:56:44.340426 | controller |
2026-03-19 14:56:44.340594 | controller | TASK [build_openstack_packages : Set proper branch name for stable opendev branches] ***
2026-03-19 14:56:44.340774 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.049)       0:01:01.721 ********
2026-03-19 14:56:44.367666 | controller | skipping: [instance]
2026-03-19 14:56:44.367845 | controller |
2026-03-19 14:56:44.367998 | controller | TASK [build_openstack_packages : Set proper branch name for non-stable branches] ***
2026-03-19 14:56:44.368140 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.027)       0:01:01.748 ********
2026-03-19 14:56:44.399770 | controller | ok: [instance]
2026-03-19 14:56:44.399931 | controller |
2026-03-19 14:56:44.400073 | controller | TASK [build_openstack_packages : Set RDO release for master openstack release] ***
2026-03-19 14:56:44.400210 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.032)       0:01:01.780 ********
2026-03-19 14:56:44.420407 | controller | ok: [instance]
2026-03-19 14:56:44.420580 | controller |
2026-03-19 14:56:44.420760 | controller | TASK [build_openstack_packages : Set RDO release for non-master openstack release] ***
2026-03-19 14:56:44.420961 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.020)       0:01:01.801 ********
2026-03-19 14:56:44.437316 | controller | skipping: [instance]
2026-03-19 14:56:44.437479 | controller |
2026-03-19 14:56:44.437644 | controller | TASK [build_openstack_packages : Make sure /usr/share/rhn/RHN-ORG-TRUSTED-SSL-CERT exists (RHEL)] ***
2026-03-19 14:56:44.437831 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.016)       0:01:01.818 ********
2026-03-19 14:56:44.454390 | controller | skipping: [instance]
2026-03-19 14:56:44.454688 | controller |
2026-03-19 14:56:44.454885 | controller | TASK [build_openstack_packages : Override projects.ini settings] ***************
2026-03-19 14:56:44.455072 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.017)       0:01:01.835 ********
2026-03-19 14:56:44.961493 | controller | ok: [instance] => (item={'regexp': 'baseurl=.*', 'line': 'baseurl=https://trunk.rdoproject.org/centos9-master'})
2026-03-19 14:56:48.296726 | controller | ok: [instance] => (item={'regexp': 'distro=.*', 'line': 'distro=rpm-master'})
2026-03-19 14:56:48.296780 | controller | ok: [instance] => (item={'regexp': 'source=.*', 'line': 'source=master'})
2026-03-19 14:56:48.296788 | controller |
2026-03-19 14:56:48.296795 | controller | TASK [build_openstack_packages : Map project name to DLRN project name] ********
2026-03-19 14:56:48.296800 | controller | Thursday 19 March 2026  14:56:44 +0000 (0:00:00.506)       0:01:02.341 ********
2026-03-19 14:56:48.296809 | controller | ok: [instance]
2026-03-19 14:56:48.484043 | controller |
2026-03-19 14:56:48.484069 | controller | TASK [build_openstack_packages : Create data directory if doesn't exist yet] ***
2026-03-19 14:56:48.484077 | controller | Thursday 19 March 2026  14:56:48 +0000 (0:00:03.335)       0:01:05.677 ********
2026-03-19 14:56:48.484087 | controller | changed: [instance]
2026-03-19 14:56:48.654600 | controller |
2026-03-19 14:56:48.654624 | controller | TASK [build_openstack_packages : Check for existing python-neutron-tests-tempest] ***
2026-03-19 14:56:48.654632 | controller | Thursday 19 March 2026  14:56:48 +0000 (0:00:00.187)       0:01:05.864 ********
2026-03-19 14:56:48.654647 | controller | ok: [instance]
2026-03-19 14:56:49.181810 | controller |
2026-03-19 14:56:49.181838 | controller | TASK [build_openstack_packages : Sync python-neutron-tests-tempest from local repo] ***
2026-03-19 14:56:49.181846 | controller | Thursday 19 March 2026  14:56:48 +0000 (0:00:00.170)       0:01:06.035 ********
2026-03-19 14:56:49.181857 | controller | changed: [instance]
2026-03-19 14:56:49.215859 | controller |
2026-03-19 14:56:49.215898 | controller | TASK [build_openstack_packages : Symlink python-neutron-tests-tempest from Zuul clonned repos for upstream] ***
2026-03-19 14:56:49.215908 | controller | Thursday 19 March 2026  14:56:49 +0000 (0:00:00.527)       0:01:06.562 ********
2026-03-19 14:56:49.215921 | controller | skipping: [instance]
2026-03-19 14:56:49.215961 | controller |
2026-03-19 14:56:49.215984 | controller | TASK [build_openstack_packages : Update packages.yml to use zuul repo for python-neutron-tests-tempest] ***
2026-03-19 14:56:49.216098 | controller | Thursday 19 March 2026  14:56:49 +0000 (0:00:00.034)       0:01:06.596 ********
2026-03-19 14:56:49.247462 | controller | skipping: [instance]
2026-03-19 14:56:49.247518 | controller |
2026-03-19 14:56:49.247621 | controller | TASK [build_openstack_packages : Find the last commit from the clonned repo] ***
2026-03-19 14:56:49.247713 | controller | Thursday 19 March 2026  14:56:49 +0000 (0:00:00.031)       0:01:06.628 ********
2026-03-19 14:56:49.451904 | controller | changed: [instance]
2026-03-19 14:56:49.451994 | controller |
2026-03-19 14:56:49.452093 | controller | TASK [build_openstack_packages : Print the last commit of the git repo] ********
2026-03-19 14:56:49.452184 | controller | Thursday 19 March 2026  14:56:49 +0000 (0:00:00.204)       0:01:06.832 ********
2026-03-19 14:56:49.475808 | controller | ok: [instance] =>
2026-03-19 14:56:49.475915 | controller |   _commit.stdout: 673feca6bb87a36f0b322881a609bd10288f884c
2026-03-19 14:56:49.476011 | controller |
2026-03-19 14:56:49.476104 | controller | TASK [build_openstack_packages : Ensure distgit repo is absent, DLRN takes care of cloning based on config] ***
2026-03-19 14:56:49.476216 | controller | Thursday 19 March 2026  14:56:49 +0000 (0:00:00.023)       0:01:06.856 ********
2026-03-19 14:56:49.650279 | controller | ok: [instance]
2026-03-19 14:56:50.010870 | controller |
2026-03-19 14:56:50.010905 | controller | TASK [build_openstack_packages : Generate DLRN Script] *************************
2026-03-19 14:56:50.010914 | controller | Thursday 19 March 2026  14:56:49 +0000 (0:00:00.174)       0:01:07.030 ********
2026-03-19 14:56:50.010924 | controller | changed: [instance]
2026-03-19 14:56:50.010949 | controller |
2026-03-19 14:56:50.011088 | controller | TASK [build_openstack_packages : Print info about building] ********************
2026-03-19 14:56:50.011116 | controller | Thursday 19 March 2026  14:56:50 +0000 (0:00:00.360)       0:01:07.391 ********
2026-03-19 14:56:50.062464 | controller | ok: [instance] =>
2026-03-19 14:56:50.252847 | controller |   msg: Building change for python-neutron-tests-tempest
2026-03-19 14:56:50.252883 | controller |
2026-03-19 14:56:50.252893 | controller | TASK [build_openstack_packages : Ensure logs dir exists] ***********************
2026-03-19 14:56:50.252908 | controller | Thursday 19 March 2026  14:56:50 +0000 (0:00:00.051)       0:01:07.443 ********
2026-03-19 14:56:50.252920 | controller | ok: [instance]
2026-03-19 14:56:50.252940 | controller |
2026-03-19 14:56:50.252949 | controller | TASK [build_openstack_packages : Run DLRN] *************************************
2026-03-19 14:56:50.253042 | controller | Thursday 19 March 2026  14:56:50 +0000 (0:00:00.190)       0:01:07.633 ********
2026-03-19 15:00:55.983762 | controller | fatal: [instance]: FAILED! => changed=true
2026-03-19 15:00:55.988020 | controller |   cmd: |-
2026-03-19 15:00:55.988036 | 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-03-19 15:00:55.988044 | controller |   delta: '0:04:05.554224'
2026-03-19 15:00:55.988050 | controller |   end: '2026-03-19 15:00:55.961404'
2026-03-19 15:00:55.988055 | controller |   msg: non-zero return code
2026-03-19 15:00:55.988061 | controller |   rc: 1
2026-03-19 15:00:55.988067 | controller |   start: '2026-03-19 14:56:50.407180'
2026-03-19 15:00:55.988072 | controller |   stderr: ''
2026-03-19 15:00:55.988077 | controller |   stderr_lines: <omitted>
2026-03-19 15:00:55.988082 | controller |   stdout: ''
2026-03-19 15:00:55.988087 | controller |   stdout_lines: <omitted>
2026-03-19 15:00:55.988094 | controller |
2026-03-19 15:00:56.166290 | controller | TASK [build_openstack_packages : Copy DLRN artifacts] **************************
2026-03-19 15:00:56.166312 | controller | Thursday 19 March 2026  15:00:55 +0000 (0:04:05.735)       0:05:13.368 ********
2026-03-19 15:00:56.166323 | controller | changed: [instance]
2026-03-19 15:00:56.183213 | controller |
2026-03-19 15:00:56.183231 | controller | TASK [build_openstack_packages : Fail the execution] ***************************
2026-03-19 15:00:56.183238 | controller | Thursday 19 March 2026  15:00:56 +0000 (0:00:00.177)       0:05:13.546 ********
2026-03-19 15:00:56.183247 | controller | fatal: [instance]: FAILED! => changed=false
2026-03-19 15:00:56.186827 | controller |   msg: DLRN run failed
2026-03-19 15:00:56.186863 | controller |
2026-03-19 15:00:56.186888 | controller | PLAY RECAP *********************************************************************
2026-03-19 15:00:56.186896 | controller | instance                   : ok=54   changed=18   unreachable=0    failed=1    skipped=11   rescued=1    ignored=0
2026-03-19 15:00:56.186902 | controller |
2026-03-19 15:00:56.186908 | controller | Thursday 19 March 2026  15:00:56 +0000 (0:00:00.019)       0:05:13.566 ********
2026-03-19 15:00:56.186920 | controller | ===============================================================================
2026-03-19 15:00:56.186925 | controller | build_openstack_packages : Run DLRN ----------------------------------- 245.74s
2026-03-19 15:00:56.186931 | controller | build_openstack_packages : Install Mock from DLRN repos ---------------- 31.33s
2026-03-19 15:00:56.186936 | controller | build_openstack_packages : Install DLRN and rdopkg from pip ------------ 14.22s
2026-03-19 15:00:56.186942 | controller | build_openstack_packages : Create dlrn-venv ----------------------------- 3.64s
2026-03-19 15:00:56.186947 | controller | build_openstack_packages : Map project name to DLRN project name -------- 3.34s
2026-03-19 15:00:56.186955 | controller | build_openstack_packages : Fetch local rdoinfo copy --------------------- 2.67s
2026-03-19 15:00:56.186977 | controller | build_openstack_packages : Check loop devices stat ---------------------- 1.83s
2026-03-19 15:00:56.188167 | controller | build_openstack_packages : Ensure DLRN package dependencies ------------- 1.39s
2026-03-19 15:00:56.238197 | controller | Clone neutron-tempest-plugin -------------------------------------------- 1.34s
2026-03-19 15:00:56.238217 | controller | Gathering Facts --------------------------------------------------------- 0.73s
2026-03-19 15:00:56.238224 | controller | build_openstack_packages : Drop in the templated version of projects.ini --- 0.53s
2026-03-19 15:00:56.238230 | controller | build_openstack_packages : Sync python-neutron-tests-tempest from local repo --- 0.53s
2026-03-19 15:00:56.238235 | controller | build_openstack_packages : Override projects.ini settings --------------- 0.51s
2026-03-19 15:00:56.238240 | controller | build_openstack_packages : Generate DLRN Script ------------------------- 0.36s
2026-03-19 15:00:56.238245 | controller | build_openstack_packages : Add user to mock group ----------------------- 0.36s
2026-03-19 15:00:56.238250 | controller | build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir --- 0.34s
2026-03-19 15:00:56.238255 | controller | build_openstack_packages : Create mock group ---------------------------- 0.31s
2026-03-19 15:00:56.238260 | controller | build_openstack_packages : Ensure DLRN dir is present ------------------- 0.29s
2026-03-19 15:00:56.238265 | controller | build_openstack_packages : Remove data files from previous runs --------- 0.28s
2026-03-19 15:00:56.238270 | controller | build_openstack_packages : Append repo_content ending with """ in mock local config at last --- 0.27s
2026-03-19 15:00:56.238281 | 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-03-19 15:00:56.238670 | controller | WARNING  An error occurred during the test sequence action: 'converge'. Cleaning up.
2026-03-19 15:00:56.246757 | controller | INFO     Running default > cleanup
2026-03-19 15:00:56.247185 | controller | WARNING  Skipping, cleanup playbook not configured.
2026-03-19 15:00:56.254212 | controller | INFO     Running default > destroy
2026-03-19 15:00:56.254528 | controller | WARNING  Skipping, instances are delegated.
2026-03-19 15:00:56.254854 | controller | INFO     Pruning extra files from scenario ephemeral directory
2026-03-19 15:00:56.256251 | controller | INFO     Writing /tmp/report.html report.
2026-03-19 15:00:56.579755 | controller | ERROR
2026-03-19 15:00:56.579921 | controller | {
2026-03-19 15:00:56.579959 | controller |   "delta": "0:06:48.420773",
2026-03-19 15:00:56.579984 | controller |   "end": "2026-03-19 15:00:56.299545",
2026-03-19 15:00:56.580006 | controller |   "msg": "non-zero return code",
2026-03-19 15:00:56.580022 | controller |   "rc": 1,
2026-03-19 15:00:56.580039 | controller |   "start": "2026-03-19 14:54:07.878772"
2026-03-19 15:00:56.580054 | controller | }
failure
2026-03-19 15:00:56.624864 | 
2026-03-19 15:00:56.624911 | PLAY RECAP
2026-03-19 15:00:56.624950 | controller | ok: 3 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0
2026-03-19 15:00:56.624971 | 
2026-03-19 15:00:56.680865 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-03-19 15:00:56.681567 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-03-19 15:00:57.148893 | 
2026-03-19 15:00:57.148986 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-03-19 15:00:57.166982 | 
2026-03-19 15:00:57.167048 | TASK [Filter out host if needed]
2026-03-19 15:00:57.174593 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-03-19 15:00:57.178656 | 
2026-03-19 15:00:57.178717 | TASK [Ensure file is present]
2026-03-19 15:00:57.460701 | controller | ok
2026-03-19 15:00:57.466793 | 
2026-03-19 15:00:57.466851 | TASK [Manage molecule report file]
2026-03-19 15:00:57.990853 | controller | changed
2026-03-19 15:00:57.996393 | 
2026-03-19 15:00:57.996459 | TASK [Check if we get ci-framework-data basedir]
2026-03-19 15:00:58.181312 | controller | ok
2026-03-19 15:00:58.186610 | 
2026-03-19 15:00:58.186687 | TASK [Create ci-framework-data log directory for zuul]
2026-03-19 15:00:58.472752 | controller | changed
2026-03-19 15:00:58.478082 | 
2026-03-19 15:00:58.478151 | TASK [Copy ci-framework interesting files]
2026-03-19 15:00:58.658664 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-03-19 15:00:59.006729 | controller | changed
2026-03-19 15:00:59.011841 | 
2026-03-19 15:00:59.011906 | TASK [Get SELinux listing]
2026-03-19 15:00:59.533523 | controller | changed
2026-03-19 15:00:59.538736 | 
2026-03-19 15:00:59.538800 | TASK [Generate log index]
2026-03-19 15:01:00.115495 | controller | changed
2026-03-19 15:01:00.119987 | 
2026-03-19 15:01:00.120044 | TASK [Get some env related data]
2026-03-19 15:01:00.616773 | controller | /home/zuul/.local/bin/ansible
2026-03-19 15:01:01.154160 | controller | changed
2026-03-19 15:01:01.158586 | 
2026-03-19 15:01:01.158652 | TASK [Generate list of logs to collect in home directory]
2026-03-19 15:01:01.429461 | controller | ok: All paths examined
2026-03-19 15:01:01.433992 | 
2026-03-19 15:01:01.434052 | LOOP [Copy logs from home directory]
2026-03-19 15:01:01.753667 | controller | changed:
2026-03-19 15:01:01.753784 | controller | {
2026-03-19 15:01:01.753809 | controller |   "atime": 1773932027.0335162,
2026-03-19 15:01:01.753829 | controller |   "ctime": 1773932045.7856386,
2026-03-19 15:01:01.753846 | controller |   "dev": 64513,
2026-03-19 15:01:01.753863 | controller |   "gid": 1000,
2026-03-19 15:01:01.753879 | controller |   "gr_name": "zuul",
2026-03-19 15:01:01.753894 | controller |   "inode": 553297,
2026-03-19 15:01:01.753909 | controller |   "isblk": false,
2026-03-19 15:01:01.753923 | controller |   "ischr": false,
2026-03-19 15:01:01.753936 | controller |   "isdir": false,
2026-03-19 15:01:01.753950 | controller |   "isfifo": false,
2026-03-19 15:01:01.753963 | controller |   "isgid": false,
2026-03-19 15:01:01.753977 | controller |   "islnk": false,
2026-03-19 15:01:01.753990 | controller |   "isreg": true,
2026-03-19 15:01:01.754003 | controller |   "issock": false,
2026-03-19 15:01:01.754016 | controller |   "isuid": false,
2026-03-19 15:01:01.754028 | controller |   "mode": "0644",
2026-03-19 15:01:01.754041 | controller |   "mtime": 1773932045.7856386,
2026-03-19 15:01:01.754054 | controller |   "nlink": 1,
2026-03-19 15:01:01.754067 | controller |   "path": "/home/zuul/ansible.log",
2026-03-19 15:01:01.754082 | controller |   "pw_name": "zuul",
2026-03-19 15:01:01.754095 | controller |   "rgrp": true,
2026-03-19 15:01:01.754109 | controller |   "roth": true,
2026-03-19 15:01:01.754123 | controller |   "rusr": true,
2026-03-19 15:01:01.754136 | controller |   "size": 6749,
2026-03-19 15:01:01.754149 | controller |   "uid": 1000,
2026-03-19 15:01:01.754162 | controller |   "wgrp": false,
2026-03-19 15:01:01.754175 | controller |   "woth": false,
2026-03-19 15:01:01.754191 | controller |   "wusr": true,
2026-03-19 15:01:01.754204 | controller |   "xgrp": false,
2026-03-19 15:01:01.754219 | controller |   "xoth": false,
2026-03-19 15:01:01.754234 | controller |   "xusr": false
2026-03-19 15:01:01.754249 | controller | }
2026-03-19 15:01:01.769292 | 
2026-03-19 15:01:01.769475 | TASK [Copy crio stats log file]
2026-03-19 15:01:01.795646 | controller | skipping: Conditional result was False
2026-03-19 15:01:01.801423 | 
2026-03-19 15:01:01.801495 | TASK [Get SELinux related data]
2026-03-19 15:01:02.009414 | controller | <no matches>
2026-03-19 15:01:02.330853 | controller | ERROR
2026-03-19 15:01:02.331139 | controller | {
2026-03-19 15:01:02.331173 | controller |   "delta": "0:00:00.008889",
2026-03-19 15:01:02.331195 | controller |   "end": "2026-03-19 15:01:02.010307",
2026-03-19 15:01:02.331215 | controller |   "msg": "non-zero return code",
2026-03-19 15:01:02.331233 | controller |   "rc": 1,
2026-03-19 15:01:02.331251 | controller |   "start": "2026-03-19 15:01:02.001418"
2026-03-19 15:01:02.331301 | controller | }
2026-03-19 15:01:02.331331 | controller | ERROR: Ignoring Errors
2026-03-19 15:01:02.336299 | 
2026-03-19 15:01:02.336365 | TASK [Create system configuration directory]
2026-03-19 15:01:02.510807 | controller | changed
2026-03-19 15:01:02.515706 | 
2026-03-19 15:01:02.515767 | TASK [Get some of the system configurations]
2026-03-19 15:01:03.039407 | controller | changed
2026-03-19 15:01:03.044462 | 
2026-03-19 15:01:03.044526 | TASK [Copy generated documentation if available]
2026-03-19 15:01:03.070982 | controller | skipping: Conditional result was False
2026-03-19 15:01:03.076574 | 
2026-03-19 15:01:03.076644 | TASK [Copy generated AsciiDoc documentation if available]
2026-03-19 15:01:03.102514 | controller | skipping: Conditional result was False
2026-03-19 15:01:03.108007 | 
2026-03-19 15:01:03.108070 | TASK [Compress logs bigger than 2MB]
2026-03-19 15:01:03.636167 | controller | changed
2026-03-19 15:01:03.641392 | 
2026-03-19 15:01:03.641453 | TASK [Copy files from workspace on node]
2026-03-19 15:01:03.660774 | controller | ok
2026-03-19 15:01:03.681786 | 
2026-03-19 15:01:03.681852 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-19 15:01:03.695349 | controller | skipping: Conditional result was False
2026-03-19 15:01:03.701576 | 
2026-03-19 15:01:03.701660 | TASK [fetch-output : Set log path for single node]
2026-03-19 15:01:03.729522 | controller | ok
2026-03-19 15:01:03.733961 | 
2026-03-19 15:01:03.734034 | LOOP [fetch-output : Ensure local output dirs]
2026-03-19 15:01:03.913935 | controller -> localhost | ok: "/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/logs"
2026-03-19 15:01:03.914220 | controller -> localhost | changed: All items complete
2026-03-19 15:01:03.914247 | 
2026-03-19 15:01:04.074732 | controller -> localhost | changed: "/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/artifacts"
2026-03-19 15:01:04.236108 | controller -> localhost | changed: "/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/docs"
2026-03-19 15:01:04.252399 | 
2026-03-19 15:01:04.252505 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-19 15:01:04.798154 | controller | changed:
2026-03-19 15:01:04.798349 | controller | .d..t...... ./
2026-03-19 15:01:04.798381 | controller | >f+++++++++ README.html
2026-03-19 15:01:04.798403 | controller | >f+++++++++ ansible-execution.log
2026-03-19 15:01:04.798424 | controller | >f+++++++++ ansible.log
2026-03-19 15:01:04.798443 | controller | >f+++++++++ dmesg.log
2026-03-19 15:01:04.798460 | controller | >f+++++++++ installed-pkgs.log
2026-03-19 15:01:04.798481 | controller | >f+++++++++ python.log
2026-03-19 15:01:04.798501 | controller | >f+++++++++ registries.conf
2026-03-19 15:01:04.798519 | controller | >f+++++++++ report.html
2026-03-19 15:01:04.798538 | controller | >f+++++++++ selinux-denials.log
2026-03-19 15:01:04.798554 | controller | >f+++++++++ selinux-listing.log
2026-03-19 15:01:04.798570 | controller | cd+++++++++ ci-framework-data/
2026-03-19 15:01:04.798584 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-03-19 15:01:04.798599 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-03-19 15:01:04.798615 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-03-19 15:01:04.798637 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-03-19 15:01:04.798655 | controller | cd+++++++++ ci-framework-data/logs/
2026-03-19 15:01:04.798671 | controller | >f+++++++++ ci-framework-data/logs/dlrn.log
2026-03-19 15:01:04.798716 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-03-19 15:01:04.798734 | controller | cd+++++++++ ci-framework-data/logs/component_logs/
2026-03-19 15:01:04.798749 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/
2026-03-19 15:01:04.798764 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/67/
2026-03-19 15:01:04.798777 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/67/3f/
2026-03-19 15:01:04.798792 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/
2026-03-19 15:01:04.798807 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/build.log
2026-03-19 15:01:04.798821 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/commit.yaml
2026-03-19 15:01:04.798841 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/hw_info.log
2026-03-19 15:01:04.798856 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/installed_pkgs.log
2026-03-19 15:01:04.798869 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/mock.log
2026-03-19 15:01:04.798883 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/notes.log
2026-03-19 15:01:04.798897 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/python-neutron-tests-tempest-3.0.1-0.20260319145652.673feca.el9.src.rpm
2026-03-19 15:01:04.798914 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/root.log
2026-03-19 15:01:04.798928 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/rpmbuild.log
2026-03-19 15:01:04.798941 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/67/3f/673feca6bb87a36f0b322881a609bd10288f884c_dev/state.log
2026-03-19 15:01:04.798954 | controller | cd+++++++++ registries.conf.d/
2026-03-19 15:01:04.798967 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-03-19 15:01:04.798981 | controller | cd+++++++++ system-config/
2026-03-19 15:01:04.798994 | controller | cd+++++++++ system-config/libvirt/
2026-03-19 15:01:04.799006 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-03-19 15:01:04.799019 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-03-19 15:01:05.143610 | controller | changed: .d..t...... ./
2026-03-19 15:01:05.505058 | controller | changed: .d..t...... ./
2026-03-19 15:01:05.525447 | 
2026-03-19 15:01:05.525548 | TASK [Return artifact to Zuul]
2026-03-19 15:01:05.554378 | controller | ok
2026-03-19 15:01:05.573715 | 
2026-03-19 15:01:05.573782 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-03-19 15:01:05.573886 | 
2026-03-19 15:01:05.573913 | PLAY RECAP
2026-03-19 15:01:05.573953 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-03-19 15:01:05.573974 | 
2026-03-19 15:01:05.646660 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-03-19 15:01:05.647455 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-03-19 15:01:06.122588 | 
2026-03-19 15:01:06.122690 | PLAY [all]
2026-03-19 15:01:06.139217 | 
2026-03-19 15:01:06.139299 | TASK [include_role : fetch-output]
2026-03-19 15:01:06.167614 | controller | ok
2026-03-19 15:01:06.183546 | 
2026-03-19 15:01:06.183620 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-19 15:01:06.227851 | controller | skipping: Conditional result was False
2026-03-19 15:01:06.232853 | 
2026-03-19 15:01:06.232917 | TASK [fetch-output : Set log path for single node]
2026-03-19 15:01:06.260835 | controller | ok
2026-03-19 15:01:06.265597 | 
2026-03-19 15:01:06.265673 | LOOP [fetch-output : Ensure local output dirs]
2026-03-19 15:01:06.573995 | controller -> localhost | ok: "/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/logs"
2026-03-19 15:01:06.748691 | controller -> localhost | ok: "/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/artifacts"
2026-03-19 15:01:06.926811 | controller -> localhost | ok: "/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/docs"
2026-03-19 15:01:06.935426 | 
2026-03-19 15:01:06.935534 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-19 15:01:07.418570 | controller | ok
2026-03-19 15:01:07.418775 | controller | ok: All items complete
2026-03-19 15:01:07.418804 | 
2026-03-19 15:01:07.769848 | controller | ok
2026-03-19 15:01:08.114316 | controller | ok
2026-03-19 15:01:08.124321 | 
2026-03-19 15:01:08.124420 | TASK [include_role : fetch-output-openshift]
2026-03-19 15:01:08.137437 | controller | skipping: Conditional result was False
2026-03-19 15:01:08.142494 | 
2026-03-19 15:01:08.142562 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-19 15:01:08.449444 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006075
2026-03-19 15:01:08.619072 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.005773
2026-03-19 15:01:08.645205 | 
2026-03-19 15:01:08.645332 | PLAY [all]
2026-03-19 15:01:08.658534 | 
2026-03-19 15:01:08.658598 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-19 15:01:09.031770 | controller | changed
2026-03-19 15:01:09.051562 | 
2026-03-19 15:01:09.051611 | PLAY RECAP
2026-03-19 15:01:09.051668 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-03-19 15:01:09.051692 | 
2026-03-19 15:01:09.116449 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-03-19 15:01:09.117158 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-03-19 15:01:09.607255 | 
2026-03-19 15:01:09.607365 | PLAY [localhost]
2026-03-19 15:01:09.623159 | 
2026-03-19 15:01:09.623228 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-19 15:01:09.893206 | localhost | changed
2026-03-19 15:01:09.897208 | 
2026-03-19 15:01:09.897298 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-19 15:01:09.915073 | localhost | ok
2026-03-19 15:01:09.922591 | 
2026-03-19 15:01:09.922667 | TASK [add-fileserver : Create SSH private key tempfile]
2026-03-19 15:01:10.192384 | localhost | changed
2026-03-19 15:01:10.197567 | 
2026-03-19 15:01:10.197643 | TASK [add-fileserver : Create SSH private key from secret]
2026-03-19 15:01:10.679684 | localhost | changed
2026-03-19 15:01:10.684169 | 
2026-03-19 15:01:10.684230 | TASK [add-fileserver : Add fileserver ssh key]
2026-03-19 15:01:10.996207 | localhost | Identity added: /var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/tmp/ansible.fu1079f_ (/var/lib/zuul/builds/d53f3edb63104eda82e285c3913ed6fe/work/tmp/ansible.fu1079f_)
2026-03-19 15:01:10.996355 | localhost | ok: Runtime: 0:00:00.005967
2026-03-19 15:01:11.000294 | 
2026-03-19 15:01:11.000356 | TASK [add-fileserver : Remove SSH private key from disk]
2026-03-19 15:01:11.199232 | localhost | ok: Runtime: 0:00:00.004189
2026-03-19 15:01:11.203859 | 
2026-03-19 15:01:11.203931 | TASK [add-fileserver : Add fileserver to inventory]
2026-03-19 15:01:11.252023 | localhost | changed
2026-03-19 15:01:11.256670 | 
2026-03-19 15:01:11.256738 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-03-19 15:01:11.546822 | localhost | changed
2026-03-19 15:01:11.564364 | 
2026-03-19 15:01:11.564419 | PLAY [localhost]
2026-03-19 15:01:11.574513 | 
2026-03-19 15:01:11.574573 | TASK [Generate bulk log download script]
2026-03-19 15:01:11.592142 | localhost | ok
2026-03-19 15:01:11.602243 | 
2026-03-19 15:01:11.602321 | TASK [local-log-download : Check API endpoint is defined]
2026-03-19 15:01:11.629153 | localhost | ok: All assertions passed
2026-03-19 15:01:11.633104 | 
2026-03-19 15:01:11.633162 | TASK [local-log-download : Create download script]
2026-03-19 15:01:11.952023 | localhost -> localhost | changed
2026-03-19 15:01:11.959500 | 
2026-03-19 15:01:11.959558 | TASK [Register quick-download link]
2026-03-19 15:01:11.976342 | localhost | ok
2026-03-19 15:01:12.007090 | 
2026-03-19 15:01:12.007156 | PLAY [logserver.rdoproject.org]
2026-03-19 15:01:12.015759 | 
2026-03-19 15:01:12.015814 | TASK [Set zuul-log-path fact]
2026-03-19 15:01:12.031493 | logserver.rdoproject.org | ok
2026-03-19 15:01:12.039485 | 
2026-03-19 15:01:12.039547 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-19 15:01:12.055675 | logserver.rdoproject.org | ok
2026-03-19 15:01:12.060395 | 
2026-03-19 15:01:12.060455 | TASK [upload-logs : Create log directories]
2026-03-19 15:01:13.785599 | logserver.rdoproject.org | changed
2026-03-19 15:01:13.788416 | 
2026-03-19 15:01:13.788476 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-19 15:01:13.994201 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.003848
2026-03-19 15:01:13.998590 | 
2026-03-19 15:01:13.998663 | TASK [upload-logs : Upload logs to log server]
2026-03-19 15:01:15.556959 | logserver.rdoproject.org | Output suppressed because no_log was given
2026-03-19 15:01:15.559527 | 
2026-03-19 15:01:15.559588 | LOOP [upload-logs : Compress console log and json output]
2026-03-19 15:01:15.594592 | logserver.rdoproject.org | skipping: Conditional result was False
2026-03-19 15:01:15.601977 | logserver.rdoproject.org | skipping: Conditional result was False
2026-03-19 15:01:15.606669 | 
2026-03-19 15:01:15.606736 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-19 15:01:15.638231 | logserver.rdoproject.org | skipping: Conditional result was False
2026-03-19 15:01:15.638433 | 
2026-03-19 15:01:15.641515 | logserver.rdoproject.org | skipping: Conditional result was False
2026-03-19 15:01:15.653368 | 
2026-03-19 15:01:15.653430 | LOOP [upload-logs : Upload console log and json output]