2026-06-09 22:05:46.850839 | Job console starting
2026-06-09 22:05:46.989478 | Updating git repos
2026-06-09 22:05:47.037013 | Cloning repos into workspace
2026-06-09 22:05:49.243423 | Restoring repo states
2026-06-09 22:05:49.259257 | Merging changes
2026-06-09 22:05:50.468663 | Checking out repos
2026-06-09 22:05:51.150332 | Preparing playbooks
2026-06-09 22:05:56.050753 | Running Ansible setup
2026-06-09 22:06:01.757673 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-09 22:06:02.431700 | 
2026-06-09 22:06:02.431815 | PLAY [localhost]
2026-06-09 22:06:02.439320 | 
2026-06-09 22:06:02.439401 | TASK [Gathering Facts]
2026-06-09 22:06:03.398056 | localhost | ok
2026-06-09 22:06:03.410772 | 
2026-06-09 22:06:03.410976 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-09 22:06:03.884085 | localhost -> localhost | changed
2026-06-09 22:06:03.899920 | 
2026-06-09 22:06:03.900146 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-09 22:06:04.849508 | localhost -> localhost | changed
2026-06-09 22:06:04.855536 | 
2026-06-09 22:06:04.855604 | TASK [Setup log path fact]
2026-06-09 22:06:04.874458 | localhost | ok
2026-06-09 22:06:04.883780 | 
2026-06-09 22:06:04.883869 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-09 22:06:04.910408 | localhost | ok
2026-06-09 22:06:04.915428 | 
2026-06-09 22:06:04.915490 | TASK [emit-job-header : Print job information]
2026-06-09 22:06:04.942724 | # Job Information
2026-06-09 22:06:04.942896 | Ansible Version: 2.16.18
2026-06-09 22:06:04.942933 | Job: cifmw-molecule-ci_local_storage
2026-06-09 22:06:04.942961 | Pipeline: github-check
2026-06-09 22:06:04.942986 | Executor: 38.129.56.84
2026-06-09 22:06:04.943011 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3989
2026-06-09 22:06:04.943036 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/d8f/rdoproject.org/d8fe38b0c8ab481c940a58a130b937b3/
2026-06-09 22:06:04.943062 | Event ID: 2bc12bf0-644f-11f1-82a3-305ccb44cad7
2026-06-09 22:06:04.946742 | 
2026-06-09 22:06:04.946827 | LOOP [emit-job-header : Print node information]
2026-06-09 22:06:05.027207 | localhost | ok:
2026-06-09 22:06:05.027621 | localhost | # Node Information
2026-06-09 22:06:05.027689 | localhost | Inventory Hostname: controller
2026-06-09 22:06:05.027739 | localhost | Hostname: np0000069147
2026-06-09 22:06:05.027780 | localhost | Username: zuul
2026-06-09 22:06:05.027822 | localhost | Distro: CentOS 9
2026-06-09 22:06:05.027898 | localhost | Provider: vexxhost-nodepool-tripleo
2026-06-09 22:06:05.027938 | localhost | Region: RegionOne
2026-06-09 22:06:05.027973 | localhost | Label: centos-9-stream-crc-2-56-0-xl
2026-06-09 22:06:05.028008 | localhost | Product Name: OpenStack Nova
2026-06-09 22:06:05.028043 | localhost | Interface IP: 38.102.83.179
2026-06-09 22:06:05.043626 | 
2026-06-09 22:06:05.043784 | PLAY [all]
2026-06-09 22:06:05.054443 | 
2026-06-09 22:06:05.054571 | TASK [Gather network facts]
2026-06-09 22:06:05.610176 | controller | ok
2026-06-09 22:06:05.622116 | 
2026-06-09 22:06:05.622244 | TASK [include_role : start-zuul-console]
2026-06-09 22:06:05.647815 | controller | ok
2026-06-09 22:06:05.666589 | 
2026-06-09 22:06:05.666717 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-09 22:06:06.246737 | controller | ok
2026-06-09 22:06:06.260475 | 
2026-06-09 22:06:06.260697 | TASK [include_role : add-build-sshkey]
2026-06-09 22:06:06.295420 | controller | ok
2026-06-09 22:06:06.317952 | 
2026-06-09 22:06:06.318163 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-09 22:06:06.669985 | controller -> localhost | ok
2026-06-09 22:06:06.675954 | 
2026-06-09 22:06:06.676046 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-09 22:06:06.699508 | controller | ok
2026-06-09 22:06:06.727528 | controller | included: /var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-09 22:06:06.736844 | 
2026-06-09 22:06:06.737003 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-09 22:06:07.356702 | controller -> localhost | Generating public/private rsa key pair.
2026-06-09 22:06:07.357022 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/d8fe38b0c8ab481c940a58a130b937b3_id_rsa
2026-06-09 22:06:07.357089 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/d8fe38b0c8ab481c940a58a130b937b3_id_rsa.pub
2026-06-09 22:06:07.357139 | controller -> localhost | The key fingerprint is:
2026-06-09 22:06:07.357185 | controller -> localhost | SHA256:6CWBTsZaX23NCdsYa8h7NLjJBzqTPR6VS9LuVz2Gk2Q zuul-build-sshkey
2026-06-09 22:06:07.357228 | controller -> localhost | The key's randomart image is:
2026-06-09 22:06:07.357270 | controller -> localhost | +---[RSA 3072]----+
2026-06-09 22:06:07.357312 | controller -> localhost | |          o      |
2026-06-09 22:06:07.357355 | controller -> localhost | |   . . . = @ .   |
2026-06-09 22:06:07.357396 | controller -> localhost | |    * . B # =E   |
2026-06-09 22:06:07.357438 | controller -> localhost | |   * . O & oo o. |
2026-06-09 22:06:07.357480 | controller -> localhost | |  . . O S =  +.o.|
2026-06-09 22:06:07.357543 | controller -> localhost | |     . * *   .o .|
2026-06-09 22:06:07.357587 | controller -> localhost | |      . . . .    |
2026-06-09 22:06:07.357629 | controller -> localhost | |           .     |
2026-06-09 22:06:07.357669 | controller -> localhost | |                 |
2026-06-09 22:06:07.357710 | controller -> localhost | +----[SHA256]-----+
2026-06-09 22:06:07.357799 | controller -> localhost | ok: Runtime: 0:00:00.143110
2026-06-09 22:06:07.366359 | 
2026-06-09 22:06:07.366505 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-09 22:06:07.399722 | controller | ok
2026-06-09 22:06:07.418675 | controller | included: /var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-09 22:06:07.435070 | 
2026-06-09 22:06:07.435183 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-09 22:06:07.459374 | controller | skipping: Conditional result was False
2026-06-09 22:06:07.465330 | 
2026-06-09 22:06:07.465420 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-09 22:06:08.259373 | controller | changed
2026-06-09 22:06:08.268348 | 
2026-06-09 22:06:08.268531 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-09 22:06:08.798946 | controller | ok
2026-06-09 22:06:08.812274 | 
2026-06-09 22:06:08.812595 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-09 22:06:10.563068 | controller | changed
2026-06-09 22:06:10.566640 | 
2026-06-09 22:06:10.566707 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-09 22:06:12.278367 | controller | changed
2026-06-09 22:06:12.286936 | 
2026-06-09 22:06:12.287094 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-09 22:06:12.314833 | controller | skipping: Conditional result was False
2026-06-09 22:06:12.324489 | 
2026-06-09 22:06:12.324638 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-09 22:06:12.811651 | controller -> localhost | changed
2026-06-09 22:06:12.827174 | 
2026-06-09 22:06:12.827346 | TASK [add-build-sshkey : Add back temp key]
2026-06-09 22:06:13.168489 | controller -> localhost | Identity added: /var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/d8fe38b0c8ab481c940a58a130b937b3_id_rsa (zuul-build-sshkey)
2026-06-09 22:06:13.169435 | controller -> localhost | ok: Runtime: 0:00:00.017377
2026-06-09 22:06:13.177036 | 
2026-06-09 22:06:13.177161 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-09 22:06:13.633330 | controller | ok
2026-06-09 22:06:13.640616 | 
2026-06-09 22:06:13.640782 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-09 22:06:13.678085 | controller | skipping: Conditional result was False
2026-06-09 22:06:13.695084 | 
2026-06-09 22:06:13.695258 | TASK [include_role : validate-host]
2026-06-09 22:06:13.732564 | controller | ok
2026-06-09 22:06:13.762904 | 
2026-06-09 22:06:13.763038 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-09 22:06:13.804343 | controller | ok
2026-06-09 22:06:13.811190 | 
2026-06-09 22:06:13.811325 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-09 22:06:14.116558 | controller -> localhost | ok
2026-06-09 22:06:14.126118 | 
2026-06-09 22:06:14.126258 | TASK [validate-host : Collect information about the host]
2026-06-09 22:06:14.994161 | controller | ok
2026-06-09 22:06:15.009921 | 
2026-06-09 22:06:15.010061 | TASK [validate-host : Sanitize hostname]
2026-06-09 22:06:15.072451 | controller | ok
2026-06-09 22:06:15.080213 | 
2026-06-09 22:06:15.080348 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-09 22:06:15.595804 | controller -> localhost | changed
2026-06-09 22:06:15.607298 | 
2026-06-09 22:06:15.607442 | TASK [validate-host : Collect information about zuul worker]
2026-06-09 22:06:16.155458 | controller | ok
2026-06-09 22:06:16.162854 | 
2026-06-09 22:06:16.163044 | TASK [validate-host : Write out all zuul information for each host]
2026-06-09 22:06:16.649972 | controller -> localhost | changed
2026-06-09 22:06:16.666531 | 
2026-06-09 22:06:16.666715 | TASK [include_role : prepare-workspace-openshift]
2026-06-09 22:06:16.693141 | controller | skipping: Conditional result was False
2026-06-09 22:06:16.700680 | 
2026-06-09 22:06:16.700814 | TASK [include_role : remove-zuul-sshkey]
2026-06-09 22:06:16.725928 | controller | skipping: Conditional result was False
2026-06-09 22:06:16.734467 | 
2026-06-09 22:06:16.734627 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-09 22:06:17.244948 | controller | ok: "logs"
2026-06-09 22:06:17.245408 | controller | ok: All items complete
2026-06-09 22:06:17.245464 | 
2026-06-09 22:06:17.874378 | controller | ok: "artifacts"
2026-06-09 22:06:18.247397 | controller | ok: "docs"
2026-06-09 22:06:18.262593 | 
2026-06-09 22:06:18.262725 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-09 22:06:18.692972 | controller | changed: "logs"
2026-06-09 22:06:19.113600 | controller | changed: "artifacts"
2026-06-09 22:06:19.485235 | controller | changed: "docs"
2026-06-09 22:06:19.503303 | 
2026-06-09 22:06:19.503428 | PLAY RECAP
2026-06-09 22:06:19.503598 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-09 22:06:19.503658 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-09 22:06:19.503698 | 
2026-06-09 22:06:19.680726 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-09 22:06:19.684423 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-09 22:06:20.439972 | 
2026-06-09 22:06:20.440106 | PLAY [all]
2026-06-09 22:06:20.450838 | 
2026-06-09 22:06:20.450954 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-09 22:06:20.534096 | controller | ok
2026-06-09 22:06:20.541736 | 
2026-06-09 22:06:20.541980 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-09 22:06:21.158783 | controller | changed
2026-06-09 22:06:21.169166 | 
2026-06-09 22:06:21.169393 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-09 22:06:23.820806 | controller | changed
2026-06-09 22:06:23.837963 | 
2026-06-09 22:06:23.838165 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-06-09 22:06:24.478901 | controller | changed:
2026-06-09 22:06:24.479285 | controller | {
2026-06-09 22:06:24.479349 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-06-09 22:06:24.479415 | controller | }
2026-06-09 22:06:24.924163 | controller | changed:
2026-06-09 22:06:24.924328 | controller | {
2026-06-09 22:06:24.924385 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-06-09 22:06:24.924428 | controller | }
2026-06-09 22:06:25.366309 | controller | changed:
2026-06-09 22:06:25.366438 | controller | {
2026-06-09 22:06:25.366471 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-06-09 22:06:25.366497 | controller | }
2026-06-09 22:06:25.876736 | controller | changed:
2026-06-09 22:06:25.877008 | controller | {
2026-06-09 22:06:25.877100 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-06-09 22:06:25.877145 | controller | }
2026-06-09 22:06:26.309439 | controller | changed:
2026-06-09 22:06:26.309553 | controller | {
2026-06-09 22:06:26.309585 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-06-09 22:06:26.309610 | controller | }
2026-06-09 22:06:26.831545 | controller | changed:
2026-06-09 22:06:26.831768 | controller | {
2026-06-09 22:06:26.831834 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-06-09 22:06:26.831955 | controller | }
2026-06-09 22:06:27.252734 | controller | changed:
2026-06-09 22:06:27.253076 | controller | {
2026-06-09 22:06:27.253166 | 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-06-09 22:06:27.253215 | controller | }
2026-06-09 22:06:27.714623 | controller | changed:
2026-06-09 22:06:27.714792 | controller | {
2026-06-09 22:06:27.714845 | 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-06-09 22:06:27.714954 | controller | }
2026-06-09 22:06:28.125016 | controller | changed:
2026-06-09 22:06:28.125167 | controller | {
2026-06-09 22:06:28.125218 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-06-09 22:06:28.125259 | controller | }
2026-06-09 22:06:28.500579 | controller | changed:
2026-06-09 22:06:28.500735 | controller | {
2026-06-09 22:06:28.500787 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-06-09 22:06:28.500828 | controller | }
2026-06-09 22:06:28.940155 | controller | changed:
2026-06-09 22:06:28.940338 | controller | {
2026-06-09 22:06:28.940393 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-06-09 22:06:28.940436 | controller | }
2026-06-09 22:06:29.389109 | controller | changed:
2026-06-09 22:06:29.389278 | controller | {
2026-06-09 22:06:29.389327 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-06-09 22:06:29.389368 | controller | }
2026-06-09 22:06:29.792192 | controller | changed:
2026-06-09 22:06:29.792370 | controller | {
2026-06-09 22:06:29.792410 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com"
2026-06-09 22:06:29.792438 | controller | }
2026-06-09 22:06:30.290535 | controller | changed:
2026-06-09 22:06:30.290706 | controller | {
2026-06-09 22:06:30.290742 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-06-09 22:06:30.290771 | controller | }
2026-06-09 22:06:30.648337 | controller | changed:
2026-06-09 22:06:30.648497 | controller | {
2026-06-09 22:06:30.648520 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-06-09 22:06:30.648540 | controller | }
2026-06-09 22:06:31.150675 | controller | changed:
2026-06-09 22:06:31.150916 | controller | {
2026-06-09 22:06:31.151022 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-06-09 22:06:31.151101 | controller | }
2026-06-09 22:06:31.619552 | controller | changed:
2026-06-09 22:06:31.619748 | controller | {
2026-06-09 22:06:31.619798 | 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-06-09 22:06:31.619902 | controller | }
2026-06-09 22:06:32.050508 | controller | changed:
2026-06-09 22:06:32.050801 | controller | {
2026-06-09 22:06:32.050939 | 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-06-09 22:06:32.051028 | controller | }
2026-06-09 22:06:32.387634 | controller | changed:
2026-06-09 22:06:32.387833 | controller | {
2026-06-09 22:06:32.387929 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-06-09 22:06:32.387975 | controller | }
2026-06-09 22:06:32.774339 | controller | changed:
2026-06-09 22:06:32.774520 | controller | {
2026-06-09 22:06:32.774553 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-06-09 22:06:32.774581 | controller | }
2026-06-09 22:06:33.180703 | controller | changed:
2026-06-09 22:06:33.180925 | controller | {
2026-06-09 22:06:33.180988 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-06-09 22:06:33.181055 | controller | }
2026-06-09 22:06:33.651910 | controller | changed:
2026-06-09 22:06:33.652070 | controller | {
2026-06-09 22:06:33.652094 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-06-09 22:06:33.652113 | controller | }
2026-06-09 22:06:34.404321 | controller | changed:
2026-06-09 22:06:34.404522 | controller | {
2026-06-09 22:06:34.404574 | 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-06-09 22:06:34.404617 | controller | }
2026-06-09 22:06:34.912506 | controller | changed:
2026-06-09 22:06:34.912724 | controller | {
2026-06-09 22:06:34.912792 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-06-09 22:06:34.912883 | controller | }
2026-06-09 22:06:35.519381 | controller | changed:
2026-06-09 22:06:35.519584 | controller | {
2026-06-09 22:06:35.519654 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-06-09 22:06:35.519711 | controller | }
2026-06-09 22:06:36.074074 | controller | changed:
2026-06-09 22:06:36.074214 | controller | {
2026-06-09 22:06:36.074266 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-06-09 22:06:36.074302 | controller | }
2026-06-09 22:06:36.107509 | 
2026-06-09 22:06:36.107716 | TASK [Set timezone to UTC]
2026-06-09 22:06:36.884880 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-06-09 22:06:36.892394 | 
2026-06-09 22:06:36.892520 | TASK [Create nodepool directory]
2026-06-09 22:06:37.364810 | controller | changed
2026-06-09 22:06:37.376066 | 
2026-06-09 22:06:37.376235 | TASK [Create nodepool sub_nodes file]
2026-06-09 22:06:39.076978 | controller | changed
2026-06-09 22:06:39.086337 | 
2026-06-09 22:06:39.086524 | TASK [Create nodepool sub_nodes_private file]
2026-06-09 22:06:40.661284 | controller | changed
2026-06-09 22:06:40.666818 | 
2026-06-09 22:06:40.666942 | LOOP [Populate nodepool sub_nodes file]
2026-06-09 22:06:40.704227 | 
2026-06-09 22:06:40.704538 | LOOP [Populate nodepool sub_nodes_private file]
2026-06-09 22:06:40.742041 | 
2026-06-09 22:06:40.742314 | TASK [Create nodepool primary file]
2026-06-09 22:06:40.769649 | controller | skipping: Conditional result was False
2026-06-09 22:06:40.782038 | 
2026-06-09 22:06:40.782179 | TASK [Create nodepool node_private for this node]
2026-06-09 22:06:42.352778 | controller | changed
2026-06-09 22:06:42.363308 | 
2026-06-09 22:06:42.363453 | LOOP [Copy ssh keys to nodepool directory]
2026-06-09 22:06:42.977158 | controller | ok: Item: id_rsa Runtime: 0:00:00.018222
2026-06-09 22:06:42.977518 | 
2026-06-09 22:06:43.281166 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.019373
2026-06-09 22:06:43.291974 | 
2026-06-09 22:06:43.292116 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-06-09 22:06:45.170517 | controller | changed
2026-06-09 22:06:45.177974 | 
2026-06-09 22:06:45.178106 | TASK [Validate sudoers config after edits]
2026-06-09 22:06:45.643270 | controller | /etc/sudoers: parsed OK
2026-06-09 22:06:45.643385 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-06-09 22:06:45.643401 | controller | /etc/sudoers.d/zuul: parsed OK
2026-06-09 22:06:45.643411 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-06-09 22:06:45.729999 | controller | ok: Runtime: 0:00:00.007825
2026-06-09 22:06:45.738379 | 
2026-06-09 22:06:45.738511 | TASK [Show the environment passed in to job shell scripts]
2026-06-09 22:06:46.173906 | controller | SHELL=/bin/bash
2026-06-09 22:06:46.174071 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-06-09 22:06:46.174091 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-06-09 22:06:46.174104 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/89/3989/6b5d3ae5832a8daf8e75b53e155d530d9e9ce1db
2026-06-09 22:06:46.174114 | controller | PWD=/home/zuul
2026-06-09 22:06:46.174126 | controller | ZUUL_PIPELINE=github-check
2026-06-09 22:06:46.174138 | controller | LOGNAME=zuul
2026-06-09 22:06:46.174146 | controller | XDG_SESSION_TYPE=tty
2026-06-09 22:06:46.174153 | controller | _=/usr/bin/env
2026-06-09 22:06:46.174167 | controller | MOTD_SHOWN=pam
2026-06-09 22:06:46.174174 | controller | HOME=/home/zuul
2026-06-09 22:06:46.174182 | controller | LANG=en_US.UTF-8
2026-06-09 22:06:46.174190 | controller | SSH_CONNECTION=38.129.56.84 49184 38.102.83.179 22
2026-06-09 22:06:46.174200 | 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-06-09 22:06:46.174208 | controller | ZUUL_CHANGE_IDS=3989,6b5d3ae5832a8daf8e75b53e155d530d9e9ce1db
2026-06-09 22:06:46.174216 | controller | WORKSPACE=/home/zuul/workspace
2026-06-09 22:06:46.174224 | controller | XDG_SESSION_CLASS=user
2026-06-09 22:06:46.174231 | controller | SELINUX_ROLE_REQUESTED=
2026-06-09 22:06:46.174238 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-06-09 22:06:46.174245 | controller | USER=zuul
2026-06-09 22:06:46.174252 | controller | ZUUL_VOTING=True
2026-06-09 22:06:46.174260 | controller | BUILD_TIMEOUT=1800000
2026-06-09 22:06:46.174267 | controller | SELINUX_USE_CURRENT_RANGE=
2026-06-09 22:06:46.174274 | controller | SHLVL=1
2026-06-09 22:06:46.174281 | controller | ZUUL_PATCHSET=6b5d3ae5832a8daf8e75b53e155d530d9e9ce1db
2026-06-09 22:06:46.174289 | controller | XDG_SESSION_ID=1
2026-06-09 22:06:46.174296 | controller | ZUUL_BRANCH=main
2026-06-09 22:06:46.174303 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-06-09 22:06:46.174309 | controller | SSH_CLIENT=38.129.56.84 49184 22
2026-06-09 22:06:46.174322 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-06-09 22:06:46.174331 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-06-09 22:06:46.174338 | controller | which_declare=declare -f
2026-06-09 22:06:46.174346 | controller | PATH=/home/zuul/.crc/bin/oc:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-06-09 22:06:46.174353 | controller | SELINUX_LEVEL_REQUESTED=
2026-06-09 22:06:46.174360 | controller | ZUUL_CHANGE=3989
2026-06-09 22:06:46.174367 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-06-09 22:06:46.174374 | controller | ZUUL_UUID=d8fe38b0c8ab481c940a58a130b937b3
2026-06-09 22:06:46.174381 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-06-09 22:06:46.174389 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-06-09 22:06:46.174398 | controller | }
2026-06-09 22:06:46.286212 | controller | ok: Runtime: 0:00:00.009392
2026-06-09 22:06:46.294376 | 
2026-06-09 22:06:46.294503 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-06-09 22:06:46.320377 | controller | skipping: Conditional result was False
2026-06-09 22:06:46.329074 | 
2026-06-09 22:06:46.329208 | TASK [Symlink /home/zuul-worker/workspace]
2026-06-09 22:06:46.867692 | controller | skipping: Conditional result was False
2026-06-09 22:06:46.879169 | 
2026-06-09 22:06:46.879314 | TASK [Ensure legacy workspace directory]
2026-06-09 22:06:47.268046 | controller | changed
2026-06-09 22:06:47.270813 | 
2026-06-09 22:06:47.270954 | PLAY RECAP
2026-06-09 22:06:47.271052 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-09 22:06:47.271097 | 
2026-06-09 22:06:47.428056 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-09 22:06:47.430398 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-09 22:06:48.056892 | 
2026-06-09 22:06:48.057017 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-06-09 22:06:48.068660 | 
2026-06-09 22:06:48.068804 | TASK [Create zuul-output directory]
2026-06-09 22:06:48.746229 | controller | changed
2026-06-09 22:06:48.755019 | 
2026-06-09 22:06:48.755189 | TASK [Slurp Zuul inventory test]
2026-06-09 22:06:49.195800 | controller -> localhost | ok
2026-06-09 22:06:49.201638 | 
2026-06-09 22:06:49.201703 | TASK [Save zuul inventory]
2026-06-09 22:06:51.036110 | controller | changed
2026-06-09 22:06:51.043621 | 
2026-06-09 22:06:51.043749 | TASK [Save zuul vars without the change_message]
2026-06-09 22:06:52.647731 | controller | changed
2026-06-09 22:06:52.650719 | 
2026-06-09 22:06:52.650834 | PLAY RECAP
2026-06-09 22:06:52.650960 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-09 22:06:52.651005 | 
2026-06-09 22:06:52.834691 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-09 22:06:52.836990 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-09 22:06:53.520180 | 
2026-06-09 22:06:53.520313 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-06-09 22:06:53.532820 | 
2026-06-09 22:06:53.532923 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-06-09 22:06:53.551140 | controller | ok
2026-06-09 22:06:53.567214 | 
2026-06-09 22:06:53.567347 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-09 22:06:53.611244 | controller | skipping: Conditional result was False
2026-06-09 22:06:53.616545 | 
2026-06-09 22:06:53.616622 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-09 22:06:54.227686 | controller | ok
2026-06-09 22:06:54.236781 | 
2026-06-09 22:06:54.236949 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-09 22:06:55.721615 | controller | ok
2026-06-09 22:06:55.737232 | 
2026-06-09 22:06:55.737379 | TASK [Prepare workspace]
2026-06-09 22:06:55.766511 | controller | ok
2026-06-09 22:06:55.797339 | 
2026-06-09 22:06:55.797480 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-09 22:06:56.322731 | controller | ok
2026-06-09 22:06:56.328754 | 
2026-06-09 22:06:56.328828 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-09 22:06:59.195280 | controller | Output suppressed because no_log was given
2026-06-09 22:06:59.210924 | 
2026-06-09 22:06:59.211088 | LOOP [Create zuul-output directory]
2026-06-09 22:06:59.621558 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-06-09 22:06:59.944618 | controller | ok: "/home/zuul/zuul-output/logs"
2026-06-09 22:06:59.961820 | 
2026-06-09 22:06:59.962013 | TASK [Install required packages]
2026-06-09 22:07:17.732871 | controller | ok: Nothing to do
2026-06-09 22:07:17.737784 | 
2026-06-09 22:07:17.737947 | TASK [Install venv]
2026-06-09 22:08:45.254681 | controller | changed
2026-06-09 22:08:45.274773 | 
2026-06-09 22:08:45.274942 | PLAY RECAP
2026-06-09 22:08:45.275051 | controller | ok: 7 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-09 22:08:45.275097 | 
2026-06-09 22:08:45.441274 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-09 22:08:45.443964 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-09 22:08:46.102006 | 
2026-06-09 22:08:46.102132 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-06-09 22:08:46.112923 | 
2026-06-09 22:08:46.112995 | TASK [Gather required facts]
2026-06-09 22:08:46.821698 | controller | ok
2026-06-09 22:08:46.832104 | 
2026-06-09 22:08:46.832280 | TASK [Load environment var if instructed to]
2026-06-09 22:08:46.869985 | controller | skipping: Conditional result was False
2026-06-09 22:08:46.880064 | 
2026-06-09 22:08:46.880223 | TASK [Ensure group_vars dir exists]
2026-06-09 22:08:47.454453 | controller | ok
2026-06-09 22:08:47.464891 | 
2026-06-09 22:08:47.465028 | TASK [Print related variables]
2026-06-09 22:08:47.511361 | controller | ok:
2026-06-09 22:08:47.511706 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-06-09 22:08:47.511780 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_local_storage
2026-06-09 22:08:47.520361 | 
2026-06-09 22:08:47.520526 | TASK [Run molecule]
2026-06-09 22:08:48.845279 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-06-09 22:08:48.920161 | controller | INFO     Performing prerun with role_name_check=0...
2026-06-09 22:09:10.027102 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.028112 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.029173 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.030208 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.031280 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+6b5d3ae5 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.0.0+6b5d3ae5 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.032331 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.033347 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.034390 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.035409 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.036473 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.037469 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.038458 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.039468 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.040511 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.041519 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 22:09:10.063188 | controller | INFO     Running default > prepare
2026-06-09 22:09:10.797362 | controller |
2026-06-09 22:09:10.797560 | controller | PLAY [Prepare] *****************************************************************
2026-06-09 22:09:10.797766 | controller |
2026-06-09 22:09:10.797992 | controller | TASK [Gathering Facts] *********************************************************
2026-06-09 22:09:10.798219 | controller | Tuesday 09 June 2026  22:09:10 +0000 (0:00:00.019)       0:00:00.019 **********
2026-06-09 22:09:11.839588 | controller | ok: [instance]
2026-06-09 22:09:11.839722 | controller |
2026-06-09 22:09:11.839785 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2026-06-09 22:09:11.839927 | controller | Tuesday 09 June 2026  22:09:11 +0000 (0:00:01.043)       0:00:01.063 **********
2026-06-09 22:09:11.864873 | controller | skipping: [instance]
2026-06-09 22:09:11.864974 | controller |
2026-06-09 22:09:11.865120 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2026-06-09 22:09:11.865242 | controller | Tuesday 09 June 2026  22:09:11 +0000 (0:00:00.025)       0:00:01.088 **********
2026-06-09 22:09:11.939106 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2026-06-09 22:09:11.939352 | controller |
2026-06-09 22:09:11.939634 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2026-06-09 22:09:11.939955 | controller | Tuesday 09 June 2026  22:09:11 +0000 (0:00:00.073)       0:00:01.162 **********
2026-06-09 22:09:12.313954 | controller | ok: [instance]
2026-06-09 22:09:12.314116 | controller |
2026-06-09 22:09:12.314335 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2026-06-09 22:09:12.314536 | controller | Tuesday 09 June 2026  22:09:12 +0000 (0:00:00.374)       0:00:01.537 **********
2026-06-09 22:09:12.645929 | controller | ok: [instance]
2026-06-09 22:09:12.646016 | controller |
2026-06-09 22:09:12.646052 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2026-06-09 22:09:12.646197 | controller | Tuesday 09 June 2026  22:09:12 +0000 (0:00:00.332)       0:00:01.869 **********
2026-06-09 22:09:13.580295 | controller | ok: [instance] => (item=ubi-9-appstream)
2026-06-09 22:09:13.580374 | controller | ok: [instance] => (item=ubi-9-baseos)
2026-06-09 22:09:13.580393 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2026-06-09 22:09:13.580472 | controller |
2026-06-09 22:09:13.580571 | controller | TASK [Deploy repo-setup] *******************************************************
2026-06-09 22:09:13.580666 | controller | Tuesday 09 June 2026  22:09:13 +0000 (0:00:00.934)       0:00:02.804 **********
2026-06-09 22:09:13.679231 | controller |
2026-06-09 22:09:13.679390 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-06-09 22:09:13.679618 | controller | Tuesday 09 June 2026  22:09:13 +0000 (0:00:00.098)       0:00:02.902 **********
2026-06-09 22:09:14.362895 | controller | changed: [instance] => (item=tmp)
2026-06-09 22:09:14.362967 | controller | changed: [instance] => (item=artifacts/repositories)
2026-06-09 22:09:14.363001 | controller | changed: [instance] => (item=venv/repo_setup)
2026-06-09 22:09:14.363122 | controller |
2026-06-09 22:09:14.363209 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-06-09 22:09:14.363303 | controller | Tuesday 09 June 2026  22:09:14 +0000 (0:00:00.683)       0:00:03.586 **********
2026-06-09 22:09:15.445576 | controller | ok: [instance]
2026-06-09 22:09:15.445665 | controller |
2026-06-09 22:09:15.445737 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-06-09 22:09:15.445866 | controller | Tuesday 09 June 2026  22:09:15 +0000 (0:00:01.082)       0:00:04.668 **********
2026-06-09 22:09:16.448827 | controller | changed: [instance]
2026-06-09 22:09:16.448869 | controller |
2026-06-09 22:09:16.448879 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-06-09 22:09:16.448887 | controller | Tuesday 09 June 2026  22:09:16 +0000 (0:00:01.001)       0:00:05.670 **********
2026-06-09 22:09:30.469848 | controller | changed: [instance]
2026-06-09 22:09:30.469935 | controller |
2026-06-09 22:09:30.469983 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-06-09 22:09:30.470084 | controller | Tuesday 09 June 2026  22:09:30 +0000 (0:00:14.022)       0:00:19.693 **********
2026-06-09 22:09:31.254845 | controller | changed: [instance]
2026-06-09 22:09:31.254887 | controller |
2026-06-09 22:09:31.254928 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-06-09 22:09:31.255119 | controller | Tuesday 09 June 2026  22:09:31 +0000 (0:00:00.784)       0:00:20.478 **********
2026-06-09 22:09:31.286658 | controller | skipping: [instance]
2026-06-09 22:09:31.286715 | controller |
2026-06-09 22:09:31.286724 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-06-09 22:09:31.286732 | controller | Tuesday 09 June 2026  22:09:31 +0000 (0:00:00.031)       0:00:20.509 **********
2026-06-09 22:09:31.933365 | controller | changed: [instance]
2026-06-09 22:09:31.933395 | controller |
2026-06-09 22:09:31.933402 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-06-09 22:09:31.933408 | controller | Tuesday 09 June 2026  22:09:31 +0000 (0:00:00.646)       0:00:21.156 **********
2026-06-09 22:09:31.974862 | controller | skipping: [instance]
2026-06-09 22:09:31.975408 | controller |
2026-06-09 22:09:31.975444 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-06-09 22:09:31.975455 | controller | Tuesday 09 June 2026  22:09:31 +0000 (0:00:00.042)       0:00:21.198 **********
2026-06-09 22:09:32.031847 | controller | skipping: [instance]
2026-06-09 22:09:32.031880 | controller |
2026-06-09 22:09:32.032244 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-06-09 22:09:32.032279 | controller | Tuesday 09 June 2026  22:09:32 +0000 (0:00:00.056)       0:00:21.255 **********
2026-06-09 22:09:32.065787 | controller | skipping: [instance]
2026-06-09 22:09:32.066183 | controller |
2026-06-09 22:09:32.066199 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-06-09 22:09:32.066206 | controller | Tuesday 09 June 2026  22:09:32 +0000 (0:00:00.034)       0:00:21.289 **********
2026-06-09 22:09:32.578273 | controller | changed: [instance]
2026-06-09 22:09:32.578304 | controller |
2026-06-09 22:09:32.578310 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-06-09 22:09:32.578316 | controller | Tuesday 09 June 2026  22:09:32 +0000 (0:00:00.511)       0:00:21.801 **********
2026-06-09 22:09:33.191451 | controller | changed: [instance]
2026-06-09 22:09:33.191479 | controller |
2026-06-09 22:09:33.191485 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-06-09 22:09:33.191491 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.613)       0:00:22.414 **********
2026-06-09 22:09:33.230863 | controller | skipping: [instance]
2026-06-09 22:09:33.230898 | controller |
2026-06-09 22:09:33.230904 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-06-09 22:09:33.230912 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.039)       0:00:22.453 **********
2026-06-09 22:09:33.270840 | controller | skipping: [instance]
2026-06-09 22:09:33.271401 | controller |
2026-06-09 22:09:33.271430 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-06-09 22:09:33.271440 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.040)       0:00:22.493 **********
2026-06-09 22:09:33.310838 | controller | skipping: [instance]
2026-06-09 22:09:33.310878 | controller |
2026-06-09 22:09:33.310889 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-06-09 22:09:33.310902 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.039)       0:00:22.533 **********
2026-06-09 22:09:33.360325 | controller | ok: [instance]
2026-06-09 22:09:33.360427 | controller |
2026-06-09 22:09:33.360580 | controller | TASK [repo_setup : Create download directory] **********************************
2026-06-09 22:09:33.360706 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.050)       0:00:22.583 **********
2026-06-09 22:09:33.396919 | controller | skipping: [instance]
2026-06-09 22:09:33.397054 | controller |
2026-06-09 22:09:33.397223 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-06-09 22:09:33.397385 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.036)       0:00:22.620 **********
2026-06-09 22:09:33.432275 | controller | skipping: [instance]
2026-06-09 22:09:33.432707 | controller |
2026-06-09 22:09:33.433124 | controller | TASK [Download the RPM] ********************************************************
2026-06-09 22:09:33.433510 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.035)       0:00:22.655 **********
2026-06-09 22:09:33.468631 | controller | skipping: [instance]
2026-06-09 22:09:33.468909 | controller |
2026-06-09 22:09:33.469274 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-06-09 22:09:33.469433 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.036)       0:00:22.691 **********
2026-06-09 22:09:33.504968 | controller | skipping: [instance]
2026-06-09 22:09:33.505186 | controller |
2026-06-09 22:09:33.505487 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-06-09 22:09:33.505786 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.036)       0:00:22.728 **********
2026-06-09 22:09:33.542618 | controller | skipping: [instance]
2026-06-09 22:09:33.542857 | controller |
2026-06-09 22:09:33.543073 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-06-09 22:09:33.543324 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.037)       0:00:22.765 **********
2026-06-09 22:09:33.583121 | controller | skipping: [instance]
2026-06-09 22:09:33.583328 | controller |
2026-06-09 22:09:33.583566 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-06-09 22:09:33.583753 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.040)       0:00:22.806 **********
2026-06-09 22:09:33.614953 | controller | skipping: [instance]
2026-06-09 22:09:33.615010 | controller |
2026-06-09 22:09:33.615182 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-06-09 22:09:33.615251 | controller | Tuesday 09 June 2026  22:09:33 +0000 (0:00:00.031)       0:00:22.838 **********
2026-06-09 22:09:34.031572 | controller | ok: [instance]
2026-06-09 22:09:34.031632 | controller |
2026-06-09 22:09:34.031638 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-06-09 22:09:34.031644 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.416)       0:00:23.254 **********
2026-06-09 22:09:34.344829 | controller | changed: [instance]
2026-06-09 22:09:34.344872 | controller |
2026-06-09 22:09:34.344907 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-06-09 22:09:34.344919 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.312)       0:00:23.567 **********
2026-06-09 22:09:34.684274 | controller | changed: [instance]
2026-06-09 22:09:34.684328 | controller |
2026-06-09 22:09:34.684490 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-06-09 22:09:34.684654 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.338)       0:00:23.905 **********
2026-06-09 22:09:34.718183 | controller | skipping: [instance]
2026-06-09 22:09:34.718246 | controller |
2026-06-09 22:09:34.718425 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-06-09 22:09:34.718535 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.034)       0:00:23.940 **********
2026-06-09 22:09:34.750558 | controller | skipping: [instance]
2026-06-09 22:09:34.750618 | controller |
2026-06-09 22:09:34.750627 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-06-09 22:09:34.750634 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.029)       0:00:23.970 **********
2026-06-09 22:09:34.786038 | controller | skipping: [instance]
2026-06-09 22:09:34.786227 | controller |
2026-06-09 22:09:34.786425 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-06-09 22:09:34.786722 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.037)       0:00:24.008 **********
2026-06-09 22:09:34.859984 | controller | skipping: [instance]
2026-06-09 22:09:34.860047 | controller |
2026-06-09 22:09:34.860171 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-06-09 22:09:34.860303 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.074)       0:00:24.082 **********
2026-06-09 22:09:34.902468 | controller | skipping: [instance]
2026-06-09 22:09:34.902546 | controller |
2026-06-09 22:09:34.902653 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-06-09 22:09:34.902825 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.042)       0:00:24.125 **********
2026-06-09 22:09:34.938584 | controller | skipping: [instance]
2026-06-09 22:09:34.938623 | controller |
2026-06-09 22:09:34.938727 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-06-09 22:09:34.938827 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.035)       0:00:24.161 **********
2026-06-09 22:09:34.971744 | controller | skipping: [instance]
2026-06-09 22:09:34.971944 | controller |
2026-06-09 22:09:34.972116 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-06-09 22:09:34.972285 | controller | Tuesday 09 June 2026  22:09:34 +0000 (0:00:00.033)       0:00:24.194 **********
2026-06-09 22:09:35.031163 | controller | skipping: [instance]
2026-06-09 22:09:35.031238 | controller |
2026-06-09 22:09:35.031450 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-06-09 22:09:35.031637 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.058)       0:00:24.253 **********
2026-06-09 22:09:35.068366 | controller | skipping: [instance]
2026-06-09 22:09:35.068480 | controller |
2026-06-09 22:09:35.068639 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-06-09 22:09:35.068856 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.037)       0:00:24.291 **********
2026-06-09 22:09:35.109596 | controller | skipping: [instance]
2026-06-09 22:09:35.109727 | controller |
2026-06-09 22:09:35.109943 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2026-06-09 22:09:35.110115 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.041)       0:00:24.332 **********
2026-06-09 22:09:35.166436 | controller | skipping: [instance]
2026-06-09 22:09:35.166524 | controller |
2026-06-09 22:09:35.166674 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2026-06-09 22:09:35.166854 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.057)       0:00:24.390 **********
2026-06-09 22:09:35.222038 | controller | skipping: [instance]
2026-06-09 22:09:35.222198 | controller |
2026-06-09 22:09:35.222406 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2026-06-09 22:09:35.222604 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.055)       0:00:24.445 **********
2026-06-09 22:09:35.278426 | controller | skipping: [instance]
2026-06-09 22:09:35.278547 | controller |
2026-06-09 22:09:35.278777 | controller | TASK [test_deps : Install additional packages] *********************************
2026-06-09 22:09:35.278992 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.056)       0:00:24.501 **********
2026-06-09 22:09:35.336629 | controller | skipping: [instance]
2026-06-09 22:09:35.336790 | controller |
2026-06-09 22:09:35.336999 | controller | TASK [test_deps : Install selinux python libs] *********************************
2026-06-09 22:09:35.337181 | controller | Tuesday 09 June 2026  22:09:35 +0000 (0:00:00.057)       0:00:24.559 **********
2026-06-09 22:10:16.666103 | controller | ok: [instance]
2026-06-09 22:10:16.666832 | controller |
2026-06-09 22:10:16.666874 | controller | TASK [test_deps : Install python yaml libs] ************************************
2026-06-09 22:10:16.666885 | controller | Tuesday 09 June 2026  22:10:16 +0000 (0:00:41.329)       0:01:05.889 **********
2026-06-09 22:10:18.216651 | controller | ok: [instance]
2026-06-09 22:10:18.216698 | controller |
2026-06-09 22:10:18.216707 | controller | TASK [test_deps : Install extra packages] **************************************
2026-06-09 22:10:18.216713 | controller | Tuesday 09 June 2026  22:10:18 +0000 (0:00:01.550)       0:01:07.440 **********
2026-06-09 22:10:18.265857 | controller | skipping: [instance]
2026-06-09 22:10:18.265898 | controller |
2026-06-09 22:10:18.265908 | controller | TASK [Start CRC] ***************************************************************
2026-06-09 22:10:18.265917 | controller | Tuesday 09 June 2026  22:10:18 +0000 (0:00:00.048)       0:01:07.489 **********
2026-06-09 22:10:18.290847 | controller |
2026-06-09 22:10:18.290887 | controller | TASK [cifmw_helpers : Ensure CRC is started] ***********************************
2026-06-09 22:10:18.290931 | controller | Tuesday 09 June 2026  22:10:18 +0000 (0:00:00.025)       0:01:07.514 **********
2026-06-09 22:15:18.516799 | controller | changed: [instance]
2026-06-09 22:15:18.516863 | controller |
2026-06-09 22:15:18.516892 | controller | TASK [cifmw_helpers : Wait for cluster to stabilize after certificate renewal] ***
2026-06-09 22:15:18.516920 | controller | Tuesday 09 June 2026  22:15:18 +0000 (0:05:00.225)       0:06:07.739 **********
2026-06-09 22:15:20.003811 | controller | ok: [instance]
2026-06-09 22:15:20.003873 | controller |
2026-06-09 22:15:20.003880 | controller | TASK [Inject crc hostname/IP in hosts] *****************************************
2026-06-09 22:15:20.003886 | controller | Tuesday 09 June 2026  22:15:20 +0000 (0:00:01.487)       0:06:09.226 **********
2026-06-09 22:15:20.434919 | controller | changed: [instance]
2026-06-09 22:15:20.434976 | controller |
2026-06-09 22:15:20.434984 | controller | PLAY RECAP *********************************************************************
2026-06-09 22:15:20.434990 | controller | instance                   : ok=22   changed=11   unreachable=0    failed=0    skipped=30   rescued=0    ignored=0
2026-06-09 22:15:20.434996 | controller |
2026-06-09 22:15:20.435006 | controller | Tuesday 09 June 2026  22:15:20 +0000 (0:00:00.428)       0:06:09.655 **********
2026-06-09 22:15:20.435011 | controller | ===============================================================================
2026-06-09 22:15:20.435017 | controller | cifmw_helpers : Ensure CRC is started --------------------------------- 300.23s
2026-06-09 22:15:20.435022 | controller | test_deps : Install selinux python libs -------------------------------- 41.33s
2026-06-09 22:15:20.435028 | controller | repo_setup : Initialize python venv and install requirements ----------- 14.02s
2026-06-09 22:15:20.435033 | controller | test_deps : Install python yaml libs ------------------------------------ 1.55s
2026-06-09 22:15:20.435038 | controller | cifmw_helpers : Wait for cluster to stabilize after certificate renewal --- 1.49s
2026-06-09 22:15:20.435043 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.08s
2026-06-09 22:15:20.435048 | controller | Gathering Facts --------------------------------------------------------- 1.04s
2026-06-09 22:15:20.435053 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.00s
2026-06-09 22:15:20.435058 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.93s
2026-06-09 22:15:20.435063 | controller | repo_setup : Install repo-setup package --------------------------------- 0.78s
2026-06-09 22:15:20.435068 | controller | repo_setup : Ensure directories are present ----------------------------- 0.68s
2026-06-09 22:15:20.435073 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.65s
2026-06-09 22:15:20.435078 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.61s
2026-06-09 22:15:20.435082 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.51s
2026-06-09 22:15:20.435087 | controller | Inject crc hostname/IP in hosts ----------------------------------------- 0.43s
2026-06-09 22:15:20.435091 | controller | repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.42s
2026-06-09 22:15:20.435096 | controller | test_deps : Detect mirrors file ----------------------------------------- 0.37s
2026-06-09 22:15:20.435101 | controller | repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.34s
2026-06-09 22:15:20.435105 | controller | test_deps : Disable ubi host subscription-manager integration ----------- 0.33s
2026-06-09 22:15:20.435110 | controller | repo_setup : Use RDO proxy mirrors -------------------------------------- 0.31s
2026-06-09 22:15:20.541410 | controller | INFO     Running default > converge
2026-06-09 22:15:21.054513 | controller |
2026-06-09 22:15:21.054564 | controller | PLAY [Converge] ****************************************************************
2026-06-09 22:15:21.054576 | controller |
2026-06-09 22:15:21.054584 | controller | TASK [Gathering Facts] *********************************************************
2026-06-09 22:15:21.054592 | controller | Tuesday 09 June 2026  22:15:21 +0000 (0:00:00.015)       0:00:00.015 **********
2026-06-09 22:15:22.157318 | controller | ok: [instance]
2026-06-09 22:15:22.157367 | controller |
2026-06-09 22:15:22.157380 | controller | TASK [Check if new ssh keypair exists] *****************************************
2026-06-09 22:15:22.157389 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:01.103)       0:00:01.118 **********
2026-06-09 22:15:22.194948 | controller |
2026-06-09 22:15:22.194993 | controller | TASK [recognize_ssh_keypair : Check if id_ed25519 key exists] ******************
2026-06-09 22:15:22.195012 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:00.038)       0:00:01.156 **********
2026-06-09 22:15:22.627125 | controller | ok: [instance]
2026-06-09 22:15:22.627154 | controller |
2026-06-09 22:15:22.627163 | controller | TASK [recognize_ssh_keypair : Set fact if new keypair exists] ******************
2026-06-09 22:15:22.627171 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:00.432)       0:00:01.588 **********
2026-06-09 22:15:22.655582 | controller | ok: [instance]
2026-06-09 22:15:22.655614 | controller |
2026-06-09 22:15:22.655629 | controller | TASK [recognize_ssh_keypair : Set fact if new keypair does not exists] *********
2026-06-09 22:15:22.655636 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:00.028)       0:00:01.617 **********
2026-06-09 22:15:22.687805 | controller | skipping: [instance]
2026-06-09 22:15:22.687834 | controller |
2026-06-09 22:15:22.687843 | controller | TASK [Add the crc host dynamically] ********************************************
2026-06-09 22:15:22.687856 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:00.031)       0:00:01.649 **********
2026-06-09 22:15:22.722769 | controller | changed: [instance]
2026-06-09 22:15:22.722795 | controller |
2026-06-09 22:15:22.723146 | controller | TASK [Run ci_local_storage role] ***********************************************
2026-06-09 22:15:22.723159 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:00.035)       0:00:01.684 **********
2026-06-09 22:15:22.780818 | controller |
2026-06-09 22:15:22.780844 | controller | TASK [ci_local_storage : Create role needed directories] ***********************
2026-06-09 22:15:22.780851 | controller | Tuesday 09 June 2026  22:15:22 +0000 (0:00:00.057)       0:00:01.742 **********
2026-06-09 22:15:23.141851 | controller | changed: [instance]
2026-06-09 22:15:23.141878 | controller |
2026-06-09 22:15:23.141884 | controller | TASK [ci_local_storage : Create the cifmw_cls_namespace namespace"] ************
2026-06-09 22:15:23.141888 | controller | Tuesday 09 June 2026  22:15:23 +0000 (0:00:00.361)       0:00:02.104 **********
2026-06-09 22:15:24.324634 | controller | changed: [instance]
2026-06-09 22:15:24.324669 | controller |
2026-06-09 22:15:24.324709 | controller | TASK [ci_local_storage : Save storage manifests as artifacts] ******************
2026-06-09 22:15:24.324721 | controller | Tuesday 09 June 2026  22:15:24 +0000 (0:00:01.181)       0:00:03.285 **********
2026-06-09 22:15:24.893570 | controller | changed: [instance]
2026-06-09 22:15:24.893599 | controller |
2026-06-09 22:15:24.893604 | controller | TASK [ci_local_storage : Get k8s nodes] ****************************************
2026-06-09 22:15:24.893609 | controller | Tuesday 09 June 2026  22:15:24 +0000 (0:00:00.569)       0:00:03.855 **********
2026-06-09 22:15:26.434122 | controller | ok: [instance]
2026-06-09 22:15:26.434150 | controller |
2026-06-09 22:15:26.434155 | controller | TASK [ci_local_storage : Fetch hostnames for all hosts] ************************
2026-06-09 22:15:26.434159 | controller | Tuesday 09 June 2026  22:15:26 +0000 (0:00:01.540)       0:00:05.396 **********
2026-06-09 22:15:30.459774 | controller | changed: [instance] => (item=instance)
2026-06-09 22:15:30.459804 | controller | changed: [instance -> crc] => (item=crc)
2026-06-09 22:15:30.459809 | controller |
2026-06-09 22:15:30.459813 | controller | TASK [ci_local_storage : Set the hosts k8s ansible hosts] **********************
2026-06-09 22:15:30.459817 | controller | Tuesday 09 June 2026  22:15:30 +0000 (0:00:04.025)       0:00:09.421 **********
2026-06-09 22:15:30.545824 | controller | ok: [instance]
2026-06-09 22:15:30.545856 | controller |
2026-06-09 22:15:30.545862 | controller | TASK [ci_local_storage : Apply the storage class manifests] ********************
2026-06-09 22:15:30.545868 | controller | Tuesday 09 June 2026  22:15:30 +0000 (0:00:00.086)       0:00:09.507 **********
2026-06-09 22:15:33.501282 | controller | changed: [instance]
2026-06-09 22:15:33.501322 | controller |
2026-06-09 22:15:33.501332 | controller | TASK [ci_local_storage : Create directories on worker node] ********************
2026-06-09 22:15:33.501341 | controller | Tuesday 09 June 2026  22:15:33 +0000 (0:00:02.954)       0:00:12.462 **********
2026-06-09 22:15:33.553934 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_local_storage/tasks/worker_node_dirs.yml for instance => (item=crc)
2026-06-09 22:15:33.553964 | controller |
2026-06-09 22:15:33.553986 | controller | TASK [ci_local_storage : Perform action in the PV directory] *******************
2026-06-09 22:15:33.554007 | controller | Tuesday 09 June 2026  22:15:33 +0000 (0:00:00.053)       0:00:12.515 **********
2026-06-09 22:15:49.594125 | controller | changed: [instance -> crc] => (item=1)
2026-06-09 22:15:49.594207 | controller | changed: [instance -> crc] => (item=2)
2026-06-09 22:15:49.594386 | controller | changed: [instance -> crc] => (item=3)
2026-06-09 22:15:49.594400 | controller | changed: [instance -> crc] => (item=4)
2026-06-09 22:15:49.594408 | controller | changed: [instance -> crc] => (item=5)
2026-06-09 22:15:49.594418 | controller | changed: [instance -> crc] => (item=6)
2026-06-09 22:15:49.594453 | controller | changed: [instance -> crc] => (item=7)
2026-06-09 22:15:49.594788 | controller | changed: [instance -> crc] => (item=8)
2026-06-09 22:15:49.594817 | controller | changed: [instance -> crc] => (item=9)
2026-06-09 22:15:49.594826 | controller | changed: [instance -> crc] => (item=10)
2026-06-09 22:15:49.594834 | controller |
2026-06-09 22:15:49.595003 | controller | TASK [ci_local_storage : Generate pv related storage manifest file] ************
2026-06-09 22:15:49.595026 | controller | Tuesday 09 June 2026  22:15:49 +0000 (0:00:16.039)       0:00:28.555 **********
2026-06-09 22:15:50.113874 | controller | changed: [instance]
2026-06-09 22:15:50.113919 | controller |
2026-06-09 22:15:50.113930 | controller | TASK [ci_local_storage : Apply pv related storage manifest file] ***************
2026-06-09 22:15:50.113939 | controller | Tuesday 09 June 2026  22:15:50 +0000 (0:00:00.520)       0:00:29.075 **********
2026-06-09 22:15:51.290408 | controller | changed: [instance]
2026-06-09 22:15:51.290464 | controller |
2026-06-09 22:15:51.290475 | controller | TASK [Not create directories on crc] *******************************************
2026-06-09 22:15:51.290482 | controller | Tuesday 09 June 2026  22:15:51 +0000 (0:00:01.175)       0:00:30.250 **********
2026-06-09 22:16:04.373369 | controller | ok: [instance -> crc] => (item=1)
2026-06-09 22:16:04.373423 | controller | ok: [instance -> crc] => (item=2)
2026-06-09 22:16:04.373429 | controller | ok: [instance -> crc] => (item=3)
2026-06-09 22:16:04.373432 | controller | ok: [instance -> crc] => (item=4)
2026-06-09 22:16:04.373436 | controller | ok: [instance -> crc] => (item=5)
2026-06-09 22:16:04.373439 | controller | ok: [instance -> crc] => (item=6)
2026-06-09 22:16:04.373443 | controller | ok: [instance -> crc] => (item=7)
2026-06-09 22:16:04.373446 | controller | ok: [instance -> crc] => (item=8)
2026-06-09 22:16:04.373450 | controller | ok: [instance -> crc] => (item=9)
2026-06-09 22:16:04.373453 | controller | ok: [instance -> crc] => (item=10)
2026-06-09 22:16:04.373457 | controller |
2026-06-09 22:16:04.373462 | controller | TASK [Fail if we have a change] ************************************************
2026-06-09 22:16:04.373465 | controller | Tuesday 09 June 2026  22:16:04 +0000 (0:00:13.081)       0:00:43.332 **********
2026-06-09 22:16:04.392354 | controller | skipping: [instance]
2026-06-09 22:16:04.392743 | controller |
2026-06-09 22:16:04.393050 | controller | TASK [Get all pvs] *************************************************************
2026-06-09 22:16:04.393813 | controller | Tuesday 09 June 2026  22:16:04 +0000 (0:00:00.022)       0:00:43.354 **********
2026-06-09 22:16:05.760046 | controller | ok: [instance]
2026-06-09 22:16:05.760073 | controller |
2026-06-09 22:16:05.760078 | controller | TASK [Assert that we created the wanted number of pvs] *************************
2026-06-09 22:16:05.760083 | controller | Tuesday 09 June 2026  22:16:05 +0000 (0:00:01.367)       0:00:44.722 **********
2026-06-09 22:16:05.819452 | controller | ok: [instance] => changed=false
2026-06-09 22:16:05.819486 | controller |   msg: All assertions passed
2026-06-09 22:16:05.819498 | controller |
2026-06-09 22:16:05.819519 | controller | TASK [Gather names from pvs] ***************************************************
2026-06-09 22:16:05.819530 | controller | Tuesday 09 June 2026  22:16:05 +0000 (0:00:00.058)       0:00:44.780 **********
2026-06-09 22:16:05.864644 | controller | ok: [instance]
2026-06-09 22:16:05.864672 | controller |
2026-06-09 22:16:05.864713 | controller | TASK [Gather computed PV names] ************************************************
2026-06-09 22:16:05.864722 | controller | Tuesday 09 June 2026  22:16:05 +0000 (0:00:00.046)       0:00:44.826 **********
2026-06-09 22:16:06.003029 | controller | ok: [instance] => (item=1)
2026-06-09 22:16:06.003070 | controller | ok: [instance] => (item=2)
2026-06-09 22:16:06.003080 | controller | ok: [instance] => (item=3)
2026-06-09 22:16:06.003087 | controller | ok: [instance] => (item=4)
2026-06-09 22:16:06.003095 | controller | ok: [instance] => (item=5)
2026-06-09 22:16:06.003103 | controller | ok: [instance] => (item=6)
2026-06-09 22:16:06.003122 | controller | ok: [instance] => (item=7)
2026-06-09 22:16:06.003130 | controller | ok: [instance] => (item=8)
2026-06-09 22:16:06.003137 | controller | ok: [instance] => (item=9)
2026-06-09 22:16:06.003145 | controller | ok: [instance] => (item=10)
2026-06-09 22:16:06.003152 | controller |
2026-06-09 22:16:06.003161 | controller | TASK [Assert that the pvs names are correct] ***********************************
2026-06-09 22:16:06.003169 | controller | Tuesday 09 June 2026  22:16:05 +0000 (0:00:00.135)       0:00:44.962 **********
2026-06-09 22:16:06.156786 | controller | ok: [instance] => (item=['molecule-storage01-crc', 'molecule-storage01-crc']) => changed=false
2026-06-09 22:16:06.156827 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.156850 | controller |   item:
2026-06-09 22:16:06.156860 | controller |   - molecule-storage01-crc
2026-06-09 22:16:06.156868 | controller |   - molecule-storage01-crc
2026-06-09 22:16:06.156876 | controller |   msg: All assertions passed
2026-06-09 22:16:06.156885 | controller | ok: [instance] => (item=['molecule-storage02-crc', 'molecule-storage02-crc']) => changed=false
2026-06-09 22:16:06.156893 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.156902 | controller |   item:
2026-06-09 22:16:06.156910 | controller |   - molecule-storage02-crc
2026-06-09 22:16:06.156918 | controller |   - molecule-storage02-crc
2026-06-09 22:16:06.156927 | controller |   msg: All assertions passed
2026-06-09 22:16:06.156935 | controller | ok: [instance] => (item=['molecule-storage03-crc', 'molecule-storage03-crc']) => changed=false
2026-06-09 22:16:06.156943 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.156952 | controller |   item:
2026-06-09 22:16:06.156960 | controller |   - molecule-storage03-crc
2026-06-09 22:16:06.156968 | controller |   - molecule-storage03-crc
2026-06-09 22:16:06.156977 | controller |   msg: All assertions passed
2026-06-09 22:16:06.156985 | controller | ok: [instance] => (item=['molecule-storage04-crc', 'molecule-storage04-crc']) => changed=false
2026-06-09 22:16:06.156993 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157011 | controller |   item:
2026-06-09 22:16:06.157021 | controller |   - molecule-storage04-crc
2026-06-09 22:16:06.157029 | controller |   - molecule-storage04-crc
2026-06-09 22:16:06.157037 | controller |   msg: All assertions passed
2026-06-09 22:16:06.157046 | controller | ok: [instance] => (item=['molecule-storage05-crc', 'molecule-storage05-crc']) => changed=false
2026-06-09 22:16:06.157054 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157062 | controller |   item:
2026-06-09 22:16:06.157070 | controller |   - molecule-storage05-crc
2026-06-09 22:16:06.157079 | controller |   - molecule-storage05-crc
2026-06-09 22:16:06.157087 | controller |   msg: All assertions passed
2026-06-09 22:16:06.157095 | controller | ok: [instance] => (item=['molecule-storage06-crc', 'molecule-storage06-crc']) => changed=false
2026-06-09 22:16:06.157104 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157112 | controller |   item:
2026-06-09 22:16:06.157120 | controller |   - molecule-storage06-crc
2026-06-09 22:16:06.157128 | controller |   - molecule-storage06-crc
2026-06-09 22:16:06.157136 | controller |   msg: All assertions passed
2026-06-09 22:16:06.157145 | controller | ok: [instance] => (item=['molecule-storage07-crc', 'molecule-storage07-crc']) => changed=false
2026-06-09 22:16:06.157161 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157174 | controller |   item:
2026-06-09 22:16:06.157182 | controller |   - molecule-storage07-crc
2026-06-09 22:16:06.157190 | controller |   - molecule-storage07-crc
2026-06-09 22:16:06.157197 | controller |   msg: All assertions passed
2026-06-09 22:16:06.157204 | controller | ok: [instance] => (item=['molecule-storage08-crc', 'molecule-storage08-crc']) => changed=false
2026-06-09 22:16:06.157212 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157220 | controller |   item:
2026-06-09 22:16:06.157229 | controller |   - molecule-storage08-crc
2026-06-09 22:16:06.157237 | controller |   - molecule-storage08-crc
2026-06-09 22:16:06.157245 | controller |   msg: All assertions passed
2026-06-09 22:16:06.157254 | controller | ok: [instance] => (item=['molecule-storage09-crc', 'molecule-storage09-crc']) => changed=false
2026-06-09 22:16:06.157262 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157282 | controller |   item:
2026-06-09 22:16:06.157292 | controller |   - molecule-storage09-crc
2026-06-09 22:16:06.157300 | controller |   - molecule-storage09-crc
2026-06-09 22:16:06.157308 | controller |   msg: All assertions passed
2026-06-09 22:16:06.157325 | controller | ok: [instance] => (item=['molecule-storage10-crc', 'molecule-storage10-crc']) => changed=false
2026-06-09 22:16:06.157618 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.157967 | controller |   item:
2026-06-09 22:16:06.158248 | controller |   - molecule-storage10-crc
2026-06-09 22:16:06.158549 | controller |   - molecule-storage10-crc
2026-06-09 22:16:06.158866 | controller |   msg: All assertions passed
2026-06-09 22:16:06.159181 | controller |
2026-06-09 22:16:06.159511 | controller | TASK [Gather mountpoints from pvs] *********************************************
2026-06-09 22:16:06.159866 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.144)       0:00:45.106 **********
2026-06-09 22:16:06.204001 | controller | ok: [instance]
2026-06-09 22:16:06.204493 | controller |
2026-06-09 22:16:06.204722 | controller | TASK [Gather computed mountpoints] *********************************************
2026-06-09 22:16:06.204929 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.059)       0:00:45.166 **********
2026-06-09 22:16:06.320014 | controller | ok: [instance] => (item=1)
2026-06-09 22:16:06.320054 | controller | ok: [instance] => (item=2)
2026-06-09 22:16:06.320063 | controller | ok: [instance] => (item=3)
2026-06-09 22:16:06.320071 | controller | ok: [instance] => (item=4)
2026-06-09 22:16:06.320079 | controller | ok: [instance] => (item=5)
2026-06-09 22:16:06.320086 | controller | ok: [instance] => (item=6)
2026-06-09 22:16:06.320094 | controller | ok: [instance] => (item=7)
2026-06-09 22:16:06.320101 | controller | ok: [instance] => (item=8)
2026-06-09 22:16:06.320109 | controller | ok: [instance] => (item=9)
2026-06-09 22:16:06.320116 | controller | ok: [instance] => (item=10)
2026-06-09 22:16:06.320124 | controller |
2026-06-09 22:16:06.320132 | controller | TASK [Assert that the mountpoints in the pv are correct] ***********************
2026-06-09 22:16:06.320141 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.111)       0:00:45.278 **********
2026-06-09 22:16:06.408535 | controller | ok: [instance] => (item=['/mnt/openstack/pv01', '/mnt/openstack/pv01']) => changed=false
2026-06-09 22:16:06.408576 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.408587 | controller |   item:
2026-06-09 22:16:06.408595 | controller |   - /mnt/openstack/pv01
2026-06-09 22:16:06.408603 | controller |   - /mnt/openstack/pv01
2026-06-09 22:16:06.408611 | controller |   msg: All assertions passed
2026-06-09 22:16:06.408619 | controller | ok: [instance] => (item=['/mnt/openstack/pv02', '/mnt/openstack/pv02']) => changed=false
2026-06-09 22:16:06.408627 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.408634 | controller |   item:
2026-06-09 22:16:06.408642 | controller |   - /mnt/openstack/pv02
2026-06-09 22:16:06.408649 | controller |   - /mnt/openstack/pv02
2026-06-09 22:16:06.408657 | controller |   msg: All assertions passed
2026-06-09 22:16:06.408665 | controller | ok: [instance] => (item=['/mnt/openstack/pv03', '/mnt/openstack/pv03']) => changed=false
2026-06-09 22:16:06.408672 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.408705 | controller |   item:
2026-06-09 22:16:06.408714 | controller |   - /mnt/openstack/pv03
2026-06-09 22:16:06.408721 | controller |   - /mnt/openstack/pv03
2026-06-09 22:16:06.408729 | controller |   msg: All assertions passed
2026-06-09 22:16:06.408736 | controller | ok: [instance] => (item=['/mnt/openstack/pv04', '/mnt/openstack/pv04']) => changed=false
2026-06-09 22:16:06.408744 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.408751 | controller |   item:
2026-06-09 22:16:06.408759 | controller |   - /mnt/openstack/pv04
2026-06-09 22:16:06.408905 | controller |   - /mnt/openstack/pv04
2026-06-09 22:16:06.409193 | controller |   msg: All assertions passed
2026-06-09 22:16:06.409558 | controller | ok: [instance] => (item=['/mnt/openstack/pv05', '/mnt/openstack/pv05']) => changed=false
2026-06-09 22:16:06.409855 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.410129 | controller |   item:
2026-06-09 22:16:06.410382 | controller |   - /mnt/openstack/pv05
2026-06-09 22:16:06.410750 | controller |   - /mnt/openstack/pv05
2026-06-09 22:16:06.411036 | controller |   msg: All assertions passed
2026-06-09 22:16:06.411297 | controller | ok: [instance] => (item=['/mnt/openstack/pv06', '/mnt/openstack/pv06']) => changed=false
2026-06-09 22:16:06.411548 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.411837 | controller |   item:
2026-06-09 22:16:06.412096 | controller |   - /mnt/openstack/pv06
2026-06-09 22:16:06.412349 | controller |   - /mnt/openstack/pv06
2026-06-09 22:16:06.412612 | controller |   msg: All assertions passed
2026-06-09 22:16:06.412908 | controller | ok: [instance] => (item=['/mnt/openstack/pv07', '/mnt/openstack/pv07']) => changed=false
2026-06-09 22:16:06.413214 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.413479 | controller |   item:
2026-06-09 22:16:06.413770 | controller |   - /mnt/openstack/pv07
2026-06-09 22:16:06.414044 | controller |   - /mnt/openstack/pv07
2026-06-09 22:16:06.414376 | controller |   msg: All assertions passed
2026-06-09 22:16:06.414659 | controller | ok: [instance] => (item=['/mnt/openstack/pv08', '/mnt/openstack/pv08']) => changed=false
2026-06-09 22:16:06.414962 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.415218 | controller |   item:
2026-06-09 22:16:06.415500 | controller |   - /mnt/openstack/pv08
2026-06-09 22:16:06.415821 | controller |   - /mnt/openstack/pv08
2026-06-09 22:16:06.416080 | controller |   msg: All assertions passed
2026-06-09 22:16:06.416353 | controller | ok: [instance] => (item=['/mnt/openstack/pv09', '/mnt/openstack/pv09']) => changed=false
2026-06-09 22:16:06.416609 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.416897 | controller |   item:
2026-06-09 22:16:06.417190 | controller |   - /mnt/openstack/pv09
2026-06-09 22:16:06.417444 | controller |   - /mnt/openstack/pv09
2026-06-09 22:16:06.417733 | controller |   msg: All assertions passed
2026-06-09 22:16:06.418003 | controller | ok: [instance] => (item=['/mnt/openstack/pv10', '/mnt/openstack/pv10']) => changed=false
2026-06-09 22:16:06.418330 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.418640 | controller |   item:
2026-06-09 22:16:06.418940 | controller |   - /mnt/openstack/pv10
2026-06-09 22:16:06.419202 | controller |   - /mnt/openstack/pv10
2026-06-09 22:16:06.419456 | controller |   msg: All assertions passed
2026-06-09 22:16:06.419737 | controller |
2026-06-09 22:16:06.420009 | controller | TASK [Assert that the storage class is correct] ********************************
2026-06-09 22:16:06.420280 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.087)       0:00:45.365 **********
2026-06-09 22:16:06.515139 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.515443 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.515750 | controller |   item: molecule-storage
2026-06-09 22:16:06.516062 | controller |   msg: All assertions passed
2026-06-09 22:16:06.516323 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.516575 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.516864 | controller |   item: molecule-storage
2026-06-09 22:16:06.517124 | controller |   msg: All assertions passed
2026-06-09 22:16:06.517380 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.517633 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.517917 | controller |   item: molecule-storage
2026-06-09 22:16:06.518173 | controller |   msg: All assertions passed
2026-06-09 22:16:06.518427 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.518675 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.518970 | controller |   item: molecule-storage
2026-06-09 22:16:06.519222 | controller |   msg: All assertions passed
2026-06-09 22:16:06.519478 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.519773 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.520056 | controller |   item: molecule-storage
2026-06-09 22:16:06.520310 | controller |   msg: All assertions passed
2026-06-09 22:16:06.520563 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.520849 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.521105 | controller |   item: molecule-storage
2026-06-09 22:16:06.521354 | controller |   msg: All assertions passed
2026-06-09 22:16:06.521610 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.521894 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.522152 | controller |   item: molecule-storage
2026-06-09 22:16:06.522401 | controller |   msg: All assertions passed
2026-06-09 22:16:06.522737 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.522998 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.523246 | controller |   item: molecule-storage
2026-06-09 22:16:06.523506 | controller |   msg: All assertions passed
2026-06-09 22:16:06.523799 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.524075 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.524326 | controller |   item: molecule-storage
2026-06-09 22:16:06.524574 | controller |   msg: All assertions passed
2026-06-09 22:16:06.524861 | controller | ok: [instance] => (item=molecule-storage) => changed=false
2026-06-09 22:16:06.525118 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.525368 | controller |   item: molecule-storage
2026-06-09 22:16:06.525637 | controller |   msg: All assertions passed
2026-06-09 22:16:06.525912 | controller |
2026-06-09 22:16:06.526173 | controller | TASK [Assert that the storage capacity is correct] *****************************
2026-06-09 22:16:06.526441 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.111)       0:00:45.477 **********
2026-06-09 22:16:06.593331 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.593627 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.593927 | controller |   item: 100Mi
2026-06-09 22:16:06.594191 | controller |   msg: All assertions passed
2026-06-09 22:16:06.594446 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.594743 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.595006 | controller |   item: 100Mi
2026-06-09 22:16:06.595289 | controller |   msg: All assertions passed
2026-06-09 22:16:06.595549 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.595840 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.596097 | controller |   item: 100Mi
2026-06-09 22:16:06.596349 | controller |   msg: All assertions passed
2026-06-09 22:16:06.596613 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.599284 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.599566 | controller |   item: 100Mi
2026-06-09 22:16:06.599860 | controller |   msg: All assertions passed
2026-06-09 22:16:06.600121 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.600457 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.600750 | controller |   item: 100Mi
2026-06-09 22:16:06.601104 | controller |   msg: All assertions passed
2026-06-09 22:16:06.601359 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.601623 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.601922 | controller |   item: 100Mi
2026-06-09 22:16:06.602182 | controller |   msg: All assertions passed
2026-06-09 22:16:06.602434 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.602707 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.602974 | controller |   item: 100Mi
2026-06-09 22:16:06.603252 | controller |   msg: All assertions passed
2026-06-09 22:16:06.603507 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.604030 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.604300 | controller |   item: 100Mi
2026-06-09 22:16:06.604549 | controller |   msg: All assertions passed
2026-06-09 22:16:06.604841 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.605098 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.605352 | controller |   item: 100Mi
2026-06-09 22:16:06.605604 | controller |   msg: All assertions passed
2026-06-09 22:16:06.605897 | controller | ok: [instance] => (item=100Mi) => changed=false
2026-06-09 22:16:06.606154 | controller |   ansible_loop_var: item
2026-06-09 22:16:06.606406 | controller |   item: 100Mi
2026-06-09 22:16:06.606668 | controller |   msg: All assertions passed
2026-06-09 22:16:06.606956 | controller |
2026-06-09 22:16:06.607249 | controller | TASK [Delete the created pvs] **************************************************
2026-06-09 22:16:06.607509 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.078)       0:00:45.555 **********
2026-06-09 22:16:06.673939 | controller |
2026-06-09 22:16:06.674249 | controller | TASK [ci_local_storage : Get all pvs] ******************************************
2026-06-09 22:16:06.674541 | controller | Tuesday 09 June 2026  22:16:06 +0000 (0:00:00.080)       0:00:45.636 **********
2026-06-09 22:16:07.746814 | controller | ok: [instance]
2026-06-09 22:16:07.746883 | controller |
2026-06-09 22:16:07.747140 | controller | TASK [ci_local_storage : Export PVs as facts] **********************************
2026-06-09 22:16:07.747157 | controller | Tuesday 09 June 2026  22:16:07 +0000 (0:00:01.072)       0:00:46.709 **********
2026-06-09 22:16:07.808612 | controller | ok: [instance]
2026-06-09 22:16:07.808643 | controller |
2026-06-09 22:16:07.808650 | controller | TASK [ci_local_storage : Delete all pvs] ***************************************
2026-06-09 22:16:07.808664 | controller | Tuesday 09 June 2026  22:16:07 +0000 (0:00:00.061)       0:00:46.770 **********
2026-06-09 22:16:24.223118 | controller | changed: [instance] => (item=molecule-storage01-crc)
2026-06-09 22:16:24.223148 | controller | changed: [instance] => (item=molecule-storage02-crc)
2026-06-09 22:16:24.223153 | controller | changed: [instance] => (item=molecule-storage03-crc)
2026-06-09 22:16:24.223156 | controller | changed: [instance] => (item=molecule-storage04-crc)
2026-06-09 22:16:24.223160 | controller | changed: [instance] => (item=molecule-storage05-crc)
2026-06-09 22:16:24.223163 | controller | changed: [instance] => (item=molecule-storage06-crc)
2026-06-09 22:16:24.223166 | controller | changed: [instance] => (item=molecule-storage07-crc)
2026-06-09 22:16:24.223176 | controller | changed: [instance] => (item=molecule-storage08-crc)
2026-06-09 22:16:24.223180 | controller | changed: [instance] => (item=molecule-storage09-crc)
2026-06-09 22:16:24.223333 | controller | changed: [instance] => (item=molecule-storage10-crc)
2026-06-09 22:16:24.223554 | controller |
2026-06-09 22:16:24.223784 | controller | TASK [ci_local_storage : Get k8s nodes] ****************************************
2026-06-09 22:16:24.223992 | controller | Tuesday 09 June 2026  22:16:24 +0000 (0:00:16.412)       0:01:03.183 **********
2026-06-09 22:16:24.947592 | controller | ok: [instance]
2026-06-09 22:16:24.947655 | controller |
2026-06-09 22:16:24.947806 | controller | TASK [ci_local_storage : Fetch hostnames for all hosts] ************************
2026-06-09 22:16:24.947930 | controller | Tuesday 09 June 2026  22:16:24 +0000 (0:00:00.726)       0:01:03.910 **********
2026-06-09 22:16:26.709174 | controller | changed: [instance] => (item=instance)
2026-06-09 22:16:26.709239 | controller | changed: [instance -> crc] => (item=crc)
2026-06-09 22:16:26.709276 | controller |
2026-06-09 22:16:26.709315 | controller | TASK [ci_local_storage : Set the hosts k8s ansible hosts] **********************
2026-06-09 22:16:26.709435 | controller | Tuesday 09 June 2026  22:16:26 +0000 (0:00:01.761)       0:01:05.671 **********
2026-06-09 22:16:26.772128 | controller | ok: [instance]
2026-06-09 22:16:26.772143 | controller |
2026-06-09 22:16:26.772148 | controller | TASK [ci_local_storage : Delete directories on worker node] ********************
2026-06-09 22:16:26.772152 | controller | Tuesday 09 June 2026  22:16:26 +0000 (0:00:00.063)       0:01:05.734 **********
2026-06-09 22:16:26.822559 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_local_storage/tasks/worker_node_dirs.yml for instance => (item=crc)
2026-06-09 22:16:26.822587 | controller |
2026-06-09 22:16:26.822597 | controller | TASK [ci_local_storage : Perform action in the PV directory] *******************
2026-06-09 22:16:26.822604 | controller | Tuesday 09 June 2026  22:16:26 +0000 (0:00:00.050)       0:01:05.784 **********
2026-06-09 22:16:38.219356 | controller | changed: [instance -> crc] => (item=1)
2026-06-09 22:16:38.219421 | controller | changed: [instance -> crc] => (item=2)
2026-06-09 22:16:38.219432 | controller | changed: [instance -> crc] => (item=3)
2026-06-09 22:16:38.219440 | controller | changed: [instance -> crc] => (item=4)
2026-06-09 22:16:38.219448 | controller | changed: [instance -> crc] => (item=5)
2026-06-09 22:16:38.219456 | controller | changed: [instance -> crc] => (item=6)
2026-06-09 22:16:38.219464 | controller | changed: [instance -> crc] => (item=7)
2026-06-09 22:16:38.219472 | controller | changed: [instance -> crc] => (item=8)
2026-06-09 22:16:38.219479 | controller | changed: [instance -> crc] => (item=9)
2026-06-09 22:16:38.219487 | controller | changed: [instance -> crc] => (item=10)
2026-06-09 22:16:38.219495 | controller |
2026-06-09 22:16:38.219504 | controller | TASK [ci_local_storage : Remove the cifmw_cls_namespace namespace] *************
2026-06-09 22:16:38.219512 | controller | Tuesday 09 June 2026  22:16:38 +0000 (0:00:11.393)       0:01:17.178 **********
2026-06-09 22:17:01.010816 | controller | changed: [instance]
2026-06-09 22:17:01.010875 | controller |
2026-06-09 22:17:01.010887 | controller | TASK [Get all namespaces] ******************************************************
2026-06-09 22:17:01.010897 | controller | Tuesday 09 June 2026  22:17:01 +0000 (0:00:22.793)       0:01:39.971 **********
2026-06-09 22:17:01.931973 | controller | ok: [instance]
2026-06-09 22:17:01.932024 | controller |
2026-06-09 22:17:01.932035 | controller | TASK [Assert that the cifmw_cls_namespace ns is deleted] ***********************
2026-06-09 22:17:01.932050 | controller | Tuesday 09 June 2026  22:17:01 +0000 (0:00:00.922)       0:01:40.894 **********
2026-06-09 22:17:02.027025 | controller | ok: [instance] => changed=false
2026-06-09 22:17:02.027106 | controller |   msg: All assertions passed
2026-06-09 22:17:02.027229 | controller |
2026-06-09 22:17:02.027374 | controller | PLAY RECAP *********************************************************************
2026-06-09 22:17:02.027502 | controller | instance                   : ok=37   changed=13   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2026-06-09 22:17:02.027636 | controller |
2026-06-09 22:17:02.027787 | controller | Tuesday 09 June 2026  22:17:02 +0000 (0:00:00.095)       0:01:40.989 **********
2026-06-09 22:17:02.027906 | controller | ===============================================================================
2026-06-09 22:17:02.028032 | controller | ci_local_storage : Remove the cifmw_cls_namespace namespace ------------ 22.79s
2026-06-09 22:17:02.028174 | controller | ci_local_storage : Delete all pvs -------------------------------------- 16.41s
2026-06-09 22:17:02.028283 | controller | ci_local_storage : Perform action in the PV directory ------------------ 16.04s
2026-06-09 22:17:02.028406 | controller | Not create directories on crc ------------------------------------------ 13.08s
2026-06-09 22:17:02.028551 | controller | ci_local_storage : Perform action in the PV directory ------------------ 11.39s
2026-06-09 22:17:02.028714 | controller | ci_local_storage : Fetch hostnames for all hosts ------------------------ 4.03s
2026-06-09 22:17:02.028870 | controller | ci_local_storage : Apply the storage class manifests -------------------- 2.95s
2026-06-09 22:17:02.029155 | controller | ci_local_storage : Fetch hostnames for all hosts ------------------------ 1.76s
2026-06-09 22:17:02.029283 | controller | ci_local_storage : Get k8s nodes ---------------------------------------- 1.54s
2026-06-09 22:17:02.029409 | controller | Get all pvs ------------------------------------------------------------- 1.37s
2026-06-09 22:17:02.029567 | controller | ci_local_storage : Create the cifmw_cls_namespace namespace" ------------ 1.18s
2026-06-09 22:17:02.029735 | controller | ci_local_storage : Apply pv related storage manifest file --------------- 1.18s
2026-06-09 22:17:02.029832 | controller | Gathering Facts --------------------------------------------------------- 1.10s
2026-06-09 22:17:02.029972 | controller | ci_local_storage : Get all pvs ------------------------------------------ 1.07s
2026-06-09 22:17:02.030086 | controller | Get all namespaces ------------------------------------------------------ 0.92s
2026-06-09 22:17:02.030211 | controller | ci_local_storage : Get k8s nodes ---------------------------------------- 0.73s
2026-06-09 22:17:02.030333 | controller | ci_local_storage : Save storage manifests as artifacts ------------------ 0.57s
2026-06-09 22:17:02.030458 | controller | ci_local_storage : Generate pv related storage manifest file ------------ 0.52s
2026-06-09 22:17:02.030604 | controller | recognize_ssh_keypair : Check if id_ed25519 key exists ------------------ 0.43s
2026-06-09 22:17:02.030750 | controller | ci_local_storage : Create role needed directories ----------------------- 0.36s
2026-06-09 22:17:02.116113 | controller | INFO     Running default > cleanup
2026-06-09 22:17:02.116450 | controller | WARNING  Skipping, cleanup playbook not configured.
2026-06-09 22:17:02.116963 | controller | INFO     Writing /tmp/report.html report.
2026-06-09 22:17:02.682376 | controller | ok: Runtime: 0:08:14.103809
2026-06-09 22:17:02.689744 | 
2026-06-09 22:17:02.689816 | PLAY RECAP
2026-06-09 22:17:02.689902 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-09 22:17:02.689934 | 
2026-06-09 22:17:02.802769 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-09 22:17:02.804150 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-09 22:17:03.424122 | 
2026-06-09 22:17:03.424244 | PLAY [Ensure ci-framework-data base directories exist on all nodes]
2026-06-09 22:17:03.434736 | 
2026-06-09 22:17:03.434870 | TASK [Create ci-framework-data/logs directory if missing]
2026-06-09 22:17:04.005766 | controller | ok
2026-06-09 22:17:04.049394 | 
2026-06-09 22:17:04.049579 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-06-09 22:17:04.056246 | 
2026-06-09 22:17:04.056357 | TASK [Filter out host if needed]
2026-06-09 22:17:04.066136 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-06-09 22:17:04.070248 | 
2026-06-09 22:17:04.070325 | TASK [Ensure file is present]
2026-06-09 22:17:04.672260 | controller | ok
2026-06-09 22:17:04.684471 | 
2026-06-09 22:17:04.684615 | TASK [Manage molecule report file]
2026-06-09 22:17:05.730708 | controller | ok: Runtime: 0:00:00.006138
2026-06-09 22:17:05.736824 | 
2026-06-09 22:17:05.736952 | TASK [Check if we get ci-framework-data basedir]
2026-06-09 22:17:06.102812 | controller | ok
2026-06-09 22:17:06.111936 | 
2026-06-09 22:17:06.112165 | TASK [Create ci-framework-data log directory for zuul]
2026-06-09 22:17:06.461230 | controller | changed
2026-06-09 22:17:06.469928 | 
2026-06-09 22:17:06.470117 | TASK [Copy ci-framework interesting files]
2026-06-09 22:17:06.882721 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-06-09 22:17:07.018999 | controller | ok: Runtime: 0:00:00.019733
2026-06-09 22:17:07.026781 | 
2026-06-09 22:17:07.026983 | TASK [Get SELinux listing]
2026-06-09 22:17:07.575647 | controller | ok: Runtime: 0:00:00.012460
2026-06-09 22:17:07.584651 | 
2026-06-09 22:17:07.584824 | TASK [Generate log index]
2026-06-09 22:17:09.206871 | controller | changed
2026-06-09 22:17:09.211216 | 
2026-06-09 22:17:09.211284 | TASK [Get some env related data]
2026-06-09 22:17:10.271422 | controller | /home/zuul/.local/bin/ansible
2026-06-09 22:17:11.240506 | controller | ok: Runtime: 0:00:01.498310
2026-06-09 22:17:11.290407 | 
2026-06-09 22:17:11.290587 | TASK [Generate list of logs to collect in home directory]
2026-06-09 22:17:11.734818 | controller | ok: All paths examined
2026-06-09 22:17:11.740670 | 
2026-06-09 22:17:11.740762 | LOOP [Copy logs from home directory]
2026-06-09 22:17:12.687505 | controller | changed:
2026-06-09 22:17:12.687965 | controller | {
2026-06-09 22:17:12.688038 | controller |   "atime": 1777967689.47849,
2026-06-09 22:17:12.688081 | controller |   "ctime": 1777968154.1714108,
2026-06-09 22:17:12.688117 | controller |   "dev": 64513,
2026-06-09 22:17:12.688152 | controller |   "gid": 1000,
2026-06-09 22:17:12.688186 | controller |   "gr_name": "zuul",
2026-06-09 22:17:12.688220 | controller |   "inode": 236288,
2026-06-09 22:17:12.688256 | controller |   "isblk": false,
2026-06-09 22:17:12.688291 | controller |   "ischr": false,
2026-06-09 22:17:12.688324 | controller |   "isdir": false,
2026-06-09 22:17:12.688357 | controller |   "isfifo": false,
2026-06-09 22:17:12.688390 | controller |   "isgid": false,
2026-06-09 22:17:12.688423 | controller |   "islnk": false,
2026-06-09 22:17:12.688455 | controller |   "isreg": true,
2026-06-09 22:17:12.688488 | controller |   "issock": false,
2026-06-09 22:17:12.688532 | controller |   "isuid": false,
2026-06-09 22:17:12.688568 | controller |   "mode": "0644",
2026-06-09 22:17:12.688601 | controller |   "mtime": 1777968154.1714108,
2026-06-09 22:17:12.688636 | controller |   "nlink": 1,
2026-06-09 22:17:12.688670 | controller |   "path": "/home/zuul/crc-setup.log",
2026-06-09 22:17:12.688704 | controller |   "pw_name": "zuul",
2026-06-09 22:17:12.688737 | controller |   "rgrp": true,
2026-06-09 22:17:12.688770 | controller |   "roth": true,
2026-06-09 22:17:12.688807 | controller |   "rusr": true,
2026-06-09 22:17:12.688842 | controller |   "size": 4108,
2026-06-09 22:17:12.688916 | controller |   "uid": 1000,
2026-06-09 22:17:12.688974 | controller |   "wgrp": false,
2026-06-09 22:17:12.689008 | controller |   "woth": false,
2026-06-09 22:17:12.689040 | controller |   "wusr": true,
2026-06-09 22:17:12.689072 | controller |   "xgrp": false,
2026-06-09 22:17:12.689104 | controller |   "xoth": false,
2026-06-09 22:17:12.689136 | controller |   "xusr": false
2026-06-09 22:17:12.689168 | controller | }
2026-06-09 22:17:13.434417 | controller | changed:
2026-06-09 22:17:13.434640 | controller | {
2026-06-09 22:17:13.434695 | controller |   "atime": 1777968156.210465,
2026-06-09 22:17:13.434736 | controller |   "ctime": 1777968956.4694307,
2026-06-09 22:17:13.434774 | controller |   "dev": 64513,
2026-06-09 22:17:13.434810 | controller |   "gid": 1000,
2026-06-09 22:17:13.434846 | controller |   "gr_name": "zuul",
2026-06-09 22:17:13.434924 | controller |   "inode": 2688,
2026-06-09 22:17:13.434961 | controller |   "isblk": false,
2026-06-09 22:17:13.434996 | controller |   "ischr": false,
2026-06-09 22:17:13.435032 | controller |   "isdir": false,
2026-06-09 22:17:13.435067 | controller |   "isfifo": false,
2026-06-09 22:17:13.435102 | controller |   "isgid": false,
2026-06-09 22:17:13.435136 | controller |   "islnk": false,
2026-06-09 22:17:13.435170 | controller |   "isreg": true,
2026-06-09 22:17:13.435205 | controller |   "issock": false,
2026-06-09 22:17:13.435238 | controller |   "isuid": false,
2026-06-09 22:17:13.435273 | controller |   "mode": "0644",
2026-06-09 22:17:13.435308 | controller |   "mtime": 1777968956.4694307,
2026-06-09 22:17:13.435344 | controller |   "nlink": 1,
2026-06-09 22:17:13.435450 | controller |   "path": "/home/zuul/crc-start.log",
2026-06-09 22:17:13.435488 | controller |   "pw_name": "zuul",
2026-06-09 22:17:13.435525 | controller |   "rgrp": true,
2026-06-09 22:17:13.435560 | controller |   "roth": true,
2026-06-09 22:17:13.435595 | controller |   "rusr": true,
2026-06-09 22:17:13.435630 | controller |   "size": 5003,
2026-06-09 22:17:13.435664 | controller |   "uid": 1000,
2026-06-09 22:17:13.435699 | controller |   "wgrp": false,
2026-06-09 22:17:13.435733 | controller |   "woth": false,
2026-06-09 22:17:13.435770 | controller |   "wusr": true,
2026-06-09 22:17:13.435821 | controller |   "xgrp": false,
2026-06-09 22:17:13.435901 | controller |   "xoth": false,
2026-06-09 22:17:13.435940 | controller |   "xusr": false
2026-06-09 22:17:13.435974 | controller | }
2026-06-09 22:17:14.277979 | controller | changed:
2026-06-09 22:17:14.278151 | controller | {
2026-06-09 22:17:14.278202 | controller |   "atime": 1781042900.393278,
2026-06-09 22:17:14.278242 | controller |   "ctime": 1781042924.8720388,
2026-06-09 22:17:14.278278 | controller |   "dev": 64513,
2026-06-09 22:17:14.278315 | controller |   "gid": 1000,
2026-06-09 22:17:14.278350 | controller |   "gr_name": "zuul",
2026-06-09 22:17:14.278384 | controller |   "inode": 648174,
2026-06-09 22:17:14.278418 | controller |   "isblk": false,
2026-06-09 22:17:14.278451 | controller |   "ischr": false,
2026-06-09 22:17:14.278485 | controller |   "isdir": false,
2026-06-09 22:17:14.278518 | controller |   "isfifo": false,
2026-06-09 22:17:14.278551 | controller |   "isgid": false,
2026-06-09 22:17:14.278584 | controller |   "islnk": false,
2026-06-09 22:17:14.278617 | controller |   "isreg": true,
2026-06-09 22:17:14.278651 | controller |   "issock": false,
2026-06-09 22:17:14.278688 | controller |   "isuid": false,
2026-06-09 22:17:14.278723 | controller |   "mode": "0644",
2026-06-09 22:17:14.278757 | controller |   "mtime": 1781042924.8720388,
2026-06-09 22:17:14.278797 | controller |   "nlink": 1,
2026-06-09 22:17:14.278834 | controller |   "path": "/home/zuul/ansible.log",
2026-06-09 22:17:14.278910 | controller |   "pw_name": "zuul",
2026-06-09 22:17:14.278950 | controller |   "rgrp": true,
2026-06-09 22:17:14.278984 | controller |   "roth": true,
2026-06-09 22:17:14.279018 | controller |   "rusr": true,
2026-06-09 22:17:14.279051 | controller |   "size": 6701,
2026-06-09 22:17:14.279084 | controller |   "uid": 1000,
2026-06-09 22:17:14.279117 | controller |   "wgrp": false,
2026-06-09 22:17:14.279149 | controller |   "woth": false,
2026-06-09 22:17:14.279181 | controller |   "wusr": true,
2026-06-09 22:17:14.279214 | controller |   "xgrp": false,
2026-06-09 22:17:14.279246 | controller |   "xoth": false,
2026-06-09 22:17:14.279280 | controller |   "xusr": false
2026-06-09 22:17:14.279314 | controller | }
2026-06-09 22:17:14.300224 | 
2026-06-09 22:17:14.300455 | TASK [Copy crio stats log file]
2026-06-09 22:17:14.327330 | controller | skipping: Conditional result was False
2026-06-09 22:17:14.336150 | 
2026-06-09 22:17:14.336294 | TASK [Get SELinux related data]
2026-06-09 22:17:14.742123 | controller | <no matches>
2026-06-09 22:17:14.879244 | controller | ERROR
2026-06-09 22:17:14.879541 | controller | {
2026-06-09 22:17:14.879599 | controller |   "delta": "0:00:00.014806",
2026-06-09 22:17:14.879810 | controller |   "end": "2026-06-09 22:17:14.743344",
2026-06-09 22:17:14.879991 | controller |   "msg": "non-zero return code",
2026-06-09 22:17:14.880039 | controller |   "rc": 1,
2026-06-09 22:17:14.880075 | controller |   "start": "2026-06-09 22:17:14.728538"
2026-06-09 22:17:14.880109 | controller | }
2026-06-09 22:17:14.880161 | controller | ERROR: Ignoring Errors
2026-06-09 22:17:14.888155 | 
2026-06-09 22:17:14.888287 | TASK [Create system configuration directory]
2026-06-09 22:17:15.266071 | controller | changed
2026-06-09 22:17:15.273840 | 
2026-06-09 22:17:15.274001 | TASK [Get some of the system configurations]
2026-06-09 22:17:15.821321 | controller | ok: Runtime: 0:00:00.024324
2026-06-09 22:17:15.828943 | 
2026-06-09 22:17:15.829073 | TASK [Copy generated documentation if available]
2026-06-09 22:17:15.856887 | controller | skipping: Conditional result was False
2026-06-09 22:17:15.867061 | 
2026-06-09 22:17:15.867198 | TASK [Copy generated AsciiDoc documentation if available]
2026-06-09 22:17:15.893502 | controller | skipping: Conditional result was False
2026-06-09 22:17:15.902774 | 
2026-06-09 22:17:15.902943 | TASK [Compress logs bigger than 2MB]
2026-06-09 22:17:16.447250 | controller | ok: Runtime: 0:00:00.008191
2026-06-09 22:17:16.455610 | 
2026-06-09 22:17:16.455735 | TASK [Copy files from workspace on node]
2026-06-09 22:17:16.493096 | controller | ok
2026-06-09 22:17:16.527359 | 
2026-06-09 22:17:16.527505 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-09 22:17:16.562592 | controller | skipping: Conditional result was False
2026-06-09 22:17:16.569115 | 
2026-06-09 22:17:16.569206 | TASK [fetch-output : Set log path for single node]
2026-06-09 22:17:16.610461 | controller | ok
2026-06-09 22:17:16.615495 | 
2026-06-09 22:17:16.615581 | LOOP [fetch-output : Ensure local output dirs]
2026-06-09 22:17:16.909467 | controller -> localhost | changed: "/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/logs"
2026-06-09 22:17:16.909752 | controller -> localhost | changed: All items complete
2026-06-09 22:17:16.909785 | 
2026-06-09 22:17:17.121435 | controller -> localhost | changed: "/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/artifacts"
2026-06-09 22:17:17.374929 | controller -> localhost | changed: "/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/docs"
2026-06-09 22:17:17.386973 | 
2026-06-09 22:17:17.387113 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-09 22:17:18.379222 | controller | changed:
2026-06-09 22:17:18.379593 | controller | .d..t...... ./
2026-06-09 22:17:18.379632 | controller | >f+++++++++ README.html
2026-06-09 22:17:18.379663 | controller | >f+++++++++ ansible-execution.log
2026-06-09 22:17:18.379689 | controller | >f+++++++++ ansible.log
2026-06-09 22:17:18.379714 | controller | >f+++++++++ crc-setup.log
2026-06-09 22:17:18.379739 | controller | >f+++++++++ crc-start.log
2026-06-09 22:17:18.379764 | controller | >f+++++++++ dmesg.log
2026-06-09 22:17:18.379787 | controller | >f+++++++++ installed-pkgs.log
2026-06-09 22:17:18.379811 | controller | >f+++++++++ python.log
2026-06-09 22:17:18.379834 | controller | >f+++++++++ registries.conf
2026-06-09 22:17:18.379882 | controller | >f+++++++++ report.html
2026-06-09 22:17:18.379908 | controller | >f+++++++++ selinux-denials.log
2026-06-09 22:17:18.379932 | controller | >f+++++++++ selinux-listing.log
2026-06-09 22:17:18.379956 | controller | cd+++++++++ ci-framework-data/
2026-06-09 22:17:18.379979 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-06-09 22:17:18.380003 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-06-09 22:17:18.380025 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2026-06-09 22:17:18.380049 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/storage/
2026-06-09 22:17:18.380073 | controller | >f+++++++++ ci-framework-data/artifacts/manifests/storage/storage-class.yaml
2026-06-09 22:17:18.380096 | controller | >f+++++++++ ci-framework-data/artifacts/manifests/storage/storage.yaml
2026-06-09 22:17:18.380117 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-06-09 22:17:18.380140 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-06-09 22:17:18.380192 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2026-06-09 22:17:18.380229 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2026-06-09 22:17:18.380277 | controller | cd+++++++++ ci-framework-data/logs/
2026-06-09 22:17:18.380304 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-06-09 22:17:18.380337 | controller | cd+++++++++ registries.conf.d/
2026-06-09 22:17:18.380371 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-06-09 22:17:18.380396 | controller | cd+++++++++ system-config/
2026-06-09 22:17:18.380419 | controller | cd+++++++++ system-config/libvirt/
2026-06-09 22:17:18.380439 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-06-09 22:17:18.380460 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-06-09 22:17:18.380482 | controller | >f+++++++++ system-config/libvirt/libvirtd.conf
2026-06-09 22:17:18.380506 | controller | >f+++++++++ system-config/libvirt/network.conf
2026-06-09 22:17:18.380527 | controller | >f+++++++++ system-config/libvirt/qemu-lockd.conf
2026-06-09 22:17:18.380562 | controller | >f+++++++++ system-config/libvirt/qemu.conf
2026-06-09 22:17:18.380587 | controller | >f+++++++++ system-config/libvirt/virtinterfaced.conf
2026-06-09 22:17:18.380611 | controller | >f+++++++++ system-config/libvirt/virtlockd.conf
2026-06-09 22:17:18.380633 | controller | >f+++++++++ system-config/libvirt/virtlogd.conf
2026-06-09 22:17:18.380655 | controller | >f+++++++++ system-config/libvirt/virtnetworkd.conf
2026-06-09 22:17:18.380677 | controller | >f+++++++++ system-config/libvirt/virtnodedevd.conf
2026-06-09 22:17:18.380700 | controller | >f+++++++++ system-config/libvirt/virtnwfilterd.conf
2026-06-09 22:17:18.380724 | controller | >f+++++++++ system-config/libvirt/virtproxyd.conf
2026-06-09 22:17:18.380745 | controller | >f+++++++++ system-config/libvirt/virtqemud.conf
2026-06-09 22:17:18.380765 | controller | >f+++++++++ system-config/libvirt/virtsecretd.conf
2026-06-09 22:17:18.380787 | controller | >f+++++++++ system-config/libvirt/virtstoraged.conf
2026-06-09 22:17:19.058966 | controller | changed: .d..t...... ./
2026-06-09 22:17:19.673696 | controller | changed: .d..t...... ./
2026-06-09 22:17:19.727592 | 
2026-06-09 22:17:19.727830 | TASK [Return artifact to Zuul]
2026-06-09 22:17:19.781922 | controller | ok
2026-06-09 22:17:19.784418 | 
2026-06-09 22:17:19.784486 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-06-09 22:17:19.784626 | 
2026-06-09 22:17:19.784662 | PLAY RECAP
2026-06-09 22:17:19.784713 | controller | ok: 19 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-06-09 22:17:19.784740 | 
2026-06-09 22:17:19.997618 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-09 22:17:19.998914 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-09 22:17:20.691881 | 
2026-06-09 22:17:20.692007 | PLAY [all]
2026-06-09 22:17:20.701918 | 
2026-06-09 22:17:20.702034 | TASK [include_role : fetch-output]
2026-06-09 22:17:20.749197 | controller | ok
2026-06-09 22:17:20.763636 | 
2026-06-09 22:17:20.763710 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-09 22:17:20.838439 | controller | skipping: Conditional result was False
2026-06-09 22:17:20.847194 | 
2026-06-09 22:17:20.847334 | TASK [fetch-output : Set log path for single node]
2026-06-09 22:17:20.890629 | controller | ok
2026-06-09 22:17:20.898346 | 
2026-06-09 22:17:20.898483 | LOOP [fetch-output : Ensure local output dirs]
2026-06-09 22:17:21.428252 | controller -> localhost | ok: "/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/logs"
2026-06-09 22:17:21.709234 | controller -> localhost | ok: "/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/artifacts"
2026-06-09 22:17:21.982466 | controller -> localhost | ok: "/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/docs"
2026-06-09 22:17:22.002933 | 
2026-06-09 22:17:22.003160 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-09 22:17:22.813847 | controller | ok
2026-06-09 22:17:22.814256 | controller | ok: All items complete
2026-06-09 22:17:22.814326 | 
2026-06-09 22:17:23.492616 | controller | ok
2026-06-09 22:17:24.158037 | controller | ok
2026-06-09 22:17:24.187453 | 
2026-06-09 22:17:24.187758 | TASK [include_role : fetch-output-openshift]
2026-06-09 22:17:24.238332 | controller | skipping: Conditional result was False
2026-06-09 22:17:24.248751 | 
2026-06-09 22:17:24.248934 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-09 22:17:24.746992 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.011124
2026-06-09 22:17:25.029556 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.017633
2026-06-09 22:17:25.045419 | 
2026-06-09 22:17:25.045548 | PLAY [all]
2026-06-09 22:17:25.055736 | 
2026-06-09 22:17:25.055931 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-09 22:17:25.717149 | controller | changed
2026-06-09 22:17:25.726450 | 
2026-06-09 22:17:25.726575 | PLAY RECAP
2026-06-09 22:17:25.726659 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-06-09 22:17:25.726705 | 
2026-06-09 22:17:25.857912 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-09 22:17:25.859055 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-06-09 22:17:26.591022 | 
2026-06-09 22:17:26.591191 | PLAY [localhost]
2026-06-09 22:17:26.602681 | 
2026-06-09 22:17:26.602763 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-09 22:17:27.142901 | localhost | changed
2026-06-09 22:17:27.152989 | 
2026-06-09 22:17:27.153144 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-09 22:17:27.181071 | localhost | ok
2026-06-09 22:17:27.186820 | 
2026-06-09 22:17:27.186906 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-09 22:17:27.632534 | localhost | changed
2026-06-09 22:17:27.643642 | 
2026-06-09 22:17:27.643798 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-09 22:17:28.495364 | localhost | changed
2026-06-09 22:17:28.499765 | 
2026-06-09 22:17:28.499828 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-09 22:17:28.956950 | localhost | Identity added: /var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/tmp/ansible.7je86m6q (/var/lib/zuul/builds/d8fe38b0c8ab481c940a58a130b937b3/work/tmp/ansible.7je86m6q)
2026-06-09 22:17:28.957150 | localhost | ok: Runtime: 0:00:00.015111
2026-06-09 22:17:28.960538 | 
2026-06-09 22:17:28.960609 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-09 22:17:29.271025 | localhost | ok: Runtime: 0:00:00.010486
2026-06-09 22:17:29.279347 | 
2026-06-09 22:17:29.279485 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-09 22:17:29.361659 | localhost | changed
2026-06-09 22:17:29.368234 | 
2026-06-09 22:17:29.368327 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-09 22:17:29.834884 | localhost | changed
2026-06-09 22:17:29.845651 | 
2026-06-09 22:17:29.845759 | PLAY [localhost]
2026-06-09 22:17:29.854335 | 
2026-06-09 22:17:29.854460 | TASK [Generate bulk log download script]
2026-06-09 22:17:29.878840 | localhost | ok
2026-06-09 22:17:29.899241 | 
2026-06-09 22:17:29.899322 | TASK [local-log-download : Check API endpoint is defined]
2026-06-09 22:17:29.942198 | localhost | ok: All assertions passed
2026-06-09 22:17:29.949610 | 
2026-06-09 22:17:29.949733 | TASK [local-log-download : Create download script]
2026-06-09 22:17:30.490016 | localhost -> localhost | changed
2026-06-09 22:17:30.551220 | 
2026-06-09 22:17:30.551398 | TASK [Register quick-download link]
2026-06-09 22:17:30.581544 | localhost | ok
2026-06-09 22:17:30.584660 | 
2026-06-09 22:17:30.584753 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-09 22:17:30.591570 | 
2026-06-09 22:17:30.591647 | TASK [Set zuul-log-path fact]
2026-06-09 22:17:30.618805 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-09 22:17:30.627700 | 
2026-06-09 22:17:30.627786 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-09 22:17:30.665882 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-09 22:17:30.669222 | 
2026-06-09 22:17:30.669323 | TASK [upload-logs : Create log directories]
2026-06-09 22:17:31.663615 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-09 22:17:31.667616 | 
2026-06-09 22:17:31.667754 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-09 22:17:32.012843 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.011475
2026-06-09 22:17:32.019363 | 
2026-06-09 22:17:32.019504 | TASK [upload-logs : Upload logs to log server]
2026-06-09 22:17:35.085648 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given
2026-06-09 22:17:35.088901 | 
2026-06-09 22:17:35.089040 | LOOP [upload-logs : Compress console log and json output]
