2025-12-05 15:36:37.024101 | Job console starting...
2025-12-05 15:36:37.232679 | Updating repositories
2025-12-05 15:36:38.046126 | Preparing job workspace
2025-12-05 15:36:49.775073 | Running Ansible setup...
2025-12-05 15:36:53.541881 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-05 15:36:54.248273 | 
2025-12-05 15:36:54.248392 | PLAY [localhost]
2025-12-05 15:36:54.264569 | 
2025-12-05 15:36:54.264642 | TASK [Gathering Facts]
2025-12-05 15:36:56.373018 | localhost | ok
2025-12-05 15:36:56.385563 | 
2025-12-05 15:36:56.385668 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-12-05 15:36:56.785232 | localhost -> localhost | changed
2025-12-05 15:36:56.790471 | 
2025-12-05 15:36:56.790554 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-12-05 15:36:57.666166 | localhost -> localhost | changed
2025-12-05 15:36:57.674314 | 
2025-12-05 15:36:57.674391 | TASK [Setup log path fact]
2025-12-05 15:36:57.691543 | localhost | ok
2025-12-05 15:36:57.705871 | 
2025-12-05 15:36:57.706012 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-05 15:36:57.733023 | localhost | ok
2025-12-05 15:36:57.740648 | 
2025-12-05 15:36:57.740731 | TASK [emit-job-header : Print job information]
2025-12-05 15:36:57.768271 | # Job Information
2025-12-05 15:36:57.768395 | Ansible Version: 2.15.12
2025-12-05 15:36:57.768426 | Job: cifmw-molecule-ci_network
2025-12-05 15:36:57.768449 | Pipeline: github-check
2025-12-05 15:36:57.768470 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-12-05 15:36:57.768490 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3539
2025-12-05 15:36:57.768509 | Log URL (when completed): https://logserver.rdoproject.org/2cd/rdoproject.org/2cd194c3aba94b079b0014aa79f99f55/
2025-12-05 15:36:57.768528 | Event ID: 757b9e30-d1ef-11f0-97eb-f505e6ea5a00
2025-12-05 15:36:57.772022 | 
2025-12-05 15:36:57.772089 | LOOP [emit-job-header : Print node information]
2025-12-05 15:36:57.855765 | localhost | ok:
2025-12-05 15:36:57.855997 | localhost | # Node Information
2025-12-05 15:36:57.856030 | localhost | Inventory Hostname: controller
2025-12-05 15:36:57.856056 | localhost | Hostname: np0005547500
2025-12-05 15:36:57.856077 | localhost | Username: zuul
2025-12-05 15:36:57.856098 | localhost | Distro: CentOS 9
2025-12-05 15:36:57.856116 | localhost | Provider: ibm-bm4-nodepool
2025-12-05 15:36:57.856133 | localhost | Region: regionOne
2025-12-05 15:36:57.856149 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-12-05 15:36:57.856165 | localhost | Product Name: OpenStack Compute
2025-12-05 15:36:57.856180 | localhost | Interface IP: 192.168.26.233
2025-12-05 15:36:57.884755 | 
2025-12-05 15:36:57.884877 | PLAY [all]
2025-12-05 15:36:57.891679 | 
2025-12-05 15:36:57.891745 | TASK [Gather network facts]
2025-12-05 15:36:58.245159 | controller | ok
2025-12-05 15:36:58.261729 | 
2025-12-05 15:36:58.261840 | TASK [include_role : start-zuul-console]
2025-12-05 15:36:58.279234 | controller | ok
2025-12-05 15:36:58.290590 | 
2025-12-05 15:36:58.290673 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-12-05 15:36:58.605959 | controller | ok
2025-12-05 15:36:58.616351 | 
2025-12-05 15:36:58.616433 | TASK [include_role : add-build-sshkey]
2025-12-05 15:36:58.635272 | controller | ok
2025-12-05 15:36:58.648596 | 
2025-12-05 15:36:58.648678 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-05 15:36:58.856454 | controller -> localhost | ok
2025-12-05 15:36:58.862077 | 
2025-12-05 15:36:58.862205 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-05 15:36:58.890522 | controller | ok
2025-12-05 15:36:58.903553 | controller | included: /var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-05 15:36:58.909162 | 
2025-12-05 15:36:58.909228 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-05 15:36:59.401071 | controller -> localhost | Generating public/private rsa key pair.
2025-12-05 15:36:59.401236 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/2cd194c3aba94b079b0014aa79f99f55_id_rsa.
2025-12-05 15:36:59.401272 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/2cd194c3aba94b079b0014aa79f99f55_id_rsa.pub.
2025-12-05 15:36:59.401297 | controller -> localhost | The key fingerprint is:
2025-12-05 15:36:59.401318 | controller -> localhost | SHA256:3nemJ79CVgzWVMLDXx13nDR/89beeOXyU1w0UDuGfKo zuul-build-sshkey
2025-12-05 15:36:59.401338 | controller -> localhost | The key's randomart image is:
2025-12-05 15:36:59.401356 | controller -> localhost | +---[RSA 3072]----+
2025-12-05 15:36:59.401374 | controller -> localhost | |             **BB|
2025-12-05 15:36:59.401394 | controller -> localhost | |            + *+@|
2025-12-05 15:36:59.401412 | controller -> localhost | |           . = X=|
2025-12-05 15:36:59.401431 | controller -> localhost | |              * O|
2025-12-05 15:36:59.401449 | controller -> localhost | |        S    o .*|
2025-12-05 15:36:59.401467 | controller -> localhost | |       . .  +  ==|
2025-12-05 15:36:59.401485 | controller -> localhost | |        . .E. = *|
2025-12-05 15:36:59.401503 | controller -> localhost | |           .o+.= |
2025-12-05 15:36:59.401521 | controller -> localhost | |            .=o.o|
2025-12-05 15:36:59.401539 | controller -> localhost | +----[SHA256]-----+
2025-12-05 15:36:59.401581 | controller -> localhost | ok: Runtime: 0:00:00.124874
2025-12-05 15:36:59.407043 | 
2025-12-05 15:36:59.407108 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-05 15:36:59.425637 | controller | ok
2025-12-05 15:36:59.434690 | controller | included: /var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-05 15:36:59.442369 | 
2025-12-05 15:36:59.442436 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-05 15:36:59.455767 | controller | skipping: Conditional result was False
2025-12-05 15:36:59.461555 | 
2025-12-05 15:36:59.461628 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-05 15:36:59.816168 | controller | changed
2025-12-05 15:36:59.821177 | 
2025-12-05 15:36:59.821248 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-05 15:37:00.011140 | controller | ok
2025-12-05 15:37:00.015967 | 
2025-12-05 15:37:00.016034 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-05 15:37:00.562756 | controller | changed
2025-12-05 15:37:00.568373 | 
2025-12-05 15:37:00.568453 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-05 15:37:01.107321 | controller | changed
2025-12-05 15:37:01.114455 | 
2025-12-05 15:37:01.114527 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-05 15:37:01.139504 | controller | skipping: Conditional result was False
2025-12-05 15:37:01.145341 | 
2025-12-05 15:37:01.145410 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-05 15:37:01.468556 | controller -> localhost | changed
2025-12-05 15:37:01.478788 | 
2025-12-05 15:37:01.478887 | TASK [add-build-sshkey : Add back temp key]
2025-12-05 15:37:01.726767 | controller -> localhost | Identity added: /var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/2cd194c3aba94b079b0014aa79f99f55_id_rsa (zuul-build-sshkey)
2025-12-05 15:37:01.726980 | controller -> localhost | ok: Runtime: 0:00:00.015917
2025-12-05 15:37:01.732786 | 
2025-12-05 15:37:01.732852 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-05 15:37:02.016443 | controller | ok
2025-12-05 15:37:02.020712 | 
2025-12-05 15:37:02.020775 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-05 15:37:02.044638 | controller | skipping: Conditional result was False
2025-12-05 15:37:02.053361 | 
2025-12-05 15:37:02.053433 | TASK [include_role : validate-host]
2025-12-05 15:37:02.070273 | controller | ok
2025-12-05 15:37:02.087965 | 
2025-12-05 15:37:02.088037 | TASK [validate-host : Define zuul_info_dir fact]
2025-12-05 15:37:02.114969 | controller | ok
2025-12-05 15:37:02.119346 | 
2025-12-05 15:37:02.119412 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-12-05 15:37:02.320561 | controller -> localhost | ok
2025-12-05 15:37:02.326221 | 
2025-12-05 15:37:02.326291 | TASK [validate-host : Collect information about the host]
2025-12-05 15:37:02.964785 | controller | ok
2025-12-05 15:37:02.973371 | 
2025-12-05 15:37:02.973486 | TASK [validate-host : Sanitize hostname]
2025-12-05 15:37:03.012357 | controller | ok
2025-12-05 15:37:03.016868 | 
2025-12-05 15:37:03.016965 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-12-05 15:37:03.397307 | controller -> localhost | changed
2025-12-05 15:37:03.402701 | 
2025-12-05 15:37:03.402780 | TASK [validate-host : Collect information about zuul worker]
2025-12-05 15:37:03.704516 | controller | ok
2025-12-05 15:37:03.709679 | 
2025-12-05 15:37:03.709756 | TASK [validate-host : Write out all zuul information for each host]
2025-12-05 15:37:04.078106 | controller -> localhost | changed
2025-12-05 15:37:04.087180 | 
2025-12-05 15:37:04.087248 | TASK [include_role : prepare-workspace-openshift]
2025-12-05 15:37:04.100580 | controller | skipping: Conditional result was False
2025-12-05 15:37:04.105855 | 
2025-12-05 15:37:04.105944 | TASK [include_role : remove-zuul-sshkey]
2025-12-05 15:37:04.119769 | controller | skipping: Conditional result was False
2025-12-05 15:37:04.124839 | 
2025-12-05 15:37:04.124936 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-12-05 15:37:04.323597 | controller | ok: "logs"
2025-12-05 15:37:04.323821 | controller | ok: All items complete
2025-12-05 15:37:04.323851 | 
2025-12-05 15:37:04.503681 | controller | ok: "artifacts"
2025-12-05 15:37:04.671062 | controller | ok: "docs"
2025-12-05 15:37:04.679756 | 
2025-12-05 15:37:04.679827 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-12-05 15:37:04.886408 | controller | changed: "logs"
2025-12-05 15:37:05.072951 | controller | changed: "artifacts"
2025-12-05 15:37:05.255454 | controller | changed: "docs"
2025-12-05 15:37:05.279431 | 
2025-12-05 15:37:05.279527 | PLAY RECAP
2025-12-05 15:37:05.279574 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-05 15:37:05.279604 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-05 15:37:05.279624 | 
2025-12-05 15:37:05.417591 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-05 15:37:05.419231 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-05 15:37:05.975234 | 
2025-12-05 15:37:05.975340 | PLAY [all]
2025-12-05 15:37:05.993993 | 
2025-12-05 15:37:05.994069 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-05 15:37:06.042327 | controller | ok
2025-12-05 15:37:06.047069 | 
2025-12-05 15:37:06.047147 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-05 15:37:06.400020 | controller | changed
2025-12-05 15:37:06.405594 | 
2025-12-05 15:37:06.405676 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-05 15:37:07.274657 | controller | changed
2025-12-05 15:37:07.283771 | 
2025-12-05 15:37:07.283843 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-12-05 15:37:07.641336 | controller | changed:
2025-12-05 15:37:07.641534 | controller | {
2025-12-05 15:37:07.641565 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-12-05 15:37:07.641596 | controller | }
2025-12-05 15:37:07.850996 | controller | changed:
2025-12-05 15:37:07.851162 | controller | {
2025-12-05 15:37:07.851204 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-12-05 15:37:07.851230 | controller | }
2025-12-05 15:37:08.088607 | controller | changed:
2025-12-05 15:37:08.088681 | controller | {
2025-12-05 15:37:08.088708 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-12-05 15:37:08.088729 | controller | }
2025-12-05 15:37:08.300535 | controller | changed:
2025-12-05 15:37:08.300615 | controller | {
2025-12-05 15:37:08.300643 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-12-05 15:37:08.300665 | controller | }
2025-12-05 15:37:08.520313 | controller | changed:
2025-12-05 15:37:08.520401 | controller | {
2025-12-05 15:37:08.520428 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-12-05 15:37:08.520450 | controller | }
2025-12-05 15:37:08.731123 | controller | changed:
2025-12-05 15:37:08.731273 | controller | {
2025-12-05 15:37:08.731307 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-12-05 15:37:08.731329 | controller | }
2025-12-05 15:37:08.938374 | controller | changed:
2025-12-05 15:37:08.938449 | controller | {
2025-12-05 15:37:08.938476 | 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"
2025-12-05 15:37:08.938498 | controller | }
2025-12-05 15:37:09.146196 | controller | changed:
2025-12-05 15:37:09.146288 | controller | {
2025-12-05 15:37:09.146316 | 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"
2025-12-05 15:37:09.146336 | controller | }
2025-12-05 15:37:09.353371 | controller | changed:
2025-12-05 15:37:09.353469 | controller | {
2025-12-05 15:37:09.353496 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-12-05 15:37:09.353516 | controller | }
2025-12-05 15:37:09.560312 | controller | changed:
2025-12-05 15:37:09.560420 | controller | {
2025-12-05 15:37:09.560447 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-12-05 15:37:09.560469 | controller | }
2025-12-05 15:37:09.765635 | controller | changed:
2025-12-05 15:37:09.765719 | controller | {
2025-12-05 15:37:09.765747 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-12-05 15:37:09.765768 | controller | }
2025-12-05 15:37:09.991904 | controller | changed:
2025-12-05 15:37:09.992006 | controller | {
2025-12-05 15:37:09.992035 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-12-05 15:37:09.992056 | controller | }
2025-12-05 15:37:10.197562 | controller | changed:
2025-12-05 15:37:10.197652 | controller | {
2025-12-05 15:37:10.197679 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-12-05 15:37:10.197699 | controller | }
2025-12-05 15:37:10.406582 | controller | changed:
2025-12-05 15:37:10.406656 | controller | {
2025-12-05 15:37:10.406685 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-12-05 15:37:10.406706 | controller | }
2025-12-05 15:37:10.611780 | controller | changed:
2025-12-05 15:37:10.611894 | controller | {
2025-12-05 15:37:10.612028 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-12-05 15:37:10.612059 | controller | }
2025-12-05 15:37:10.817975 | controller | changed:
2025-12-05 15:37:10.818052 | controller | {
2025-12-05 15:37:10.818078 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-12-05 15:37:10.818099 | controller | }
2025-12-05 15:37:11.028122 | controller | changed:
2025-12-05 15:37:11.028211 | controller | {
2025-12-05 15:37:11.028249 | 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"
2025-12-05 15:37:11.028278 | controller | }
2025-12-05 15:37:11.232156 | controller | changed:
2025-12-05 15:37:11.232283 | controller | {
2025-12-05 15:37:11.232314 | 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"
2025-12-05 15:37:11.232345 | controller | }
2025-12-05 15:37:11.435001 | controller | changed:
2025-12-05 15:37:11.435071 | controller | {
2025-12-05 15:37:11.435098 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-12-05 15:37:11.435119 | controller | }
2025-12-05 15:37:11.639309 | controller | changed:
2025-12-05 15:37:11.639440 | controller | {
2025-12-05 15:37:11.639473 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-12-05 15:37:11.639496 | controller | }
2025-12-05 15:37:11.841766 | controller | changed:
2025-12-05 15:37:11.841901 | controller | {
2025-12-05 15:37:11.841960 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-12-05 15:37:11.841984 | controller | }
2025-12-05 15:37:12.047246 | controller | changed:
2025-12-05 15:37:12.047333 | controller | {
2025-12-05 15:37:12.047363 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-12-05 15:37:12.047385 | controller | }
2025-12-05 15:37:12.263231 | controller | changed:
2025-12-05 15:37:12.263312 | controller | {
2025-12-05 15:37:12.263338 | 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"
2025-12-05 15:37:12.263359 | controller | }
2025-12-05 15:37:12.467663 | controller | changed:
2025-12-05 15:37:12.467745 | controller | {
2025-12-05 15:37:12.467772 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-12-05 15:37:12.467793 | controller | }
2025-12-05 15:37:12.691898 | controller | changed:
2025-12-05 15:37:12.692017 | controller | {
2025-12-05 15:37:12.692043 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-12-05 15:37:12.692065 | controller | }
2025-12-05 15:37:12.905969 | controller | changed:
2025-12-05 15:37:12.906106 | controller | {
2025-12-05 15:37:12.906137 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-12-05 15:37:12.906180 | controller | }
2025-12-05 15:37:12.922271 | 
2025-12-05 15:37:12.922339 | TASK [Set timezone to UTC]
2025-12-05 15:37:13.316537 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-12-05 15:37:13.322141 | 
2025-12-05 15:37:13.322207 | TASK [Create nodepool directory]
2025-12-05 15:37:13.532892 | controller | changed
2025-12-05 15:37:13.540891 | 
2025-12-05 15:37:13.541010 | TASK [Create nodepool sub_nodes file]
2025-12-05 15:37:14.087958 | controller | changed
2025-12-05 15:37:14.092959 | 
2025-12-05 15:37:14.093039 | TASK [Create nodepool sub_nodes_private file]
2025-12-05 15:37:14.613447 | controller | changed
2025-12-05 15:37:14.619860 | 
2025-12-05 15:37:14.619996 | LOOP [Populate nodepool sub_nodes file]
2025-12-05 15:37:14.649052 | 
2025-12-05 15:37:14.649178 | LOOP [Populate nodepool sub_nodes_private file]
2025-12-05 15:37:14.687515 | 
2025-12-05 15:37:14.687646 | TASK [Create nodepool primary file]
2025-12-05 15:37:14.710599 | controller | skipping: Conditional result was False
2025-12-05 15:37:14.715788 | 
2025-12-05 15:37:14.715861 | TASK [Create nodepool node_private for this node]
2025-12-05 15:37:15.270792 | controller | changed
2025-12-05 15:37:15.277364 | 
2025-12-05 15:37:15.277446 | LOOP [Copy ssh keys to nodepool directory]
2025-12-05 15:37:15.620614 | controller | ok: Item: id_rsa Runtime: 0:00:00.004787
2025-12-05 15:37:15.620775 | 
2025-12-05 15:37:15.781846 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004559
2025-12-05 15:37:15.791120 | 
2025-12-05 15:37:15.791193 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-12-05 15:37:16.316339 | controller | changed
2025-12-05 15:37:16.321853 | 
2025-12-05 15:37:16.321964 | TASK [Validate sudoers config after edits]
2025-12-05 15:37:16.539261 | controller | /etc/sudoers: parsed OK
2025-12-05 15:37:16.539330 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-12-05 15:37:16.539340 | controller | /etc/sudoers.d/zuul: parsed OK
2025-12-05 15:37:16.539346 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-12-05 15:37:16.846812 | controller | ok: Runtime: 0:00:00.004819
2025-12-05 15:37:16.852333 | 
2025-12-05 15:37:16.852408 | TASK [Show the environment passed in to job shell scripts]
2025-12-05 15:37:17.052871 | controller | SHELL=/bin/bash
2025-12-05 15:37:17.052907 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-12-05 15:37:17.052917 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-12-05 15:37:17.052924 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/39/3539/d69732b2a1625f2c30dfa731f6f764b0a55cbde9
2025-12-05 15:37:17.052930 | controller | PWD=/home/zuul
2025-12-05 15:37:17.052935 | controller | ZUUL_PIPELINE=github-check
2025-12-05 15:37:17.052941 | controller | LOGNAME=zuul
2025-12-05 15:37:17.052976 | controller | XDG_SESSION_TYPE=tty
2025-12-05 15:37:17.052983 | controller | _=/usr/bin/env
2025-12-05 15:37:17.052989 | controller | MOTD_SHOWN=pam
2025-12-05 15:37:17.052994 | controller | HOME=/home/zuul
2025-12-05 15:37:17.052999 | controller | LANG=en_US.UTF-8
2025-12-05 15:37:17.053005 | controller | SSH_CONNECTION=192.168.26.12 35016 192.168.26.233 22
2025-12-05 15:37:17.053022 | 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
2025-12-05 15:37:17.053044 | controller | ZUUL_CHANGE_IDS=3539,d69732b2a1625f2c30dfa731f6f764b0a55cbde9
2025-12-05 15:37:17.053051 | controller | WORKSPACE=/home/zuul/workspace
2025-12-05 15:37:17.053056 | controller | XDG_SESSION_CLASS=user
2025-12-05 15:37:17.053062 | controller | SELINUX_ROLE_REQUESTED=
2025-12-05 15:37:17.053067 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-12-05 15:37:17.053072 | controller | USER=zuul
2025-12-05 15:37:17.053077 | controller | ZUUL_VOTING=True
2025-12-05 15:37:17.053083 | controller | BUILD_TIMEOUT=1800000
2025-12-05 15:37:17.053088 | controller | SELINUX_USE_CURRENT_RANGE=
2025-12-05 15:37:17.053093 | controller | SHLVL=1
2025-12-05 15:37:17.053098 | controller | ZUUL_PATCHSET=d69732b2a1625f2c30dfa731f6f764b0a55cbde9
2025-12-05 15:37:17.053104 | controller | XDG_SESSION_ID=1
2025-12-05 15:37:17.053109 | controller | ZUUL_BRANCH=main
2025-12-05 15:37:17.053114 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-12-05 15:37:17.053120 | controller | SSH_CLIENT=192.168.26.12 35016 22
2025-12-05 15:37:17.053125 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-12-05 15:37:17.053130 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-12-05 15:37:17.053136 | controller | which_declare=declare -f
2025-12-05 15:37:17.053141 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-12-05 15:37:17.053146 | controller | SELINUX_LEVEL_REQUESTED=
2025-12-05 15:37:17.053152 | controller | ZUUL_CHANGE=3539
2025-12-05 15:37:17.053169 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-12-05 15:37:17.053175 | controller | ZUUL_UUID=2cd194c3aba94b079b0014aa79f99f55
2025-12-05 15:37:17.053180 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-12-05 15:37:17.053185 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-12-05 15:37:17.053191 | controller | }
2025-12-05 15:37:17.378875 | controller | ok: Runtime: 0:00:00.005095
2025-12-05 15:37:17.384218 | 
2025-12-05 15:37:17.384281 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-12-05 15:37:17.397501 | controller | skipping: Conditional result was False
2025-12-05 15:37:17.402539 | 
2025-12-05 15:37:17.402606 | TASK [Symlink /home/zuul-worker/workspace]
2025-12-05 15:37:17.927944 | controller | skipping: Conditional result was False
2025-12-05 15:37:17.933497 | 
2025-12-05 15:37:17.933564 | TASK [Ensure legacy workspace directory]
2025-12-05 15:37:18.134969 | controller | changed
2025-12-05 15:37:18.191433 | 
2025-12-05 15:37:18.191527 | PLAY RECAP
2025-12-05 15:37:18.191575 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-05 15:37:18.191600 | 
2025-12-05 15:37:18.282752 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-05 15:37:18.283551 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-05 15:37:18.821680 | 
2025-12-05 15:37:18.821781 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-12-05 15:37:18.842071 | 
2025-12-05 15:37:18.842145 | TASK [Create zuul-output directory]
2025-12-05 15:37:19.156758 | controller | changed
2025-12-05 15:37:19.161857 | 
2025-12-05 15:37:19.161970 | TASK [Slurp Zuul inventory test]
2025-12-05 15:37:19.451430 | controller -> localhost | ok
2025-12-05 15:37:19.458556 | 
2025-12-05 15:37:19.458639 | TASK [Save zuul inventory]
2025-12-05 15:37:20.234534 | controller | changed
2025-12-05 15:37:20.239614 | 
2025-12-05 15:37:20.239693 | TASK [Save zuul vars without the change_message]
2025-12-05 15:37:20.802736 | controller | changed
2025-12-05 15:37:20.821498 | 
2025-12-05 15:37:20.821566 | PLAY RECAP
2025-12-05 15:37:20.821611 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-05 15:37:20.821635 | 
2025-12-05 15:37:20.893585 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-05 15:37:20.894818 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-05 15:37:21.469192 | 
2025-12-05 15:37:21.469295 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-12-05 15:37:21.491177 | 
2025-12-05 15:37:21.491266 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-12-05 15:37:21.529983 | controller | ok
2025-12-05 15:37:21.548315 | 
2025-12-05 15:37:21.548423 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-05 15:37:21.572441 | controller | skipping: Conditional result was False
2025-12-05 15:37:21.578521 | 
2025-12-05 15:37:21.578607 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-05 15:37:21.910531 | controller | ok
2025-12-05 15:37:21.915981 | 
2025-12-05 15:37:21.916069 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-05 15:37:22.535693 | controller | ok
2025-12-05 15:37:22.545751 | 
2025-12-05 15:37:22.545835 | TASK [Prepare workspace]
2025-12-05 15:37:22.564142 | controller | ok
2025-12-05 15:37:22.580329 | 
2025-12-05 15:37:22.580402 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-12-05 15:37:22.871983 | controller | ok
2025-12-05 15:37:22.881359 | 
2025-12-05 15:37:22.881470 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-12-05 15:37:25.329939 | controller | Output suppressed because no_log was given
2025-12-05 15:37:25.342796 | 
2025-12-05 15:37:25.342900 | LOOP [Create zuul-output directory]
2025-12-05 15:37:25.536091 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-12-05 15:37:25.707096 | controller | ok: "/home/zuul/zuul-output/logs"
2025-12-05 15:37:25.722656 | 
2025-12-05 15:37:25.722718 | TASK [Install required packages]
2025-12-05 15:38:14.714029 | controller | changed
2025-12-05 15:38:14.722954 | 
2025-12-05 15:38:14.723049 | TASK [Install venv]
2025-12-05 15:38:43.060752 | controller | ERROR
2025-12-05 15:38:43.060982 | controller | {
2025-12-05 15:38:43.061023 | controller |   "msg": "gmake: *** [Makefile:60: setup_molecule] Error 1",
2025-12-05 15:38:43.061048 | controller |   "rc": 2
2025-12-05 15:38:43.061081 | controller | }
failure
2025-12-05 15:38:43.073460 | 
2025-12-05 15:38:43.073514 | PLAY RECAP
2025-12-05 15:38:43.073558 | controller | ok: 6 changed: 3 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0
2025-12-05 15:38:43.073582 | 
2025-12-05 15:38:43.269647 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-05 15:38:43.270542 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-05 15:38:44.712563 | 
2025-12-05 15:38:44.712654 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-12-05 15:38:44.750441 | 
2025-12-05 15:38:44.750532 | TASK [Filter out host if needed]
2025-12-05 15:38:44.760325 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-12-05 15:38:44.765336 | 
2025-12-05 15:38:44.765404 | TASK [Ensure file is present]
2025-12-05 15:38:45.163475 | controller | ok
2025-12-05 15:38:45.173644 | 
2025-12-05 15:38:45.173735 | TASK [Manage molecule report file]
2025-12-05 15:38:45.744639 | controller | skipping: Conditional result was False
2025-12-05 15:38:45.758698 | 
2025-12-05 15:38:45.758788 | TASK [Check if we get ci-framework-data basedir]
2025-12-05 15:38:45.994845 | controller | ok
2025-12-05 15:38:46.000022 | 
2025-12-05 15:38:46.000100 | TASK [Create ci-framework-data log directory for zuul]
2025-12-05 15:38:46.335897 | controller | changed
2025-12-05 15:38:46.341343 | 
2025-12-05 15:38:46.341419 | TASK [Copy ci-framework interesting files]
2025-12-05 15:38:46.691304 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-12-05 15:38:46.872793 | controller | changed
2025-12-05 15:38:46.878268 | 
2025-12-05 15:38:46.878347 | TASK [Get SELinux listing]
2025-12-05 15:38:47.408978 | controller | changed
2025-12-05 15:38:47.423622 | 
2025-12-05 15:38:47.423726 | TASK [Generate log index]
2025-12-05 15:38:48.115794 | controller | changed
2025-12-05 15:38:48.120808 | 
2025-12-05 15:38:48.120873 | TASK [Get some env related data]
2025-12-05 15:38:48.651599 | controller | /home/zuul/.local/bin/ansible
2025-12-05 15:38:49.646150 | controller | changed
2025-12-05 15:38:49.651780 | 
2025-12-05 15:38:49.651859 | TASK [Generate list of logs to collect in home directory]
2025-12-05 15:38:50.098771 | controller | ok: All paths examined
2025-12-05 15:38:50.104423 | 
2025-12-05 15:38:50.104500 | LOOP [Copy logs from home directory]
2025-12-05 15:38:50.147605 | 
2025-12-05 15:38:50.148766 | TASK [Copy crio stats log file]
2025-12-05 15:38:50.181926 | controller | skipping: Conditional result was False
2025-12-05 15:38:50.212820 | 
2025-12-05 15:38:50.212948 | TASK [Get SELinux related data]
2025-12-05 15:38:50.428641 | controller | <no matches>
2025-12-05 15:38:50.749604 | controller | ERROR
2025-12-05 15:38:50.749718 | controller | {
2025-12-05 15:38:50.749749 | controller |   "delta": "0:00:00.008041",
2025-12-05 15:38:50.749771 | controller |   "end": "2025-12-05 15:38:50.429511",
2025-12-05 15:38:50.749790 | controller |   "msg": "non-zero return code",
2025-12-05 15:38:50.749807 | controller |   "rc": 1,
2025-12-05 15:38:50.749826 | controller |   "start": "2025-12-05 15:38:50.421470"
2025-12-05 15:38:50.749843 | controller | }
2025-12-05 15:38:50.749867 | controller | ERROR: Ignoring Errors
2025-12-05 15:38:50.757299 | 
2025-12-05 15:38:50.757402 | TASK [Create system configuration directory]
2025-12-05 15:38:50.967221 | controller | changed
2025-12-05 15:38:50.999170 | 
2025-12-05 15:38:50.999262 | TASK [Get some of the system configurations]
2025-12-05 15:38:51.563511 | controller | changed
2025-12-05 15:38:51.569649 | 
2025-12-05 15:38:51.569717 | TASK [Copy generated documentation if available]
2025-12-05 15:38:51.583347 | controller | skipping: Conditional result was False
2025-12-05 15:38:51.589852 | 
2025-12-05 15:38:51.589932 | TASK [Copy generated AsciiDoc documentation if available]
2025-12-05 15:38:51.603372 | controller | skipping: Conditional result was False
2025-12-05 15:38:51.609593 | 
2025-12-05 15:38:51.609658 | TASK [Compress logs bigger than 2MB]
2025-12-05 15:38:52.133995 | controller | changed
2025-12-05 15:38:52.140018 | 
2025-12-05 15:38:52.140100 | TASK [Copy files from workspace on node]
2025-12-05 15:38:52.159883 | controller | ok
2025-12-05 15:38:52.195033 | 
2025-12-05 15:38:52.195123 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-05 15:38:52.214674 | controller | skipping: Conditional result was False
2025-12-05 15:38:52.220687 | 
2025-12-05 15:38:52.220755 | TASK [fetch-output : Set log path for single node]
2025-12-05 15:38:52.249311 | controller | ok
2025-12-05 15:38:52.254616 | 
2025-12-05 15:38:52.254686 | LOOP [fetch-output : Ensure local output dirs]
2025-12-05 15:38:52.498845 | controller -> localhost | ok: "/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/logs"
2025-12-05 15:38:52.499139 | 
2025-12-05 15:38:52.721736 | controller -> localhost | changed: "/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/artifacts"
2025-12-05 15:38:52.944660 | controller -> localhost | changed: "/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/docs"
2025-12-05 15:38:52.960962 | 
2025-12-05 15:38:52.961109 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-05 15:38:53.586616 | controller | changed:
2025-12-05 15:38:53.586781 | controller | .d..t...... ./
2025-12-05 15:38:53.586813 | controller | >f+++++++++ README.html
2025-12-05 15:38:53.586837 | controller | >f+++++++++ dmesg.log
2025-12-05 15:38:53.586861 | controller | >f+++++++++ installed-pkgs.log
2025-12-05 15:38:53.586881 | controller | >f+++++++++ python.log
2025-12-05 15:38:53.586900 | controller | >f+++++++++ registries.conf
2025-12-05 15:38:53.586944 | controller | >f+++++++++ selinux-denials.log
2025-12-05 15:38:53.586967 | controller | >f+++++++++ selinux-listing.log
2025-12-05 15:38:53.586987 | controller | cd+++++++++ ci-framework-data/
2025-12-05 15:38:53.587006 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-12-05 15:38:53.587024 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-12-05 15:38:53.587042 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-12-05 15:38:53.587060 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-12-05 15:38:53.587087 | controller | cd+++++++++ ci-framework-data/logs/
2025-12-05 15:38:53.587106 | controller | cd+++++++++ registries.conf.d/
2025-12-05 15:38:53.587123 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-12-05 15:38:53.587139 | controller | cd+++++++++ system-config/
2025-12-05 15:38:53.587155 | controller | cd+++++++++ system-config/libvirt/
2025-12-05 15:38:53.587171 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-12-05 15:38:53.587186 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-12-05 15:38:54.124708 | controller | changed: .d..t...... ./
2025-12-05 15:38:54.567501 | controller | changed: .d..t...... ./
2025-12-05 15:38:54.593638 | 
2025-12-05 15:38:54.593713 | TASK [Return artifact to Zuul]
2025-12-05 15:38:54.628588 | controller | skipping: Conditional result was False
2025-12-05 15:38:54.648677 | 
2025-12-05 15:38:54.648732 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-12-05 15:38:54.648826 | 
2025-12-05 15:38:54.648853 | PLAY RECAP
2025-12-05 15:38:54.648888 | controller | ok: 15 changed: 11 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 1
2025-12-05 15:38:54.648930 | 
2025-12-05 15:38:54.724418 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-05 15:38:54.725186 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-05 15:38:55.321650 | 
2025-12-05 15:38:55.321739 | PLAY [all]
2025-12-05 15:38:55.341669 | 
2025-12-05 15:38:55.341756 | TASK [include_role : fetch-output]
2025-12-05 15:38:55.391867 | controller | ok
2025-12-05 15:38:55.434153 | 
2025-12-05 15:38:55.434276 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-05 15:38:55.478326 | controller | skipping: Conditional result was False
2025-12-05 15:38:55.484530 | 
2025-12-05 15:38:55.484612 | TASK [fetch-output : Set log path for single node]
2025-12-05 15:38:55.524747 | controller | ok
2025-12-05 15:38:55.529627 | 
2025-12-05 15:38:55.529699 | LOOP [fetch-output : Ensure local output dirs]
2025-12-05 15:38:55.983249 | controller -> localhost | ok: "/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/logs"
2025-12-05 15:38:56.193179 | controller -> localhost | ok: "/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/artifacts"
2025-12-05 15:38:56.400781 | controller -> localhost | ok: "/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/docs"
2025-12-05 15:38:56.412655 | 
2025-12-05 15:38:56.412758 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-05 15:38:56.968570 | controller | ok
2025-12-05 15:38:56.968742 | controller | ok: All items complete
2025-12-05 15:38:56.968771 | 
2025-12-05 15:38:57.393400 | controller | ok
2025-12-05 15:38:57.856354 | controller | ok
2025-12-05 15:38:57.874726 | 
2025-12-05 15:38:57.875022 | TASK [include_role : fetch-output-openshift]
2025-12-05 15:38:57.915342 | controller | skipping: Conditional result was False
2025-12-05 15:38:57.922271 | 
2025-12-05 15:38:57.922370 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-12-05 15:38:58.521958 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006388
2025-12-05 15:38:58.741616 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007733
2025-12-05 15:38:58.781798 | 
2025-12-05 15:38:58.781877 | PLAY [all]
2025-12-05 15:38:58.798098 | 
2025-12-05 15:38:58.798197 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-12-05 15:38:59.246535 | controller | changed
2025-12-05 15:38:59.268456 | 
2025-12-05 15:38:59.268505 | PLAY RECAP
2025-12-05 15:38:59.268550 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-12-05 15:38:59.268573 | 
2025-12-05 15:38:59.383423 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-05 15:38:59.384176 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-12-05 15:39:00.042823 | 
2025-12-05 15:39:00.042924 | PLAY [localhost]
2025-12-05 15:39:00.060886 | 
2025-12-05 15:39:00.060979 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-12-05 15:39:00.387631 | localhost | changed
2025-12-05 15:39:00.392387 | 
2025-12-05 15:39:00.392469 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-12-05 15:39:00.419480 | localhost | ok
2025-12-05 15:39:00.427559 | 
2025-12-05 15:39:00.427630 | TASK [add-fileserver : Create SSH private key tempfile]
2025-12-05 15:39:00.728429 | localhost | changed
2025-12-05 15:39:00.734204 | 
2025-12-05 15:39:00.734277 | TASK [add-fileserver : Create SSH private key from secret]
2025-12-05 15:39:01.365410 | localhost | changed
2025-12-05 15:39:01.370610 | 
2025-12-05 15:39:01.370680 | TASK [add-fileserver : Add fileserver ssh key]
2025-12-05 15:39:01.725166 | localhost | Identity added: /var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/tmp/ansible.eum3qdrr (/var/lib/zuul/builds/2cd194c3aba94b079b0014aa79f99f55/work/tmp/ansible.eum3qdrr)
2025-12-05 15:39:01.725343 | localhost | ok: Runtime: 0:00:00.006736
2025-12-05 15:39:01.729599 | 
2025-12-05 15:39:01.729677 | TASK [add-fileserver : Remove SSH private key from disk]
2025-12-05 15:39:01.974458 | localhost | ok: Runtime: 0:00:00.004455
2025-12-05 15:39:01.991030 | 
2025-12-05 15:39:01.991129 | TASK [add-fileserver : Add fileserver to inventory]
2025-12-05 15:39:02.083902 | localhost | changed
2025-12-05 15:39:02.088236 | 
2025-12-05 15:39:02.088312 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-12-05 15:39:02.638985 | localhost | changed
2025-12-05 15:39:02.678260 | 
2025-12-05 15:39:02.678336 | PLAY [localhost]
2025-12-05 15:39:02.695755 | 
2025-12-05 15:39:02.695821 | TASK [Generate bulk log download script]
2025-12-05 15:39:02.720325 | localhost | ok
2025-12-05 15:39:02.736711 | 
2025-12-05 15:39:02.736784 | TASK [local-log-download : Check API endpoint is defined]
2025-12-05 15:39:02.800363 | localhost | ok: All assertions passed
2025-12-05 15:39:02.805077 | 
2025-12-05 15:39:02.805159 | TASK [local-log-download : Create download script]
2025-12-05 15:39:03.349855 | localhost -> localhost | changed
2025-12-05 15:39:03.358832 | 
2025-12-05 15:39:03.359038 | TASK [Register quick-download link]
2025-12-05 15:39:03.420371 | localhost | ok
2025-12-05 15:39:03.483678 | 
2025-12-05 15:39:03.483748 | PLAY [logserver.rdoproject.org]
2025-12-05 15:39:03.521512 | 
2025-12-05 15:39:03.521576 | TASK [Set zuul-log-path fact]
2025-12-05 15:39:03.558623 | logserver.rdoproject.org | ok
2025-12-05 15:39:03.571740 | 
2025-12-05 15:39:03.571808 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-05 15:39:03.621524 | logserver.rdoproject.org | ok
2025-12-05 15:39:03.627114 | 
2025-12-05 15:39:03.627187 | TASK [upload-logs : Create log directories]
2025-12-05 15:39:05.357832 | logserver.rdoproject.org | changed
2025-12-05 15:39:05.362536 | 
2025-12-05 15:39:05.362607 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-12-05 15:39:05.613232 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004780
2025-12-05 15:39:05.618174 | 
2025-12-05 15:39:05.618261 | TASK [upload-logs : Upload logs to log server]
2025-12-05 15:39:07.069946 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-12-05 15:39:07.073083 | 
2025-12-05 15:39:07.073164 | LOOP [upload-logs : Compress console log and json output]
2025-12-05 15:39:07.141370 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 15:39:07.142166 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 15:39:07.151152 | 
2025-12-05 15:39:07.151260 | LOOP [upload-logs : Upload compressed console log and json output]
2025-12-05 15:39:07.234178 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 15:39:07.234454 | 
2025-12-05 15:39:07.242069 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 15:39:07.250020 | 
2025-12-05 15:39:07.250145 | LOOP [upload-logs : Upload console log and json output]