2026-06-10 08:36:13.414331 | Job console starting
2026-06-10 08:36:13.546153 | Updating git repos
2026-06-10 08:36:13.592433 | Cloning repos into workspace
2026-06-10 08:36:15.891910 | Restoring repo states
2026-06-10 08:36:15.908960 | Merging changes
2026-06-10 08:36:17.013051 | Checking out repos
2026-06-10 08:36:17.737723 | Preparing playbooks
2026-06-10 08:36:25.627823 | Running Ansible setup
2026-06-10 08:36:29.502442 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-10 08:36:30.139132 | 
2026-06-10 08:36:30.139320 | PLAY [localhost]
2026-06-10 08:36:30.146933 | 
2026-06-10 08:36:30.147001 | TASK [Gathering Facts]
2026-06-10 08:36:31.103753 | localhost | ok
2026-06-10 08:36:31.112865 | 
2026-06-10 08:36:31.112982 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-10 08:36:31.553236 | localhost -> localhost | changed
2026-06-10 08:36:31.558038 | 
2026-06-10 08:36:31.558131 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-10 08:36:32.508763 | localhost -> localhost | changed
2026-06-10 08:36:32.525294 | 
2026-06-10 08:36:32.525506 | TASK [Setup log path fact]
2026-06-10 08:36:32.551730 | localhost | ok
2026-06-10 08:36:32.571300 | 
2026-06-10 08:36:32.571485 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-10 08:36:32.601493 | localhost | ok
2026-06-10 08:36:32.608824 | 
2026-06-10 08:36:32.608994 | TASK [emit-job-header : Print job information]
2026-06-10 08:36:32.657610 | # Job Information
2026-06-10 08:36:32.657777 | Ansible Version: 2.16.18
2026-06-10 08:36:32.657803 | Job: cifmw-molecule-cifmw_helpers
2026-06-10 08:36:32.657824 | Pipeline: github-check
2026-06-10 08:36:32.657841 | Executor: 38.102.83.32
2026-06-10 08:36:32.657859 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3989
2026-06-10 08:36:32.657878 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/a07/rdoproject.org/a07e9f03a65d43828566f341986db5c1/
2026-06-10 08:36:32.657899 | Event ID: 36966ce0-64a7-11f1-9961-c2e921a4b3d8
2026-06-10 08:36:32.660706 | 
2026-06-10 08:36:32.660767 | LOOP [emit-job-header : Print node information]
2026-06-10 08:36:32.751481 | localhost | ok:
2026-06-10 08:36:32.751821 | localhost | # Node Information
2026-06-10 08:36:32.751885 | localhost | Inventory Hostname: controller
2026-06-10 08:36:32.751936 | localhost | Hostname: np0000069516
2026-06-10 08:36:32.751978 | localhost | Username: zuul
2026-06-10 08:36:32.752020 | localhost | Distro: CentOS 9
2026-06-10 08:36:32.752056 | localhost | Provider: vexxhost-nodepool-tripleo
2026-06-10 08:36:32.752091 | localhost | Region: RegionOne
2026-06-10 08:36:32.752125 | localhost | Label: cloud-centos-9-stream-tripleo
2026-06-10 08:36:32.752158 | localhost | Product Name: OpenStack Nova
2026-06-10 08:36:32.752192 | localhost | Interface IP: 38.102.83.159
2026-06-10 08:36:32.771260 | 
2026-06-10 08:36:32.771471 | PLAY [all]
2026-06-10 08:36:32.785063 | 
2026-06-10 08:36:32.785224 | TASK [Gather network facts]
2026-06-10 08:36:33.281598 | controller | ok
2026-06-10 08:36:33.295230 | 
2026-06-10 08:36:33.295412 | TASK [include_role : start-zuul-console]
2026-06-10 08:36:33.332987 | controller | ok
2026-06-10 08:36:33.354143 | 
2026-06-10 08:36:33.354389 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-10 08:36:33.805192 | controller | ok
2026-06-10 08:36:33.817637 | 
2026-06-10 08:36:33.817778 | TASK [include_role : add-build-sshkey]
2026-06-10 08:36:33.850318 | controller | ok
2026-06-10 08:36:33.872637 | 
2026-06-10 08:36:33.872807 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-10 08:36:34.173053 | controller -> localhost | ok
2026-06-10 08:36:34.181912 | 
2026-06-10 08:36:34.182044 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-10 08:36:34.214100 | controller | ok
2026-06-10 08:36:34.242630 | controller | included: /var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-10 08:36:34.249864 | 
2026-06-10 08:36:34.249965 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-10 08:36:35.087856 | controller -> localhost | Generating public/private rsa key pair.
2026-06-10 08:36:35.088048 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/a07e9f03a65d43828566f341986db5c1_id_rsa
2026-06-10 08:36:35.088080 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/a07e9f03a65d43828566f341986db5c1_id_rsa.pub
2026-06-10 08:36:35.088102 | controller -> localhost | The key fingerprint is:
2026-06-10 08:36:35.088122 | controller -> localhost | SHA256:F9tTHpPouHbKu6tZTdISuf43dEaT19pNIAyG46Fga2o zuul-build-sshkey
2026-06-10 08:36:35.088140 | controller -> localhost | The key's randomart image is:
2026-06-10 08:36:35.088158 | controller -> localhost | +---[RSA 3072]----+
2026-06-10 08:36:35.088176 | controller -> localhost | |         .oo     |
2026-06-10 08:36:35.088196 | controller -> localhost | |    o   +. .o... |
2026-06-10 08:36:35.088214 | controller -> localhost | |   . o o o+ ..=.o|
2026-06-10 08:36:35.088231 | controller -> localhost | |    o . .  X o ==|
2026-06-10 08:36:35.088249 | controller -> localhost | |   o    S B * .=+|
2026-06-10 08:36:35.088266 | controller -> localhost | |  E      o * .o =|
2026-06-10 08:36:35.088283 | controller -> localhost | | .        = o. o |
2026-06-10 08:36:35.088302 | controller -> localhost | |         = +  o  |
2026-06-10 08:36:35.088319 | controller -> localhost | |        o.*+.. . |
2026-06-10 08:36:35.088336 | controller -> localhost | +----[SHA256]-----+
2026-06-10 08:36:35.088381 | controller -> localhost | ok: Runtime: 0:00:00.326241
2026-06-10 08:36:35.092318 | 
2026-06-10 08:36:35.092384 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-10 08:36:35.109388 | controller | ok
2026-06-10 08:36:35.117208 | controller | included: /var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-10 08:36:35.125107 | 
2026-06-10 08:36:35.125188 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-10 08:36:35.159678 | controller | skipping: Conditional result was False
2026-06-10 08:36:35.163789 | 
2026-06-10 08:36:35.163860 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-10 08:36:37.734680 | controller | changed
2026-06-10 08:36:37.739135 | 
2026-06-10 08:36:37.739274 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-10 08:36:37.979872 | controller | ok
2026-06-10 08:36:37.987024 | 
2026-06-10 08:36:37.987209 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-10 08:36:38.855013 | controller | changed
2026-06-10 08:36:38.858543 | 
2026-06-10 08:36:38.858610 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-10 08:36:39.643656 | controller | changed
2026-06-10 08:36:39.651603 | 
2026-06-10 08:36:39.651734 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-10 08:36:39.678425 | controller | skipping: Conditional result was False
2026-06-10 08:36:39.683008 | 
2026-06-10 08:36:39.683094 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-10 08:36:40.112686 | controller -> localhost | changed
2026-06-10 08:36:40.122238 | 
2026-06-10 08:36:40.122321 | TASK [add-build-sshkey : Add back temp key]
2026-06-10 08:36:40.484140 | controller -> localhost | Identity added: /var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/a07e9f03a65d43828566f341986db5c1_id_rsa (zuul-build-sshkey)
2026-06-10 08:36:40.484437 | controller -> localhost | ok: Runtime: 0:00:00.016555
2026-06-10 08:36:40.494470 | 
2026-06-10 08:36:40.494672 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-10 08:36:40.833831 | controller | ok
2026-06-10 08:36:40.841111 | 
2026-06-10 08:36:40.841248 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-10 08:36:40.868232 | controller | skipping: Conditional result was False
2026-06-10 08:36:40.877931 | 
2026-06-10 08:36:40.878049 | TASK [include_role : validate-host]
2026-06-10 08:36:40.909139 | controller | ok
2026-06-10 08:36:40.933232 | 
2026-06-10 08:36:40.933413 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-10 08:36:40.962674 | controller | ok
2026-06-10 08:36:40.966999 | 
2026-06-10 08:36:40.967084 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-10 08:36:41.234195 | controller -> localhost | ok
2026-06-10 08:36:41.239477 | 
2026-06-10 08:36:41.239605 | TASK [validate-host : Collect information about the host]
2026-06-10 08:36:41.987067 | controller | ok
2026-06-10 08:36:41.997265 | 
2026-06-10 08:36:41.997353 | TASK [validate-host : Sanitize hostname]
2026-06-10 08:36:42.078817 | controller | ok
2026-06-10 08:36:42.087063 | 
2026-06-10 08:36:42.087245 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-10 08:36:42.600218 | controller -> localhost | changed
2026-06-10 08:36:42.605892 | 
2026-06-10 08:36:42.605962 | TASK [validate-host : Collect information about zuul worker]
2026-06-10 08:36:43.028612 | controller | ok
2026-06-10 08:36:43.032779 | 
2026-06-10 08:36:43.032860 | TASK [validate-host : Write out all zuul information for each host]
2026-06-10 08:36:43.564617 | controller -> localhost | changed
2026-06-10 08:36:43.579195 | 
2026-06-10 08:36:43.579333 | TASK [include_role : prepare-workspace-openshift]
2026-06-10 08:36:43.606400 | controller | skipping: Conditional result was False
2026-06-10 08:36:43.615973 | 
2026-06-10 08:36:43.616176 | TASK [include_role : remove-zuul-sshkey]
2026-06-10 08:36:43.643782 | controller | skipping: Conditional result was False
2026-06-10 08:36:43.653150 | 
2026-06-10 08:36:43.653335 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-10 08:36:43.902947 | controller | ok: "logs"
2026-06-10 08:36:43.903171 | controller | ok: All items complete
2026-06-10 08:36:43.903198 | 
2026-06-10 08:36:44.117051 | controller | ok: "artifacts"
2026-06-10 08:36:44.324137 | controller | ok: "docs"
2026-06-10 08:36:44.342725 | 
2026-06-10 08:36:44.342866 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-10 08:36:44.643727 | controller | changed: "logs"
2026-06-10 08:36:44.841446 | controller | changed: "artifacts"
2026-06-10 08:36:45.070964 | controller | changed: "docs"
2026-06-10 08:36:45.088227 | 
2026-06-10 08:36:45.088296 | PLAY RECAP
2026-06-10 08:36:45.088350 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-10 08:36:45.088385 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-10 08:36:45.088408 | 
2026-06-10 08:36:45.206666 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-10 08:36:45.207797 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-10 08:36:45.913269 | 
2026-06-10 08:36:45.913588 | PLAY [all]
2026-06-10 08:36:45.925150 | 
2026-06-10 08:36:45.925268 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-10 08:36:46.020587 | controller | ok
2026-06-10 08:36:46.029144 | 
2026-06-10 08:36:46.029312 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-10 08:36:46.479684 | controller | changed
2026-06-10 08:36:46.490300 | 
2026-06-10 08:36:46.490456 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-10 08:36:47.733039 | controller | changed
2026-06-10 08:36:47.757748 | 
2026-06-10 08:36:47.757993 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-06-10 08:36:48.271965 | controller | changed:
2026-06-10 08:36:48.272463 | controller | {
2026-06-10 08:36:48.272573 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-06-10 08:36:48.272648 | controller | }
2026-06-10 08:36:48.561987 | controller | changed:
2026-06-10 08:36:48.562156 | controller | {
2026-06-10 08:36:48.562322 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-06-10 08:36:48.562394 | controller | }
2026-06-10 08:36:48.820766 | controller | changed:
2026-06-10 08:36:48.820929 | controller | {
2026-06-10 08:36:48.820982 | 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-10 08:36:48.821026 | controller | }
2026-06-10 08:36:49.081319 | controller | changed:
2026-06-10 08:36:49.081483 | controller | {
2026-06-10 08:36:49.081582 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-06-10 08:36:49.081626 | controller | }
2026-06-10 08:36:49.337191 | controller | changed:
2026-06-10 08:36:49.337406 | controller | {
2026-06-10 08:36:49.337475 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-06-10 08:36:49.337577 | controller | }
2026-06-10 08:36:49.584177 | controller | changed:
2026-06-10 08:36:49.584340 | controller | {
2026-06-10 08:36:49.584395 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-06-10 08:36:49.584439 | controller | }
2026-06-10 08:36:49.843235 | controller | changed:
2026-06-10 08:36:49.843654 | controller | {
2026-06-10 08:36:49.843686 | 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-10 08:36:49.843706 | controller | }
2026-06-10 08:36:50.065679 | controller | changed:
2026-06-10 08:36:50.066044 | controller | {
2026-06-10 08:36:50.066136 | 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-10 08:36:50.066222 | controller | }
2026-06-10 08:36:50.328948 | controller | changed:
2026-06-10 08:36:50.329129 | controller | {
2026-06-10 08:36:50.329180 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-06-10 08:36:50.329220 | controller | }
2026-06-10 08:36:50.566403 | controller | changed:
2026-06-10 08:36:50.566628 | controller | {
2026-06-10 08:36:50.566684 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-06-10 08:36:50.566727 | controller | }
2026-06-10 08:36:50.843186 | controller | changed:
2026-06-10 08:36:50.843358 | controller | {
2026-06-10 08:36:50.843414 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-06-10 08:36:50.843457 | controller | }
2026-06-10 08:36:51.119207 | controller | changed:
2026-06-10 08:36:51.119333 | controller | {
2026-06-10 08:36:51.119365 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-06-10 08:36:51.119391 | controller | }
2026-06-10 08:36:51.373234 | controller | changed:
2026-06-10 08:36:51.373420 | controller | {
2026-06-10 08:36:51.373471 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com"
2026-06-10 08:36:51.373538 | controller | }
2026-06-10 08:36:51.661769 | controller | changed:
2026-06-10 08:36:51.661898 | controller | {
2026-06-10 08:36:51.661932 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-06-10 08:36:51.661959 | controller | }
2026-06-10 08:36:51.913557 | controller | changed:
2026-06-10 08:36:51.913796 | controller | {
2026-06-10 08:36:51.913843 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-06-10 08:36:51.913951 | controller | }
2026-06-10 08:36:52.188745 | controller | changed:
2026-06-10 08:36:52.188939 | controller | {
2026-06-10 08:36:52.189003 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-06-10 08:36:52.189053 | controller | }
2026-06-10 08:36:52.447509 | controller | changed:
2026-06-10 08:36:52.447719 | controller | {
2026-06-10 08:36:52.447773 | 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-10 08:36:52.447818 | controller | }
2026-06-10 08:36:52.711044 | controller | changed:
2026-06-10 08:36:52.711228 | controller | {
2026-06-10 08:36:52.711281 | 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-10 08:36:52.711341 | controller | }
2026-06-10 08:36:52.991276 | controller | changed:
2026-06-10 08:36:52.991439 | controller | {
2026-06-10 08:36:52.991489 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-06-10 08:36:52.991607 | controller | }
2026-06-10 08:36:53.278189 | controller | changed:
2026-06-10 08:36:53.278450 | controller | {
2026-06-10 08:36:53.278586 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-06-10 08:36:53.278648 | controller | }
2026-06-10 08:36:53.532600 | controller | changed:
2026-06-10 08:36:53.532779 | controller | {
2026-06-10 08:36:53.532863 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-06-10 08:36:53.532919 | controller | }
2026-06-10 08:36:53.796265 | controller | changed:
2026-06-10 08:36:53.796610 | controller | {
2026-06-10 08:36:53.796719 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-06-10 08:36:53.796788 | controller | }
2026-06-10 08:36:54.084006 | controller | changed:
2026-06-10 08:36:54.084179 | controller | {
2026-06-10 08:36:54.084231 | 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-10 08:36:54.084273 | controller | }
2026-06-10 08:36:54.370439 | controller | changed:
2026-06-10 08:36:54.370616 | controller | {
2026-06-10 08:36:54.370673 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-06-10 08:36:54.370717 | controller | }
2026-06-10 08:36:54.630605 | controller | changed:
2026-06-10 08:36:54.630749 | controller | {
2026-06-10 08:36:54.630799 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-06-10 08:36:54.630840 | controller | }
2026-06-10 08:36:54.868336 | controller | changed:
2026-06-10 08:36:54.868503 | controller | {
2026-06-10 08:36:54.868593 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-06-10 08:36:54.868635 | controller | }
2026-06-10 08:36:54.912650 | 
2026-06-10 08:36:54.912824 | TASK [Set timezone to UTC]
2026-06-10 08:36:55.411395 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-06-10 08:36:55.416615 | 
2026-06-10 08:36:55.416720 | TASK [Create nodepool directory]
2026-06-10 08:36:55.714359 | controller | changed
2026-06-10 08:36:55.726629 | 
2026-06-10 08:36:55.726825 | TASK [Create nodepool sub_nodes file]
2026-06-10 08:36:56.393704 | controller | changed
2026-06-10 08:36:56.401936 | 
2026-06-10 08:36:56.402068 | TASK [Create nodepool sub_nodes_private file]
2026-06-10 08:36:57.070552 | controller | changed
2026-06-10 08:36:57.078084 | 
2026-06-10 08:36:57.078209 | LOOP [Populate nodepool sub_nodes file]
2026-06-10 08:36:57.119606 | 
2026-06-10 08:36:57.119835 | LOOP [Populate nodepool sub_nodes_private file]
2026-06-10 08:36:57.181390 | 
2026-06-10 08:36:57.181713 | TASK [Create nodepool primary file]
2026-06-10 08:36:57.217922 | controller | skipping: Conditional result was False
2026-06-10 08:36:57.227986 | 
2026-06-10 08:36:57.228146 | TASK [Create nodepool node_private for this node]
2026-06-10 08:36:57.862816 | controller | changed
2026-06-10 08:36:57.869610 | 
2026-06-10 08:36:57.869768 | LOOP [Copy ssh keys to nodepool directory]
2026-06-10 08:36:58.320144 | controller | ok: Item: id_rsa Runtime: 0:00:00.006265
2026-06-10 08:36:58.320381 | 
2026-06-10 08:36:58.569849 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.009480
2026-06-10 08:36:58.590651 | 
2026-06-10 08:36:58.590876 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-06-10 08:36:59.286956 | controller | changed
2026-06-10 08:36:59.294744 | 
2026-06-10 08:36:59.294896 | TASK [Validate sudoers config after edits]
2026-06-10 08:36:59.612482 | controller | /etc/sudoers: parsed OK
2026-06-10 08:36:59.612519 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-06-10 08:36:59.612525 | controller | /etc/sudoers.d/zuul: parsed OK
2026-06-10 08:36:59.612529 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-06-10 08:36:59.844434 | controller | ok: Runtime: 0:00:00.007818
2026-06-10 08:36:59.850110 | 
2026-06-10 08:36:59.850194 | TASK [Show the environment passed in to job shell scripts]
2026-06-10 08:37:00.166601 | controller | SHELL=/bin/bash
2026-06-10 08:37:00.166690 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-06-10 08:37:00.166707 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-06-10 08:37:00.166778 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/89/3989/40bee6119c5e40bf54a372b80a12a0ebdff9661f
2026-06-10 08:37:00.166800 | controller | PWD=/home/zuul
2026-06-10 08:37:00.166814 | controller | ZUUL_PIPELINE=github-check
2026-06-10 08:37:00.166892 | controller | LOGNAME=zuul
2026-06-10 08:37:00.166905 | controller | XDG_SESSION_TYPE=tty
2026-06-10 08:37:00.166913 | controller | _=/usr/bin/env
2026-06-10 08:37:00.166926 | controller | MOTD_SHOWN=pam
2026-06-10 08:37:00.166934 | controller | HOME=/home/zuul
2026-06-10 08:37:00.166942 | controller | LANG=en_US.UTF-8
2026-06-10 08:37:00.166950 | controller | SSH_CONNECTION=38.102.83.32 53476 38.102.83.159 22
2026-06-10 08:37:00.166961 | 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-10 08:37:00.166970 | controller | ZUUL_CHANGE_IDS=3989,40bee6119c5e40bf54a372b80a12a0ebdff9661f
2026-06-10 08:37:00.166980 | controller | WORKSPACE=/home/zuul/workspace
2026-06-10 08:37:00.167027 | controller | XDG_SESSION_CLASS=user
2026-06-10 08:37:00.167035 | controller | SELINUX_ROLE_REQUESTED=
2026-06-10 08:37:00.167043 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-06-10 08:37:00.167052 | controller | USER=zuul
2026-06-10 08:37:00.167059 | controller | ZUUL_VOTING=True
2026-06-10 08:37:00.167067 | controller | BUILD_TIMEOUT=1800000
2026-06-10 08:37:00.167075 | controller | SELINUX_USE_CURRENT_RANGE=
2026-06-10 08:37:00.167083 | controller | SHLVL=1
2026-06-10 08:37:00.167091 | controller | ZUUL_PATCHSET=40bee6119c5e40bf54a372b80a12a0ebdff9661f
2026-06-10 08:37:00.167099 | controller | XDG_SESSION_ID=1
2026-06-10 08:37:00.167106 | controller | ZUUL_BRANCH=main
2026-06-10 08:37:00.167114 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-06-10 08:37:00.167122 | controller | SSH_CLIENT=38.102.83.32 53476 22
2026-06-10 08:37:00.167134 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-06-10 08:37:00.167144 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-06-10 08:37:00.167153 | controller | which_declare=declare -f
2026-06-10 08:37:00.167161 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-06-10 08:37:00.167169 | controller | SELINUX_LEVEL_REQUESTED=
2026-06-10 08:37:00.167176 | controller | ZUUL_CHANGE=3989
2026-06-10 08:37:00.167184 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-06-10 08:37:00.167192 | controller | ZUUL_UUID=a07e9f03a65d43828566f341986db5c1
2026-06-10 08:37:00.167201 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-06-10 08:37:00.167209 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-06-10 08:37:00.167217 | controller | }
2026-06-10 08:37:00.421239 | controller | ok: Runtime: 0:00:00.007998
2026-06-10 08:37:00.430752 | 
2026-06-10 08:37:00.431178 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-06-10 08:37:00.450162 | controller | skipping: Conditional result was False
2026-06-10 08:37:00.461164 | 
2026-06-10 08:37:00.461340 | TASK [Symlink /home/zuul-worker/workspace]
2026-06-10 08:37:01.002607 | controller | skipping: Conditional result was False
2026-06-10 08:37:01.011589 | 
2026-06-10 08:37:01.011735 | TASK [Ensure legacy workspace directory]
2026-06-10 08:37:01.290693 | controller | changed
2026-06-10 08:37:01.293338 | 
2026-06-10 08:37:01.293431 | PLAY RECAP
2026-06-10 08:37:01.293550 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-10 08:37:01.293604 | 
2026-06-10 08:37:01.440412 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-10 08:37:01.441587 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-10 08:37:02.022784 | 
2026-06-10 08:37:02.022907 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-06-10 08:37:02.034169 | 
2026-06-10 08:37:02.034278 | TASK [Create zuul-output directory]
2026-06-10 08:37:02.473704 | controller | changed
2026-06-10 08:37:02.481685 | 
2026-06-10 08:37:02.481828 | TASK [Slurp Zuul inventory test]
2026-06-10 08:37:02.881602 | controller -> localhost | ok
2026-06-10 08:37:02.887714 | 
2026-06-10 08:37:02.887782 | TASK [Save zuul inventory]
2026-06-10 08:37:03.998413 | controller | changed
2026-06-10 08:37:04.010351 | 
2026-06-10 08:37:04.010558 | TASK [Save zuul vars without the change_message]
2026-06-10 08:37:04.783364 | controller | changed
2026-06-10 08:37:04.785272 | 
2026-06-10 08:37:04.785348 | PLAY RECAP
2026-06-10 08:37:04.785396 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-10 08:37:04.785526 | 
2026-06-10 08:37:04.918736 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-10 08:37:04.921462 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-10 08:37:05.588569 | 
2026-06-10 08:37:05.588705 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-06-10 08:37:05.600717 | 
2026-06-10 08:37:05.600862 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-06-10 08:37:05.621012 | controller | ok
2026-06-10 08:37:05.636111 | 
2026-06-10 08:37:05.636233 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-10 08:37:05.680686 | controller | skipping: Conditional result was False
2026-06-10 08:37:05.686973 | 
2026-06-10 08:37:05.687071 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-10 08:37:06.414869 | controller | ok
2026-06-10 08:37:06.424056 | 
2026-06-10 08:37:06.424247 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-10 08:37:08.144889 | controller | ok
2026-06-10 08:37:08.165349 | 
2026-06-10 08:37:08.166240 | TASK [Prepare workspace]
2026-06-10 08:37:08.190827 | controller | ok
2026-06-10 08:37:08.227110 | 
2026-06-10 08:37:08.227261 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-10 08:37:08.722613 | controller | ok
2026-06-10 08:37:08.729041 | 
2026-06-10 08:37:08.729133 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-10 08:37:11.504658 | controller | Output suppressed because no_log was given
2026-06-10 08:37:11.520702 | 
2026-06-10 08:37:11.520870 | LOOP [Create zuul-output directory]
2026-06-10 08:37:12.466060 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-06-10 08:37:12.821236 | controller | ok: "/home/zuul/zuul-output/logs"
2026-06-10 08:37:12.837147 | 
2026-06-10 08:37:12.839463 | TASK [Install required packages]
2026-06-10 08:37:59.714258 | controller | changed
2026-06-10 08:37:59.720297 | 
2026-06-10 08:37:59.720454 | TASK [Install venv]
2026-06-10 08:39:30.941440 | controller | changed
2026-06-10 08:39:30.953908 | 
2026-06-10 08:39:30.954020 | PLAY RECAP
2026-06-10 08:39:30.954068 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-10 08:39:30.954088 | 
2026-06-10 08:39:31.108993 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-10 08:39:31.110412 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-10 08:39:31.747894 | 
2026-06-10 08:39:31.748007 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-06-10 08:39:31.758937 | 
2026-06-10 08:39:31.759035 | TASK [Gather required facts]
2026-06-10 08:39:32.414896 | controller | ok
2026-06-10 08:39:32.423484 | 
2026-06-10 08:39:32.423693 | TASK [Load environment var if instructed to]
2026-06-10 08:39:32.460843 | controller | skipping: Conditional result was False
2026-06-10 08:39:32.470789 | 
2026-06-10 08:39:32.471004 | TASK [Ensure group_vars dir exists]
2026-06-10 08:39:32.904270 | controller | ok
2026-06-10 08:39:32.912860 | 
2026-06-10 08:39:32.913008 | TASK [Print related variables]
2026-06-10 08:39:32.947203 | controller | ok:
2026-06-10 08:39:32.947478 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-06-10 08:39:32.947596 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_helpers
2026-06-10 08:39:32.954974 | 
2026-06-10 08:39:32.955126 | TASK [Run molecule]
2026-06-10 08:39:34.306696 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-06-10 08:39:34.400482 | controller | INFO     Performing prerun with role_name_check=0...
2026-06-10 08:39:51.389591 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.390592 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.391740 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.392819 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.393834 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+40bee611 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 1.0.0+40bee611 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.394746 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.395662 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.396614 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.397589 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.398627 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.399550 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.400659 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.401650 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.402938 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.403984 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/e6630c/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-10 08:39:51.425980 | controller | INFO     Running default > prepare
2026-06-10 08:39:52.239516 | controller |
2026-06-10 08:39:52.239822 | controller | PLAY [Prepare] *****************************************************************
2026-06-10 08:39:52.240043 | controller |
2026-06-10 08:39:52.240269 | controller | TASK [Gathering Facts] *********************************************************
2026-06-10 08:39:52.240488 | controller | Wednesday 10 June 2026  08:39:52 +0000 (0:00:00.021)       0:00:00.021 ********
2026-06-10 08:39:53.215194 | controller | ok: [instance]
2026-06-10 08:39:53.215446 | controller |
2026-06-10 08:39:53.215777 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2026-06-10 08:39:53.216126 | controller | Wednesday 10 June 2026  08:39:53 +0000 (0:00:00.976)       0:00:00.997 ********
2026-06-10 08:39:53.249278 | controller | skipping: [instance]
2026-06-10 08:39:53.249433 | controller |
2026-06-10 08:39:53.249645 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2026-06-10 08:39:53.249937 | controller | Wednesday 10 June 2026  08:39:53 +0000 (0:00:00.034)       0:00:01.031 ********
2026-06-10 08:39:53.331991 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2026-06-10 08:39:53.332255 | controller |
2026-06-10 08:39:53.332581 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2026-06-10 08:39:53.333129 | controller | Wednesday 10 June 2026  08:39:53 +0000 (0:00:00.082)       0:00:01.114 ********
2026-06-10 08:39:53.648577 | controller | ok: [instance]
2026-06-10 08:39:53.648744 | controller |
2026-06-10 08:39:53.649026 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2026-06-10 08:39:53.649294 | controller | Wednesday 10 June 2026  08:39:53 +0000 (0:00:00.317)       0:00:01.431 ********
2026-06-10 08:39:54.015998 | controller | ok: [instance]
2026-06-10 08:39:54.016090 | controller |
2026-06-10 08:39:54.016236 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2026-06-10 08:39:54.016390 | controller | Wednesday 10 June 2026  08:39:54 +0000 (0:00:00.367)       0:00:01.798 ********
2026-06-10 08:39:54.892856 | controller | ok: [instance] => (item=ubi-9-appstream)
2026-06-10 08:39:54.893071 | controller | ok: [instance] => (item=ubi-9-baseos)
2026-06-10 08:39:54.893095 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2026-06-10 08:39:54.893108 | controller |
2026-06-10 08:39:54.893215 | controller | TASK [Deploy repo-setup] *******************************************************
2026-06-10 08:39:54.893314 | controller | Wednesday 10 June 2026  08:39:54 +0000 (0:00:00.876)       0:00:02.675 ********
2026-06-10 08:39:54.986805 | controller |
2026-06-10 08:39:54.986890 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-06-10 08:39:54.986983 | controller | Wednesday 10 June 2026  08:39:54 +0000 (0:00:00.094)       0:00:02.770 ********
2026-06-10 08:39:55.588732 | controller | changed: [instance] => (item=tmp)
2026-06-10 08:39:55.588791 | controller | changed: [instance] => (item=artifacts/repositories)
2026-06-10 08:39:55.588906 | controller | changed: [instance] => (item=venv/repo_setup)
2026-06-10 08:39:55.588999 | controller |
2026-06-10 08:39:55.589097 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-06-10 08:39:55.589191 | controller | Wednesday 10 June 2026  08:39:55 +0000 (0:00:00.601)       0:00:03.371 ********
2026-06-10 08:39:56.512419 | controller | ok: [instance]
2026-06-10 08:39:56.512977 | controller |
2026-06-10 08:39:56.513022 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-06-10 08:39:56.513039 | controller | Wednesday 10 June 2026  08:39:56 +0000 (0:00:00.922)       0:00:04.294 ********
2026-06-10 08:39:57.772003 | controller | changed: [instance]
2026-06-10 08:39:57.772051 | controller |
2026-06-10 08:39:57.772065 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-06-10 08:39:57.772078 | controller | Wednesday 10 June 2026  08:39:57 +0000 (0:00:01.258)       0:00:05.553 ********
2026-06-10 08:40:05.883827 | controller | changed: [instance]
2026-06-10 08:40:05.884248 | controller |
2026-06-10 08:40:05.884274 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-06-10 08:40:05.884281 | controller | Wednesday 10 June 2026  08:40:05 +0000 (0:00:08.112)       0:00:13.666 ********
2026-06-10 08:40:06.662881 | controller | changed: [instance]
2026-06-10 08:40:06.662914 | controller |
2026-06-10 08:40:06.663226 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-06-10 08:40:06.663273 | controller | Wednesday 10 June 2026  08:40:06 +0000 (0:00:00.778)       0:00:14.445 ********
2026-06-10 08:40:06.702881 | controller | skipping: [instance]
2026-06-10 08:40:06.703487 | controller |
2026-06-10 08:40:06.703524 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-06-10 08:40:06.703533 | controller | Wednesday 10 June 2026  08:40:06 +0000 (0:00:00.039)       0:00:14.484 ********
2026-06-10 08:40:07.413896 | controller | changed: [instance]
2026-06-10 08:40:07.413927 | controller |
2026-06-10 08:40:07.413931 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-06-10 08:40:07.414165 | controller | Wednesday 10 June 2026  08:40:07 +0000 (0:00:00.710)       0:00:15.195 ********
2026-06-10 08:40:07.455898 | controller | skipping: [instance]
2026-06-10 08:40:07.455928 | controller |
2026-06-10 08:40:07.455932 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-06-10 08:40:07.455949 | controller | Wednesday 10 June 2026  08:40:07 +0000 (0:00:00.041)       0:00:15.237 ********
2026-06-10 08:40:07.502989 | controller | skipping: [instance]
2026-06-10 08:40:07.503038 | controller |
2026-06-10 08:40:07.503048 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-06-10 08:40:07.503057 | controller | Wednesday 10 June 2026  08:40:07 +0000 (0:00:00.046)       0:00:15.284 ********
2026-06-10 08:40:07.551822 | controller | skipping: [instance]
2026-06-10 08:40:07.552396 | controller |
2026-06-10 08:40:07.552687 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-06-10 08:40:07.552974 | controller | Wednesday 10 June 2026  08:40:07 +0000 (0:00:00.049)       0:00:15.334 ********
2026-06-10 08:40:08.003852 | controller | changed: [instance]
2026-06-10 08:40:08.004521 | controller |
2026-06-10 08:40:08.004575 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-06-10 08:40:08.004589 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.451)       0:00:15.786 ********
2026-06-10 08:40:08.549847 | controller | changed: [instance]
2026-06-10 08:40:08.549872 | controller |
2026-06-10 08:40:08.550258 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-06-10 08:40:08.550295 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.546)       0:00:16.332 ********
2026-06-10 08:40:08.602888 | controller | skipping: [instance]
2026-06-10 08:40:08.602938 | controller |
2026-06-10 08:40:08.602948 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-06-10 08:40:08.602958 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.052)       0:00:16.384 ********
2026-06-10 08:40:08.653228 | controller | skipping: [instance]
2026-06-10 08:40:08.653262 | controller |
2026-06-10 08:40:08.653267 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-06-10 08:40:08.653271 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.050)       0:00:16.435 ********
2026-06-10 08:40:08.707886 | controller | skipping: [instance]
2026-06-10 08:40:08.708755 | controller |
2026-06-10 08:40:08.708822 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-06-10 08:40:08.708837 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.054)       0:00:16.490 ********
2026-06-10 08:40:08.782188 | controller | ok: [instance]
2026-06-10 08:40:08.782541 | controller |
2026-06-10 08:40:08.782924 | controller | TASK [repo_setup : Create download directory] **********************************
2026-06-10 08:40:08.783241 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.074)       0:00:16.564 ********
2026-06-10 08:40:08.838213 | controller | skipping: [instance]
2026-06-10 08:40:08.838433 | controller |
2026-06-10 08:40:08.838624 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-06-10 08:40:08.838845 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.056)       0:00:16.620 ********
2026-06-10 08:40:08.889073 | controller | skipping: [instance]
2026-06-10 08:40:08.889396 | controller |
2026-06-10 08:40:08.889692 | controller | TASK [Download the RPM] ********************************************************
2026-06-10 08:40:08.890043 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.050)       0:00:16.671 ********
2026-06-10 08:40:08.940130 | controller | skipping: [instance]
2026-06-10 08:40:08.940444 | controller |
2026-06-10 08:40:08.940798 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-06-10 08:40:08.941101 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.050)       0:00:16.722 ********
2026-06-10 08:40:08.993858 | controller | skipping: [instance]
2026-06-10 08:40:08.994214 | controller |
2026-06-10 08:40:08.994518 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-06-10 08:40:08.994845 | controller | Wednesday 10 June 2026  08:40:08 +0000 (0:00:00.053)       0:00:16.776 ********
2026-06-10 08:40:09.042197 | controller | skipping: [instance]
2026-06-10 08:40:09.042369 | controller |
2026-06-10 08:40:09.042502 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-06-10 08:40:09.042643 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.049)       0:00:16.825 ********
2026-06-10 08:40:09.093783 | controller | skipping: [instance]
2026-06-10 08:40:09.094112 | controller |
2026-06-10 08:40:09.094423 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-06-10 08:40:09.094796 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.051)       0:00:16.876 ********
2026-06-10 08:40:09.123994 | controller | skipping: [instance]
2026-06-10 08:40:09.124192 | controller |
2026-06-10 08:40:09.124372 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-06-10 08:40:09.124549 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.030)       0:00:16.907 ********
2026-06-10 08:40:09.366796 | controller | ok: [instance]
2026-06-10 08:40:09.366835 | controller |
2026-06-10 08:40:09.366846 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-06-10 08:40:09.366855 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.242)       0:00:17.149 ********
2026-06-10 08:40:09.596766 | controller | changed: [instance]
2026-06-10 08:40:09.596808 | controller |
2026-06-10 08:40:09.596819 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-06-10 08:40:09.596830 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.229)       0:00:17.379 ********
2026-06-10 08:40:09.933929 | controller | changed: [instance]
2026-06-10 08:40:09.933966 | controller |
2026-06-10 08:40:09.933977 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-06-10 08:40:09.933985 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.336)       0:00:17.715 ********
2026-06-10 08:40:09.961776 | controller | skipping: [instance]
2026-06-10 08:40:09.961817 | controller |
2026-06-10 08:40:09.961827 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-06-10 08:40:09.961836 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.027)       0:00:17.743 ********
2026-06-10 08:40:09.992929 | controller | skipping: [instance]
2026-06-10 08:40:09.992968 | controller |
2026-06-10 08:40:09.992979 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-06-10 08:40:09.992989 | controller | Wednesday 10 June 2026  08:40:09 +0000 (0:00:00.031)       0:00:17.775 ********
2026-06-10 08:40:10.022876 | controller | skipping: [instance]
2026-06-10 08:40:10.022912 | controller |
2026-06-10 08:40:10.022922 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-06-10 08:40:10.022992 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.030)       0:00:17.805 ********
2026-06-10 08:40:10.055645 | controller | skipping: [instance]
2026-06-10 08:40:10.055908 | controller |
2026-06-10 08:40:10.056062 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-06-10 08:40:10.056221 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.033)       0:00:17.838 ********
2026-06-10 08:40:10.096065 | controller | skipping: [instance]
2026-06-10 08:40:10.096216 | controller |
2026-06-10 08:40:10.096377 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-06-10 08:40:10.096539 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.040)       0:00:17.879 ********
2026-06-10 08:40:10.135169 | controller | skipping: [instance]
2026-06-10 08:40:10.135287 | controller |
2026-06-10 08:40:10.135442 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-06-10 08:40:10.135688 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.038)       0:00:17.917 ********
2026-06-10 08:40:10.164761 | controller | skipping: [instance]
2026-06-10 08:40:10.164935 | controller |
2026-06-10 08:40:10.165098 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-06-10 08:40:10.165249 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.029)       0:00:17.947 ********
2026-06-10 08:40:10.223764 | controller | skipping: [instance]
2026-06-10 08:40:10.223962 | controller |
2026-06-10 08:40:10.224125 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-06-10 08:40:10.224290 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.058)       0:00:18.006 ********
2026-06-10 08:40:10.250901 | controller | skipping: [instance]
2026-06-10 08:40:10.251209 | controller |
2026-06-10 08:40:10.251550 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-06-10 08:40:10.251982 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.027)       0:00:18.033 ********
2026-06-10 08:40:10.284797 | controller | skipping: [instance]
2026-06-10 08:40:10.284936 | controller |
2026-06-10 08:40:10.285103 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2026-06-10 08:40:10.285261 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.034)       0:00:18.068 ********
2026-06-10 08:40:10.335406 | controller | skipping: [instance]
2026-06-10 08:40:10.335578 | controller |
2026-06-10 08:40:10.335837 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2026-06-10 08:40:10.336025 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.050)       0:00:18.118 ********
2026-06-10 08:40:10.393431 | controller | skipping: [instance]
2026-06-10 08:40:10.393569 | controller |
2026-06-10 08:40:10.393758 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2026-06-10 08:40:10.393968 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.058)       0:00:18.176 ********
2026-06-10 08:40:10.453226 | controller | skipping: [instance]
2026-06-10 08:40:10.453331 | controller |
2026-06-10 08:40:10.453508 | controller | TASK [test_deps : Install additional packages] *********************************
2026-06-10 08:40:10.453668 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.059)       0:00:18.236 ********
2026-06-10 08:40:10.508253 | controller | skipping: [instance]
2026-06-10 08:40:10.508495 | controller |
2026-06-10 08:40:10.508830 | controller | TASK [test_deps : Install selinux python libs] *********************************
2026-06-10 08:40:10.509131 | controller | Wednesday 10 June 2026  08:40:10 +0000 (0:00:00.054)       0:00:18.291 ********
2026-06-10 08:42:02.414948 | controller | ok: [instance]
2026-06-10 08:42:02.415057 | controller |
2026-06-10 08:42:02.415437 | controller | TASK [test_deps : Install python yaml libs] ************************************
2026-06-10 08:42:02.415460 | controller | Wednesday 10 June 2026  08:42:02 +0000 (0:01:51.906)       0:02:10.197 ********
2026-06-10 08:42:03.848837 | controller | ok: [instance]
2026-06-10 08:42:03.848865 | controller |
2026-06-10 08:42:03.848870 | controller | TASK [test_deps : Install extra packages] **************************************
2026-06-10 08:42:03.849077 | controller | Wednesday 10 June 2026  08:42:03 +0000 (0:00:01.432)       0:02:11.630 ********
2026-06-10 08:42:03.892021 | controller | skipping: [instance]
2026-06-10 08:42:03.892066 | controller |
2026-06-10 08:42:03.892307 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2026-06-10 08:42:03.892349 | controller | Wednesday 10 June 2026  08:42:03 +0000 (0:00:00.043)       0:02:11.674 ********
2026-06-10 08:42:03.970942 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2026-06-10 08:42:03.971239 | controller |
2026-06-10 08:42:03.971552 | controller | TASK [ci_setup : List packages to install] *************************************
2026-06-10 08:42:03.971857 | controller | Wednesday 10 June 2026  08:42:03 +0000 (0:00:00.079)       0:02:11.753 ********
2026-06-10 08:42:04.000848 | controller | ok: [instance] =>
2026-06-10 08:42:04.001146 | controller |   cifmw_ci_setup_packages:
2026-06-10 08:42:04.001405 | controller |   - bash-completion
2026-06-10 08:42:04.001659 | controller |   - ca-certificates
2026-06-10 08:42:04.001949 | controller |   - git-core
2026-06-10 08:42:04.002203 | controller |   - make
2026-06-10 08:42:04.002466 | controller |   - tar
2026-06-10 08:42:04.002750 | controller |   - tmux
2026-06-10 08:42:04.003020 | controller |   - python3-pip
2026-06-10 08:42:04.003260 | controller |
2026-06-10 08:42:04.003556 | controller | TASK [ci_setup : Install needed packages] **************************************
2026-06-10 08:42:04.003851 | controller | Wednesday 10 June 2026  08:42:03 +0000 (0:00:00.029)       0:02:11.783 ********
2026-06-10 08:42:06.867371 | controller | changed: [instance]
2026-06-10 08:42:06.867521 | controller |
2026-06-10 08:42:06.867649 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2026-06-10 08:42:06.867816 | controller | Wednesday 10 June 2026  08:42:06 +0000 (0:00:02.866)       0:02:14.650 ********
2026-06-10 08:42:07.053829 | controller | ok: [instance]
2026-06-10 08:42:07.053856 | controller |
2026-06-10 08:42:07.053861 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2026-06-10 08:42:07.053868 | controller | Wednesday 10 June 2026  08:42:07 +0000 (0:00:00.186)       0:02:14.836 ********
2026-06-10 08:42:07.273139 | controller | changed: [instance]
2026-06-10 08:42:07.273176 | controller |
2026-06-10 08:42:07.273187 | controller | TASK [ci_setup : Install openshift client] *************************************
2026-06-10 08:42:07.273196 | controller | Wednesday 10 June 2026  08:42:07 +0000 (0:00:00.217)       0:02:15.054 ********
2026-06-10 08:42:11.204212 | controller | changed: [instance]
2026-06-10 08:42:11.204254 | controller |
2026-06-10 08:42:11.204264 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2026-06-10 08:42:11.204274 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:03.931)       0:02:18.986 ********
2026-06-10 08:42:11.239058 | controller | skipping: [instance]
2026-06-10 08:42:11.239110 | controller |
2026-06-10 08:42:11.239121 | controller | TASK [ci_setup : Create completion file] ***************************************
2026-06-10 08:42:11.239130 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.034)       0:02:19.021 ********
2026-06-10 08:42:11.596288 | controller | changed: [instance]
2026-06-10 08:42:11.596314 | controller |
2026-06-10 08:42:11.596319 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2026-06-10 08:42:11.596323 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.357)       0:02:19.379 ********
2026-06-10 08:42:11.910148 | controller | changed: [instance]
2026-06-10 08:42:11.910173 | controller |
2026-06-10 08:42:11.910178 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2026-06-10 08:42:11.910182 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.314)       0:02:19.693 ********
2026-06-10 08:42:11.925940 | controller | skipping: [instance]
2026-06-10 08:42:11.925966 | controller |
2026-06-10 08:42:11.925970 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2026-06-10 08:42:11.925975 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.015)       0:02:19.709 ********
2026-06-10 08:42:11.947107 | controller | skipping: [instance]
2026-06-10 08:42:11.947130 | controller |
2026-06-10 08:42:11.947135 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2026-06-10 08:42:11.947139 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.020)       0:02:19.729 ********
2026-06-10 08:42:11.973890 | controller | skipping: [instance]
2026-06-10 08:42:11.973917 | controller |
2026-06-10 08:42:11.973924 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2026-06-10 08:42:11.973933 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.026)       0:02:19.756 ********
2026-06-10 08:42:11.994660 | controller | skipping: [instance]
2026-06-10 08:42:11.994679 | controller |
2026-06-10 08:42:11.994683 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2026-06-10 08:42:11.994687 | controller | Wednesday 10 June 2026  08:42:11 +0000 (0:00:00.021)       0:02:19.777 ********
2026-06-10 08:42:12.013932 | controller | skipping: [instance]
2026-06-10 08:42:12.013989 | controller |
2026-06-10 08:42:12.014000 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2026-06-10 08:42:12.014029 | controller | Wednesday 10 June 2026  08:42:12 +0000 (0:00:00.019)       0:02:19.797 ********
2026-06-10 08:42:12.051931 | controller | skipping: [instance]
2026-06-10 08:42:12.051960 | controller |
2026-06-10 08:42:12.052174 | controller | TASK [ci_setup : Manage directories] *******************************************
2026-06-10 08:42:12.052411 | controller | Wednesday 10 June 2026  08:42:12 +0000 (0:00:00.038)       0:02:19.835 ********
2026-06-10 08:42:13.313938 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2026-06-10 08:42:13.313978 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2026-06-10 08:42:13.313982 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2026-06-10 08:42:13.313986 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2026-06-10 08:42:13.314727 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2026-06-10 08:42:13.314803 | controller |
2026-06-10 08:42:13.314814 | controller | TASK [Create file with vars] ***************************************************
2026-06-10 08:42:13.314822 | controller | Wednesday 10 June 2026  08:42:13 +0000 (0:00:01.260)       0:02:21.095 ********
2026-06-10 08:42:13.770974 | controller | changed: [instance]
2026-06-10 08:42:13.771017 | controller |
2026-06-10 08:42:13.771198 | controller | TASK [Create directory for var files] ******************************************
2026-06-10 08:42:13.771231 | controller | Wednesday 10 June 2026  08:42:13 +0000 (0:00:00.458)       0:02:21.553 ********
2026-06-10 08:42:14.021984 | controller | changed: [instance]
2026-06-10 08:42:14.022021 | controller |
2026-06-10 08:42:14.022281 | controller | TASK [Create first var file in directory] **************************************
2026-06-10 08:42:14.022311 | controller | Wednesday 10 June 2026  08:42:14 +0000 (0:00:00.250)       0:02:21.804 ********
2026-06-10 08:42:14.427857 | controller | changed: [instance]
2026-06-10 08:42:14.427895 | controller |
2026-06-10 08:42:14.427900 | controller | TASK [Create second var file in directory] *************************************
2026-06-10 08:42:14.427905 | controller | Wednesday 10 June 2026  08:42:14 +0000 (0:00:00.405)       0:02:22.210 ********
2026-06-10 08:42:14.821711 | controller | changed: [instance]
2026-06-10 08:42:14.821775 | controller |
2026-06-10 08:42:14.821786 | controller | TASK [Create file for various vars] ********************************************
2026-06-10 08:42:14.821795 | controller | Wednesday 10 June 2026  08:42:14 +0000 (0:00:00.393)       0:02:22.604 ********
2026-06-10 08:42:15.178924 | controller | changed: [instance]
2026-06-10 08:42:15.178965 | controller |
2026-06-10 08:42:15.179102 | controller | TASK [Install required packages] ***********************************************
2026-06-10 08:42:15.179127 | controller | Wednesday 10 June 2026  08:42:15 +0000 (0:00:00.355)       0:02:22.960 ********
2026-06-10 08:42:16.560561 | controller | ok: [instance]
2026-06-10 08:42:16.560613 | controller |
2026-06-10 08:42:16.560627 | controller | TASK [Create file with jinja2 var] *********************************************
2026-06-10 08:42:16.560636 | controller | Wednesday 10 June 2026  08:42:16 +0000 (0:00:01.382)       0:02:24.342 ********
2026-06-10 08:42:16.958631 | controller | changed: [instance]
2026-06-10 08:42:16.958658 | controller |
2026-06-10 08:42:16.958665 | controller | TASK [Create directory for include dir] ****************************************
2026-06-10 08:42:16.958671 | controller | Wednesday 10 June 2026  08:42:16 +0000 (0:00:00.399)       0:02:24.741 ********
2026-06-10 08:42:17.164245 | controller | changed: [instance]
2026-06-10 08:42:17.164275 | controller |
2026-06-10 08:42:17.164281 | controller | TASK [Create file with jinja2 var in include dir] ******************************
2026-06-10 08:42:17.164286 | controller | Wednesday 10 June 2026  08:42:17 +0000 (0:00:00.205)       0:02:24.947 ********
2026-06-10 08:42:17.532183 | controller | changed: [instance]
2026-06-10 08:42:17.532212 | controller |
2026-06-10 08:42:17.532217 | controller | TASK [Create file without extension] *******************************************
2026-06-10 08:42:17.532221 | controller | Wednesday 10 June 2026  08:42:17 +0000 (0:00:00.367)       0:02:25.314 ********
2026-06-10 08:42:17.925861 | controller | changed: [instance]
2026-06-10 08:42:17.925885 | controller |
2026-06-10 08:42:17.925891 | controller | PLAY RECAP *********************************************************************
2026-06-10 08:42:17.925901 | controller | instance                   : ok=38   changed=24   unreachable=0    failed=0    skipped=37   rescued=0    ignored=0
2026-06-10 08:42:17.925905 | controller |
2026-06-10 08:42:17.925908 | controller | Wednesday 10 June 2026  08:42:17 +0000 (0:00:00.392)       0:02:25.707 ********
2026-06-10 08:42:17.925912 | controller | ===============================================================================
2026-06-10 08:42:17.926896 | controller | test_deps : Install selinux python libs ------------------------------- 111.91s
2026-06-10 08:42:17.926944 | controller | repo_setup : Initialize python venv and install requirements ------------ 8.11s
2026-06-10 08:42:17.926951 | controller | ci_setup : Install openshift client ------------------------------------- 3.93s
2026-06-10 08:42:17.926957 | controller | ci_setup : Install needed packages -------------------------------------- 2.87s
2026-06-10 08:42:17.926962 | controller | test_deps : Install python yaml libs ------------------------------------ 1.43s
2026-06-10 08:42:17.926967 | controller | Install required packages ----------------------------------------------- 1.38s
2026-06-10 08:42:17.926972 | controller | ci_setup : Manage directories ------------------------------------------- 1.26s
2026-06-10 08:42:17.926976 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.26s
2026-06-10 08:42:17.926981 | controller | Gathering Facts --------------------------------------------------------- 0.98s
2026-06-10 08:42:17.926986 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.92s
2026-06-10 08:42:17.927812 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.88s
2026-06-10 08:42:17.927841 | controller | repo_setup : Install repo-setup package --------------------------------- 0.78s
2026-06-10 08:42:17.927846 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.71s
2026-06-10 08:42:17.927850 | controller | repo_setup : Ensure directories are present ----------------------------- 0.60s
2026-06-10 08:42:17.927853 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.55s
2026-06-10 08:42:17.927857 | controller | Create file with vars --------------------------------------------------- 0.46s
2026-06-10 08:42:17.927860 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.45s
2026-06-10 08:42:17.927864 | controller | Create first var file in directory -------------------------------------- 0.41s
2026-06-10 08:42:17.927867 | controller | Create file with jinja2 var --------------------------------------------- 0.40s
2026-06-10 08:42:17.927871 | controller | Create second var file in directory ------------------------------------- 0.39s
2026-06-10 08:42:18.015799 | controller | INFO     Running default > converge
2026-06-10 08:42:18.453605 | controller |
2026-06-10 08:42:18.453725 | controller | PLAY [Converge] ****************************************************************
2026-06-10 08:42:18.453878 | controller |
2026-06-10 08:42:18.453997 | controller | TASK [Gathering Facts] *********************************************************
2026-06-10 08:42:18.454107 | controller | Wednesday 10 June 2026  08:42:18 +0000 (0:00:00.013)       0:00:00.013 ********
2026-06-10 08:42:19.294422 | controller | ok: [instance]
2026-06-10 08:42:19.294452 | controller |
2026-06-10 08:42:19.294458 | controller | TASK [Read file with facts] ****************************************************
2026-06-10 08:42:19.294462 | controller | Wednesday 10 June 2026  08:42:19 +0000 (0:00:00.840)       0:00:00.853 ********
2026-06-10 08:42:19.327277 | controller |
2026-06-10 08:42:19.327299 | controller | TASK [cifmw_helpers : Fail if file is not yaml or yml extension] ***************
2026-06-10 08:42:19.327304 | controller | Wednesday 10 June 2026  08:42:19 +0000 (0:00:00.033)       0:00:00.886 ********
2026-06-10 08:42:19.381511 | controller | skipping: [instance]
2026-06-10 08:42:19.381540 | controller |
2026-06-10 08:42:19.381545 | controller | TASK [cifmw_helpers : Check if file is available] ******************************
2026-06-10 08:42:19.381549 | controller | Wednesday 10 June 2026  08:42:19 +0000 (0:00:00.053)       0:00:00.940 ********
2026-06-10 08:42:19.723154 | controller | ok: [instance]
2026-06-10 08:42:19.723233 | controller |
2026-06-10 08:42:19.723245 | controller | TASK [cifmw_helpers : Read the vars] *******************************************
2026-06-10 08:42:19.723265 | controller | Wednesday 10 June 2026  08:42:19 +0000 (0:00:00.341)       0:00:01.281 ********
2026-06-10 08:42:20.048504 | controller | ok: [instance]
2026-06-10 08:42:20.048535 | controller |
2026-06-10 08:42:20.048542 | controller | TASK [cifmw_helpers : Set vars as fact] ****************************************
2026-06-10 08:42:20.048548 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.325)       0:00:01.607 ********
2026-06-10 08:42:20.088527 | controller | ok: [instance] => (item=None)
2026-06-10 08:42:20.088559 | controller | ok: [instance]
2026-06-10 08:42:20.088566 | controller |
2026-06-10 08:42:20.088572 | controller | TASK [Check if some_var is available] ******************************************
2026-06-10 08:42:20.088578 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.040)       0:00:01.647 ********
2026-06-10 08:42:20.108851 | controller | ok: [instance] => changed=false
2026-06-10 08:42:20.108881 | controller |   msg: All assertions passed
2026-06-10 08:42:20.108888 | controller |
2026-06-10 08:42:20.108894 | controller | TASK [Read all files in directory and set as fact] *****************************
2026-06-10 08:42:20.108900 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.020)       0:00:01.667 ********
2026-06-10 08:42:20.161613 | controller |
2026-06-10 08:42:20.161645 | controller | TASK [cifmw_helpers : Check directory is available] ****************************
2026-06-10 08:42:20.161652 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.052)       0:00:01.720 ********
2026-06-10 08:42:20.365417 | controller | ok: [instance]
2026-06-10 08:42:20.365562 | controller |
2026-06-10 08:42:20.365712 | controller | TASK [cifmw_helpers : Find yaml files] *****************************************
2026-06-10 08:42:20.365950 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.203)       0:00:01.924 ********
2026-06-10 08:42:20.667528 | controller | ok: [instance]
2026-06-10 08:42:20.667555 | controller |
2026-06-10 08:42:20.667560 | controller | TASK [cifmw_helpers : Print available yaml files] ******************************
2026-06-10 08:42:20.667565 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.302)       0:00:02.226 ********
2026-06-10 08:42:20.723147 | controller | ok: [instance] =>
2026-06-10 08:42:20.723181 | controller |   msg: |-
2026-06-10 08:42:20.723189 | controller |     Found yaml files to parse: ['/tmp/provided_dir/firstfile.yml', '/tmp/provided_dir/secondfile.yml']
2026-06-10 08:42:20.723195 | controller |
2026-06-10 08:42:20.723201 | controller | TASK [cifmw_helpers : Read vars] ***********************************************
2026-06-10 08:42:20.723207 | controller | Wednesday 10 June 2026  08:42:20 +0000 (0:00:00.054)       0:00:02.281 ********
2026-06-10 08:42:21.124738 | controller | ok: [instance] => (item=None)
2026-06-10 08:42:21.124769 | controller | ok: [instance] => (item=None)
2026-06-10 08:42:21.124774 | controller | ok: [instance]
2026-06-10 08:42:21.124778 | controller |
2026-06-10 08:42:21.124783 | controller | TASK [cifmw_helpers : Call task to parse all files as fact] ********************
2026-06-10 08:42:21.124787 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.401)       0:00:02.683 ********
2026-06-10 08:42:21.167857 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_helpers/tasks/set_dir_facts.yml for instance => (item=(censored due to no_log))
2026-06-10 08:42:21.167883 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_helpers/tasks/set_dir_facts.yml for instance => (item=(censored due to no_log))
2026-06-10 08:42:21.168165 | controller |
2026-06-10 08:42:21.168192 | controller | TASK [cifmw_helpers : Set files as fact] ***************************************
2026-06-10 08:42:21.168196 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.043)       0:00:02.727 ********
2026-06-10 08:42:21.212571 | controller | ok: [instance] => (item=None)
2026-06-10 08:42:21.212602 | controller | ok: [instance]
2026-06-10 08:42:21.212608 | controller |
2026-06-10 08:42:21.212624 | controller | TASK [cifmw_helpers : Set files as fact] ***************************************
2026-06-10 08:42:21.212630 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.044)       0:00:02.771 ********
2026-06-10 08:42:21.255439 | controller | ok: [instance] => (item=None)
2026-06-10 08:42:21.255465 | controller | ok: [instance]
2026-06-10 08:42:21.255470 | controller |
2026-06-10 08:42:21.255474 | controller | TASK [Check if variables from dir are available] *******************************
2026-06-10 08:42:21.255478 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.042)       0:00:02.814 ********
2026-06-10 08:42:21.281863 | controller | ok: [instance] => changed=false
2026-06-10 08:42:21.281890 | controller |   msg: All assertions passed
2026-06-10 08:42:21.281895 | controller |
2026-06-10 08:42:21.281899 | controller | TASK [Check various files] *****************************************************
2026-06-10 08:42:21.281907 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.026)       0:00:02.841 ********
2026-06-10 08:42:21.314886 | controller |
2026-06-10 08:42:21.314976 | controller | TASK [cifmw_helpers : Filter Ansible variable files and set as fact] ***********
2026-06-10 08:42:21.315088 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.033)       0:00:02.874 ********
2026-06-10 08:42:21.357433 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_helpers/tasks/var_file.yml for instance => (item=@/tmp/various_vars.yml)
2026-06-10 08:42:21.357518 | controller |
2026-06-10 08:42:21.357625 | controller | TASK [cifmw_helpers : Fail if file is not yaml or yml extension] ***************
2026-06-10 08:42:21.357755 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.042)       0:00:02.916 ********
2026-06-10 08:42:21.390411 | controller | skipping: [instance]
2026-06-10 08:42:21.390487 | controller |
2026-06-10 08:42:21.390598 | controller | TASK [cifmw_helpers : Check if file is available] ******************************
2026-06-10 08:42:21.390710 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.033)       0:00:02.949 ********
2026-06-10 08:42:21.605341 | controller | ok: [instance]
2026-06-10 08:42:21.605368 | controller |
2026-06-10 08:42:21.605373 | controller | TASK [cifmw_helpers : Read the vars] *******************************************
2026-06-10 08:42:21.605378 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.214)       0:00:03.164 ********
2026-06-10 08:42:21.791989 | controller | ok: [instance]
2026-06-10 08:42:21.792016 | controller |
2026-06-10 08:42:21.792021 | controller | TASK [cifmw_helpers : Set vars as fact] ****************************************
2026-06-10 08:42:21.792026 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.186)       0:00:03.351 ********
2026-06-10 08:42:21.825920 | controller | ok: [instance] => (item=None)
2026-06-10 08:42:21.825957 | controller | ok: [instance]
2026-06-10 08:42:21.825983 | controller |
2026-06-10 08:42:21.826221 | controller | TASK [cifmw_helpers : Filter just dict and set as fact] ************************
2026-06-10 08:42:21.826243 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.034)       0:00:03.385 ********
2026-06-10 08:42:21.868894 | controller | ok: [instance] => (item={'key': 'mytest', 'value': True})
2026-06-10 08:42:21.868934 | controller |
2026-06-10 08:42:21.868941 | controller | TASK [Check if variables from various vars exists] *****************************
2026-06-10 08:42:21.868947 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.042)       0:00:03.428 ********
2026-06-10 08:42:21.890311 | controller | ok: [instance] => changed=false
2026-06-10 08:42:21.890341 | controller |   msg: All assertions passed
2026-06-10 08:42:21.890346 | controller |
2026-06-10 08:42:21.890350 | controller | TASK [Make a symlink to local .ansible collection dir] *************************
2026-06-10 08:42:21.890355 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.021)       0:00:03.449 ********
2026-06-10 08:42:21.924901 | controller |
2026-06-10 08:42:21.924941 | controller | TASK [cifmw_helpers : Check if the ci-framework exists] ************************
2026-06-10 08:42:21.924951 | controller | Wednesday 10 June 2026  08:42:21 +0000 (0:00:00.034)       0:00:03.484 ********
2026-06-10 08:42:22.164602 | controller | ok: [instance]
2026-06-10 08:42:22.164637 | controller |
2026-06-10 08:42:22.164643 | controller | TASK [cifmw_helpers : Check if cifmw general collection exists] ****************
2026-06-10 08:42:22.164649 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.238)       0:00:03.723 ********
2026-06-10 08:42:22.395019 | controller | ok: [instance]
2026-06-10 08:42:22.395060 | controller |
2026-06-10 08:42:22.395071 | controller | TASK [cifmw_helpers : Workaround for earlier nested ansible execution] *********
2026-06-10 08:42:22.395080 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.229)       0:00:03.953 ********
2026-06-10 08:42:22.411455 | controller | skipping: [instance]
2026-06-10 08:42:22.411481 | controller |
2026-06-10 08:42:22.411490 | controller | TASK [cifmw_helpers : Create symlink to the local .ansible collection dir] *****
2026-06-10 08:42:22.411499 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.017)       0:00:03.970 ********
2026-06-10 08:42:22.433681 | controller | skipping: [instance]
2026-06-10 08:42:22.433751 | controller |
2026-06-10 08:42:22.433765 | controller | TASK [Check if symlink was done] ***********************************************
2026-06-10 08:42:22.433787 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.021)       0:00:03.992 ********
2026-06-10 08:42:22.750477 | controller | ok: [instance]
2026-06-10 08:42:22.750515 | controller |
2026-06-10 08:42:22.750525 | controller | TASK [Assert that symlink was done] ********************************************
2026-06-10 08:42:22.750534 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.316)       0:00:04.308 ********
2026-06-10 08:42:22.771949 | controller | ok: [instance] => changed=false
2026-06-10 08:42:22.771999 | controller |   msg: All assertions passed
2026-06-10 08:42:22.772009 | controller |
2026-06-10 08:42:22.772318 | controller | TASK [Check include file] ******************************************************
2026-06-10 08:42:22.772350 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.022)       0:00:04.330 ********
2026-06-10 08:42:22.811752 | controller |
2026-06-10 08:42:22.811793 | controller | TASK [cifmw_helpers : Fail if file is not yaml or yml extension] ***************
2026-06-10 08:42:22.811802 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.039)       0:00:04.370 ********
2026-06-10 08:42:22.842846 | controller | skipping: [instance]
2026-06-10 08:42:22.842865 | controller |
2026-06-10 08:42:22.843040 | controller | TASK [cifmw_helpers : Check if file is available] ******************************
2026-06-10 08:42:22.843056 | controller | Wednesday 10 June 2026  08:42:22 +0000 (0:00:00.031)       0:00:04.402 ********
2026-06-10 08:42:23.168056 | controller | ok: [instance]
2026-06-10 08:42:23.168109 | controller |
2026-06-10 08:42:23.168120 | controller | TASK [cifmw_helpers : Create temporary directory] ******************************
2026-06-10 08:42:23.168130 | controller | Wednesday 10 June 2026  08:42:23 +0000 (0:00:00.324)       0:00:04.726 ********
2026-06-10 08:42:23.487344 | controller | changed: [instance -> localhost]
2026-06-10 08:42:23.487380 | controller |
2026-06-10 08:42:23.487388 | controller | TASK [cifmw_helpers : Read vars] ***********************************************
2026-06-10 08:42:23.487393 | controller | Wednesday 10 June 2026  08:42:23 +0000 (0:00:00.319)       0:00:05.046 ********
2026-06-10 08:42:23.730125 | controller | ok: [instance]
2026-06-10 08:42:23.730157 | controller |
2026-06-10 08:42:23.730163 | controller | TASK [cifmw_helpers : Create new variable files with content] ******************
2026-06-10 08:42:23.730169 | controller | Wednesday 10 June 2026  08:42:23 +0000 (0:00:00.242)       0:00:05.288 ********
2026-06-10 08:42:24.280222 | controller | changed: [instance -> localhost]
2026-06-10 08:42:24.280253 | controller |
2026-06-10 08:42:24.280260 | controller | TASK [cifmw_helpers : Include vars] ********************************************
2026-06-10 08:42:24.280266 | controller | Wednesday 10 June 2026  08:42:24 +0000 (0:00:00.549)       0:00:05.837 ********
2026-06-10 08:42:24.346288 | controller | ok: [instance -> localhost]
2026-06-10 08:42:24.346319 | controller |
2026-06-10 08:42:24.346328 | controller | TASK [cifmw_helpers : Remove temporary directory] ******************************
2026-06-10 08:42:24.346333 | controller | Wednesday 10 June 2026  08:42:24 +0000 (0:00:00.066)       0:00:05.904 ********
2026-06-10 08:42:24.735388 | controller | changed: [instance -> localhost]
2026-06-10 08:42:24.735418 | controller |
2026-06-10 08:42:24.735425 | controller | TASK [Check if jinja2 vars are translated] *************************************
2026-06-10 08:42:24.735431 | controller | Wednesday 10 June 2026  08:42:24 +0000 (0:00:00.389)       0:00:06.294 ********
2026-06-10 08:42:24.761856 | controller | ok: [instance] => changed=false
2026-06-10 08:42:24.761883 | controller |   msg: All assertions passed
2026-06-10 08:42:24.761893 | controller |
2026-06-10 08:42:24.762269 | controller | TASK [Check include dir] *******************************************************
2026-06-10 08:42:24.762286 | controller | Wednesday 10 June 2026  08:42:24 +0000 (0:00:00.026)       0:00:06.321 ********
2026-06-10 08:42:24.816803 | controller |
2026-06-10 08:42:24.816834 | controller | TASK [cifmw_helpers : Check directory is available] ****************************
2026-06-10 08:42:24.816921 | controller | Wednesday 10 June 2026  08:42:24 +0000 (0:00:00.054)       0:00:06.375 ********
2026-06-10 08:42:25.059861 | controller | ok: [instance]
2026-06-10 08:42:25.059891 | controller |
2026-06-10 08:42:25.060034 | controller | TASK [cifmw_helpers : Find yaml files] *****************************************
2026-06-10 08:42:25.060054 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.243)       0:00:06.619 ********
2026-06-10 08:42:25.276177 | controller | ok: [instance]
2026-06-10 08:42:25.276212 | controller |
2026-06-10 08:42:25.276217 | controller | TASK [cifmw_helpers : Print available yaml files] ******************************
2026-06-10 08:42:25.276221 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.215)       0:00:06.835 ********
2026-06-10 08:42:25.311892 | controller | ok: [instance] =>
2026-06-10 08:42:25.311930 | controller |   msg: |-
2026-06-10 08:42:25.311941 | controller |     Found yaml files to parse: ['/tmp/included_dir/somefile.yml']
2026-06-10 08:42:25.311950 | controller |
2026-06-10 08:42:25.311958 | controller | TASK [cifmw_helpers : Create files on localhost and use include_vars] **********
2026-06-10 08:42:25.311967 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.035)       0:00:06.870 ********
2026-06-10 08:42:25.348861 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_helpers/tasks/include_file.yml for instance => (item=(censored due to no_log))
2026-06-10 08:42:25.348894 | controller |
2026-06-10 08:42:25.349001 | controller | TASK [cifmw_helpers : Fail if file is not yaml or yml extension] ***************
2026-06-10 08:42:25.349014 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.037)       0:00:06.908 ********
2026-06-10 08:42:25.383208 | controller | skipping: [instance]
2026-06-10 08:42:25.383220 | controller |
2026-06-10 08:42:25.383225 | controller | TASK [cifmw_helpers : Check if file is available] ******************************
2026-06-10 08:42:25.383234 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.034)       0:00:06.942 ********
2026-06-10 08:42:25.639838 | controller | ok: [instance]
2026-06-10 08:42:25.639874 | controller |
2026-06-10 08:42:25.639880 | controller | TASK [cifmw_helpers : Create temporary directory] ******************************
2026-06-10 08:42:25.639964 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.255)       0:00:07.198 ********
2026-06-10 08:42:25.826572 | controller | changed: [instance -> localhost]
2026-06-10 08:42:25.826599 | controller |
2026-06-10 08:42:25.826604 | controller | TASK [cifmw_helpers : Read vars] ***********************************************
2026-06-10 08:42:25.826608 | controller | Wednesday 10 June 2026  08:42:25 +0000 (0:00:00.187)       0:00:07.385 ********
2026-06-10 08:42:26.031444 | controller | ok: [instance]
2026-06-10 08:42:26.031471 | controller |
2026-06-10 08:42:26.031475 | controller | TASK [cifmw_helpers : Create new variable files with content] ******************
2026-06-10 08:42:26.031480 | controller | Wednesday 10 June 2026  08:42:26 +0000 (0:00:00.204)       0:00:07.590 ********
2026-06-10 08:42:26.472634 | controller | changed: [instance -> localhost]
2026-06-10 08:42:26.472688 | controller |
2026-06-10 08:42:26.472702 | controller | TASK [cifmw_helpers : Include vars] ********************************************
2026-06-10 08:42:26.472746 | controller | Wednesday 10 June 2026  08:42:26 +0000 (0:00:00.439)       0:00:08.030 ********
2026-06-10 08:42:26.527902 | controller | ok: [instance -> localhost]
2026-06-10 08:42:26.527942 | controller |
2026-06-10 08:42:26.528233 | controller | TASK [cifmw_helpers : Remove temporary directory] ******************************
2026-06-10 08:42:26.528278 | controller | Wednesday 10 June 2026  08:42:26 +0000 (0:00:00.055)       0:00:08.086 ********
2026-06-10 08:42:26.786956 | controller | changed: [instance -> localhost]
2026-06-10 08:42:26.786999 | controller |
2026-06-10 08:42:26.787441 | controller | TASK [Check if all files were parsed] ******************************************
2026-06-10 08:42:26.787481 | controller | Wednesday 10 June 2026  08:42:26 +0000 (0:00:00.258)       0:00:08.344 ********
2026-06-10 08:42:26.860992 | controller | ok: [instance] => changed=false
2026-06-10 08:42:26.861050 | controller |   msg: All assertions passed
2026-06-10 08:42:26.861876 | controller |
2026-06-10 08:42:26.861927 | controller | PLAY RECAP *********************************************************************
2026-06-10 08:42:26.861935 | controller | instance                   : ok=42   changed=6    unreachable=0    failed=0    skipped=6    rescued=0    ignored=0
2026-06-10 08:42:26.861941 | controller |
2026-06-10 08:42:26.866489 | controller | Wednesday 10 June 2026  08:42:26 +0000 (0:00:00.073)       0:00:08.418 ********
2026-06-10 08:42:26.866530 | controller | ===============================================================================
2026-06-10 08:42:26.866548 | controller | Gathering Facts --------------------------------------------------------- 0.84s
2026-06-10 08:42:26.866559 | controller | cifmw_helpers : Create new variable files with content ------------------ 0.55s
2026-06-10 08:42:26.866570 | controller | cifmw_helpers : Create new variable files with content ------------------ 0.44s
2026-06-10 08:42:26.866581 | controller | cifmw_helpers : Read vars ----------------------------------------------- 0.40s
2026-06-10 08:42:26.866591 | controller | cifmw_helpers : Remove temporary directory ------------------------------ 0.39s
2026-06-10 08:42:26.866601 | controller | cifmw_helpers : Check if file is available ------------------------------ 0.34s
2026-06-10 08:42:26.866608 | controller | cifmw_helpers : Read the vars ------------------------------------------- 0.33s
2026-06-10 08:42:26.866616 | controller | cifmw_helpers : Check if file is available ------------------------------ 0.32s
2026-06-10 08:42:26.866625 | controller | cifmw_helpers : Create temporary directory ------------------------------ 0.32s
2026-06-10 08:42:26.866636 | controller | Check if symlink was done ----------------------------------------------- 0.32s
2026-06-10 08:42:26.866647 | controller | cifmw_helpers : Find yaml files ----------------------------------------- 0.30s
2026-06-10 08:42:26.866657 | controller | cifmw_helpers : Remove temporary directory ------------------------------ 0.26s
2026-06-10 08:42:26.866668 | controller | cifmw_helpers : Check if file is available ------------------------------ 0.26s
2026-06-10 08:42:26.866679 | controller | cifmw_helpers : Check directory is available ---------------------------- 0.24s
2026-06-10 08:42:26.866690 | controller | cifmw_helpers : Read vars ----------------------------------------------- 0.24s
2026-06-10 08:42:26.866700 | controller | cifmw_helpers : Check if the ci-framework exists ------------------------ 0.24s
2026-06-10 08:42:26.866710 | controller | cifmw_helpers : Check if cifmw general collection exists ---------------- 0.23s
2026-06-10 08:42:26.866760 | controller | cifmw_helpers : Find yaml files ----------------------------------------- 0.22s
2026-06-10 08:42:26.866773 | controller | cifmw_helpers : Check if file is available ------------------------------ 0.21s
2026-06-10 08:42:26.866783 | controller | cifmw_helpers : Read vars ----------------------------------------------- 0.20s
2026-06-10 08:42:26.966675 | controller | INFO     Running default > cleanup
2026-06-10 08:42:26.967978 | controller | WARNING  Skipping, cleanup playbook not configured.
2026-06-10 08:42:26.969161 | controller | INFO     Writing /tmp/report.html report.
2026-06-10 08:42:27.309498 | controller | ok: Runtime: 0:02:53.665701
2026-06-10 08:42:27.320476 | 
2026-06-10 08:42:27.320612 | PLAY RECAP
2026-06-10 08:42:27.320705 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-10 08:42:27.320751 | 
2026-06-10 08:42:27.474054 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-10 08:42:27.476767 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-10 08:42:28.184984 | 
2026-06-10 08:42:28.185297 | PLAY [Ensure ci-framework-data base directories exist on all nodes]
2026-06-10 08:42:28.197841 | 
2026-06-10 08:42:28.197980 | TASK [Create ci-framework-data/logs directory if missing]
2026-06-10 08:42:28.687382 | controller | ok
2026-06-10 08:42:28.717718 | 
2026-06-10 08:42:28.717866 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-06-10 08:42:28.724506 | 
2026-06-10 08:42:28.724659 | TASK [Filter out host if needed]
2026-06-10 08:42:28.735003 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-06-10 08:42:28.739116 | 
2026-06-10 08:42:28.739190 | TASK [Ensure file is present]
2026-06-10 08:42:29.176716 | controller | ok
2026-06-10 08:42:29.189177 | 
2026-06-10 08:42:29.189321 | TASK [Manage molecule report file]
2026-06-10 08:42:29.734157 | controller | ok: Runtime: 0:00:00.007416
2026-06-10 08:42:29.742825 | 
2026-06-10 08:42:29.742963 | TASK [Check if we get ci-framework-data basedir]
2026-06-10 08:42:30.020565 | controller | ok
2026-06-10 08:42:30.028962 | 
2026-06-10 08:42:30.029093 | TASK [Create ci-framework-data log directory for zuul]
2026-06-10 08:42:30.295830 | controller | changed
2026-06-10 08:42:30.304454 | 
2026-06-10 08:42:30.304641 | TASK [Copy ci-framework interesting files]
2026-06-10 08:42:30.615110 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-06-10 08:42:30.851917 | controller | ok: Runtime: 0:00:00.015959
2026-06-10 08:42:30.861321 | 
2026-06-10 08:42:30.861470 | TASK [Get SELinux listing]
2026-06-10 08:42:31.407329 | controller | ok: Runtime: 0:00:00.011904
2026-06-10 08:42:31.416117 | 
2026-06-10 08:42:31.416286 | TASK [Generate log index]
2026-06-10 08:42:33.289661 | controller | changed
2026-06-10 08:42:33.298188 | 
2026-06-10 08:42:33.298311 | TASK [Get some env related data]
2026-06-10 08:42:33.993831 | controller | /home/zuul/.local/bin/ansible
2026-06-10 08:42:34.929052 | controller | ok: Runtime: 0:00:00.969155
2026-06-10 08:42:34.979010 | 
2026-06-10 08:42:34.979164 | TASK [Generate list of logs to collect in home directory]
2026-06-10 08:42:35.660776 | controller | ok: All paths examined
2026-06-10 08:42:35.666496 | 
2026-06-10 08:42:35.666627 | LOOP [Copy logs from home directory]
2026-06-10 08:42:37.140336 | controller | changed:
2026-06-10 08:42:37.140660 | controller | {
2026-06-10 08:42:37.140726 | controller |   "atime": 1781080740.652955,
2026-06-10 08:42:37.140770 | controller |   "ctime": 1781080770.5447776,
2026-06-10 08:42:37.140807 | controller |   "dev": 64513,
2026-06-10 08:42:37.140847 | controller |   "gid": 1000,
2026-06-10 08:42:37.140882 | controller |   "gr_name": "zuul",
2026-06-10 08:42:37.140918 | controller |   "inode": 35287,
2026-06-10 08:42:37.140953 | controller |   "isblk": false,
2026-06-10 08:42:37.140987 | controller |   "ischr": false,
2026-06-10 08:42:37.141022 | controller |   "isdir": false,
2026-06-10 08:42:37.141057 | controller |   "isfifo": false,
2026-06-10 08:42:37.141090 | controller |   "isgid": false,
2026-06-10 08:42:37.141123 | controller |   "islnk": false,
2026-06-10 08:42:37.141156 | controller |   "isreg": true,
2026-06-10 08:42:37.141188 | controller |   "issock": false,
2026-06-10 08:42:37.141226 | controller |   "isuid": false,
2026-06-10 08:42:37.141271 | controller |   "mode": "0644",
2026-06-10 08:42:37.141305 | controller |   "mtime": 1781080770.5447776,
2026-06-10 08:42:37.141340 | controller |   "nlink": 1,
2026-06-10 08:42:37.141373 | controller |   "path": "/home/zuul/ansible.log",
2026-06-10 08:42:37.141405 | controller |   "pw_name": "zuul",
2026-06-10 08:42:37.141438 | controller |   "rgrp": true,
2026-06-10 08:42:37.141470 | controller |   "roth": true,
2026-06-10 08:42:37.141508 | controller |   "rusr": true,
2026-06-10 08:42:37.141605 | controller |   "size": 6749,
2026-06-10 08:42:37.141647 | controller |   "uid": 1000,
2026-06-10 08:42:37.141682 | controller |   "wgrp": false,
2026-06-10 08:42:37.141716 | controller |   "woth": false,
2026-06-10 08:42:37.141750 | controller |   "wusr": true,
2026-06-10 08:42:37.141782 | controller |   "xgrp": false,
2026-06-10 08:42:37.141817 | controller |   "xoth": false,
2026-06-10 08:42:37.141850 | controller |   "xusr": false
2026-06-10 08:42:37.141885 | controller | }
2026-06-10 08:42:37.156749 | 
2026-06-10 08:42:37.156885 | TASK [Copy crio stats log file]
2026-06-10 08:42:37.174795 | controller | skipping: Conditional result was False
2026-06-10 08:42:37.183249 | 
2026-06-10 08:42:37.183380 | TASK [Get SELinux related data]
2026-06-10 08:42:37.476276 | controller | <no matches>
2026-06-10 08:42:37.728318 | controller | ERROR
2026-06-10 08:42:37.728629 | controller | {
2026-06-10 08:42:37.728700 | controller |   "delta": "0:00:00.012286",
2026-06-10 08:42:37.728746 | controller |   "end": "2026-06-10 08:42:37.477638",
2026-06-10 08:42:37.728788 | controller |   "msg": "non-zero return code",
2026-06-10 08:42:37.728827 | controller |   "rc": 1,
2026-06-10 08:42:37.728867 | controller |   "start": "2026-06-10 08:42:37.465352"
2026-06-10 08:42:37.728905 | controller | }
2026-06-10 08:42:37.728955 | controller | ERROR: Ignoring Errors
2026-06-10 08:42:37.737159 | 
2026-06-10 08:42:37.737286 | TASK [Create system configuration directory]
2026-06-10 08:42:37.975129 | controller | changed
2026-06-10 08:42:37.983170 | 
2026-06-10 08:42:37.983315 | TASK [Get some of the system configurations]
2026-06-10 08:42:38.533477 | controller | ok: Runtime: 0:00:00.015976
2026-06-10 08:42:38.541322 | 
2026-06-10 08:42:38.541448 | TASK [Copy generated documentation if available]
2026-06-10 08:42:38.567875 | controller | skipping: Conditional result was False
2026-06-10 08:42:38.576259 | 
2026-06-10 08:42:38.576391 | TASK [Copy generated AsciiDoc documentation if available]
2026-06-10 08:42:38.611538 | controller | skipping: Conditional result was False
2026-06-10 08:42:38.619934 | 
2026-06-10 08:42:38.620059 | TASK [Compress logs bigger than 2MB]
2026-06-10 08:42:39.164653 | controller | ok: Runtime: 0:00:00.005705
2026-06-10 08:42:39.170654 | 
2026-06-10 08:42:39.170740 | TASK [Copy files from workspace on node]
2026-06-10 08:42:39.203344 | controller | ok
2026-06-10 08:42:39.236052 | 
2026-06-10 08:42:39.236226 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-10 08:42:39.272082 | controller | skipping: Conditional result was False
2026-06-10 08:42:39.279093 | 
2026-06-10 08:42:39.279235 | TASK [fetch-output : Set log path for single node]
2026-06-10 08:42:39.321882 | controller | ok
2026-06-10 08:42:39.328381 | 
2026-06-10 08:42:39.328652 | LOOP [fetch-output : Ensure local output dirs]
2026-06-10 08:42:39.629429 | controller -> localhost | changed: "/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/logs"
2026-06-10 08:42:39.630265 | controller -> localhost | changed: All items complete
2026-06-10 08:42:39.630397 | 
2026-06-10 08:42:39.871038 | controller -> localhost | changed: "/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/artifacts"
2026-06-10 08:42:40.111783 | controller -> localhost | changed: "/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/docs"
2026-06-10 08:42:40.123135 | 
2026-06-10 08:42:40.123260 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-10 08:42:40.894687 | controller | changed:
2026-06-10 08:42:40.894976 | controller | .d..t...... ./
2026-06-10 08:42:40.895089 | controller | >f+++++++++ README.html
2026-06-10 08:42:40.895144 | controller | >f+++++++++ ansible-execution.log
2026-06-10 08:42:40.895181 | controller | >f+++++++++ ansible.log
2026-06-10 08:42:40.895220 | controller | >f+++++++++ dmesg.log
2026-06-10 08:42:40.895255 | controller | >f+++++++++ installed-pkgs.log
2026-06-10 08:42:40.895289 | controller | >f+++++++++ python.log
2026-06-10 08:42:40.895323 | controller | >f+++++++++ registries.conf
2026-06-10 08:42:40.895356 | controller | >f+++++++++ report.html
2026-06-10 08:42:40.895389 | controller | >f+++++++++ selinux-denials.log
2026-06-10 08:42:40.895422 | controller | >f+++++++++ selinux-listing.log
2026-06-10 08:42:40.895454 | controller | cd+++++++++ ci-framework-data/
2026-06-10 08:42:40.895485 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-06-10 08:42:40.895543 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-06-10 08:42:40.895586 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2026-06-10 08:42:40.895622 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2026-06-10 08:42:40.895654 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2026-06-10 08:42:40.895686 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-06-10 08:42:40.895719 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-06-10 08:42:40.895751 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2026-06-10 08:42:40.895783 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2026-06-10 08:42:40.895816 | controller | cd+++++++++ ci-framework-data/logs/
2026-06-10 08:42:40.895849 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-06-10 08:42:40.895881 | controller | cd+++++++++ registries.conf.d/
2026-06-10 08:42:40.895915 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-06-10 08:42:40.895948 | controller | cd+++++++++ system-config/
2026-06-10 08:42:40.895980 | controller | cd+++++++++ system-config/libvirt/
2026-06-10 08:42:40.896013 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-06-10 08:42:40.896045 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-06-10 08:42:41.460049 | controller | changed: .d..t...... ./
2026-06-10 08:42:42.013418 | controller | changed: .d..t...... ./
2026-06-10 08:42:42.050780 | 
2026-06-10 08:42:42.051016 | TASK [Return artifact to Zuul]
2026-06-10 08:42:42.097057 | controller | ok
2026-06-10 08:42:42.100357 | 
2026-06-10 08:42:42.100459 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-06-10 08:42:42.100683 | 
2026-06-10 08:42:42.100745 | PLAY RECAP
2026-06-10 08:42:42.100819 | controller | ok: 19 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-06-10 08:42:42.100860 | 
2026-06-10 08:42:42.244954 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-10 08:42:42.247445 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-10 08:42:42.860740 | 
2026-06-10 08:42:42.860882 | PLAY [all]
2026-06-10 08:42:42.871356 | 
2026-06-10 08:42:42.871462 | TASK [include_role : fetch-output]
2026-06-10 08:42:42.921115 | controller | ok
2026-06-10 08:42:42.942044 | 
2026-06-10 08:42:42.942194 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-10 08:42:43.018404 | controller | skipping: Conditional result was False
2026-06-10 08:42:43.024973 | 
2026-06-10 08:42:43.025090 | TASK [fetch-output : Set log path for single node]
2026-06-10 08:42:43.079228 | controller | ok
2026-06-10 08:42:43.087687 | 
2026-06-10 08:42:43.087858 | LOOP [fetch-output : Ensure local output dirs]
2026-06-10 08:42:43.512882 | controller -> localhost | ok: "/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/logs"
2026-06-10 08:42:43.785896 | controller -> localhost | ok: "/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/artifacts"
2026-06-10 08:42:44.051990 | controller -> localhost | ok: "/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/docs"
2026-06-10 08:42:44.070468 | 
2026-06-10 08:42:44.070721 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-10 08:42:44.811849 | controller | ok
2026-06-10 08:42:44.812225 | controller | ok: All items complete
2026-06-10 08:42:44.812291 | 
2026-06-10 08:42:45.393852 | controller | ok
2026-06-10 08:42:45.971775 | controller | ok
2026-06-10 08:42:45.998583 | 
2026-06-10 08:42:45.998732 | TASK [include_role : fetch-output-openshift]
2026-06-10 08:42:46.028865 | controller | skipping: Conditional result was False
2026-06-10 08:42:46.039948 | 
2026-06-10 08:42:46.040094 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-10 08:42:46.599754 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013401
2026-06-10 08:42:46.862340 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012857
2026-06-10 08:42:46.872776 | 
2026-06-10 08:42:46.872878 | PLAY [all]
2026-06-10 08:42:46.879198 | 
2026-06-10 08:42:46.879283 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-10 08:42:47.400086 | controller | changed
2026-06-10 08:42:47.409579 | 
2026-06-10 08:42:47.409680 | PLAY RECAP
2026-06-10 08:42:47.409761 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-06-10 08:42:47.409805 | 
2026-06-10 08:42:47.570040 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-10 08:42:47.572282 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-06-10 08:42:48.254715 | 
2026-06-10 08:42:48.254897 | PLAY [localhost]
2026-06-10 08:42:48.270970 | 
2026-06-10 08:42:48.271114 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-10 08:42:48.761629 | localhost | changed
2026-06-10 08:42:48.776640 | 
2026-06-10 08:42:48.776920 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-10 08:42:48.806693 | localhost | ok
2026-06-10 08:42:48.815581 | 
2026-06-10 08:42:48.815704 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-10 08:42:49.250965 | localhost | changed
2026-06-10 08:42:49.257785 | 
2026-06-10 08:42:49.257900 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-10 08:42:50.099617 | localhost | changed
2026-06-10 08:42:50.108374 | 
2026-06-10 08:42:50.108503 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-10 08:42:50.643791 | localhost | Identity added: /var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/tmp/ansible.ub9eq46t (/var/lib/zuul/builds/a07e9f03a65d43828566f341986db5c1/work/tmp/ansible.ub9eq46t)
2026-06-10 08:42:50.644102 | localhost | ok: Runtime: 0:00:00.020196
2026-06-10 08:42:50.651264 | 
2026-06-10 08:42:50.651399 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-10 08:42:50.949250 | localhost | ok: Runtime: 0:00:00.007038
2026-06-10 08:42:50.954457 | 
2026-06-10 08:42:50.954577 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-10 08:42:51.026716 | localhost | changed
2026-06-10 08:42:51.036100 | 
2026-06-10 08:42:51.036234 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-10 08:42:51.495006 | localhost | changed
2026-06-10 08:42:51.506451 | 
2026-06-10 08:42:51.506611 | PLAY [localhost]
2026-06-10 08:42:51.515237 | 
2026-06-10 08:42:51.515359 | TASK [Generate bulk log download script]
2026-06-10 08:42:51.538464 | localhost | ok
2026-06-10 08:42:51.561471 | 
2026-06-10 08:42:51.561606 | TASK [local-log-download : Check API endpoint is defined]
2026-06-10 08:42:51.606307 | localhost | ok: All assertions passed
2026-06-10 08:42:51.614092 | 
2026-06-10 08:42:51.614374 | TASK [local-log-download : Create download script]
2026-06-10 08:42:52.098254 | localhost -> localhost | changed
2026-06-10 08:42:52.157725 | 
2026-06-10 08:42:52.157886 | TASK [Register quick-download link]
2026-06-10 08:42:52.187245 | localhost | ok
2026-06-10 08:42:52.189919 | 
2026-06-10 08:42:52.189986 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-10 08:42:52.196370 | 
2026-06-10 08:42:52.196451 | TASK [Set zuul-log-path fact]
2026-06-10 08:42:52.213876 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-10 08:42:52.222052 | 
2026-06-10 08:42:52.222145 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-10 08:42:52.259430 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-10 08:42:52.262736 | 
2026-06-10 08:42:52.262821 | TASK [upload-logs : Create log directories]
2026-06-10 08:42:53.172943 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-10 08:42:53.176471 | 
2026-06-10 08:42:53.176647 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-10 08:42:53.487237 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.009271
2026-06-10 08:42:53.491668 | 
2026-06-10 08:42:53.491755 | TASK [upload-logs : Upload logs to log server]
2026-06-10 08:42:55.661769 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given
2026-06-10 08:42:55.664817 | 
2026-06-10 08:42:55.664943 | LOOP [upload-logs : Compress console log and json output]
