2026-02-23 15:06:12.040309 | Job console starting... 2026-02-23 15:06:12.262249 | Updating repositories 2026-02-23 15:06:13.043285 | Preparing job workspace 2026-02-23 15:06:19.874179 | Running Ansible setup... 2026-02-23 15:06:22.633159 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-02-23 15:06:23.099059 | 2026-02-23 15:06:23.099158 | PLAY [localhost] 2026-02-23 15:06:23.106906 | 2026-02-23 15:06:23.106982 | TASK [Gathering Facts] 2026-02-23 15:06:23.871716 | localhost | ok 2026-02-23 15:06:23.883512 | 2026-02-23 15:06:23.883588 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-23 15:06:24.173620 | localhost -> localhost | changed 2026-02-23 15:06:24.178768 | 2026-02-23 15:06:24.178837 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-23 15:06:24.798052 | localhost -> localhost | changed 2026-02-23 15:06:24.805480 | 2026-02-23 15:06:24.805544 | TASK [Setup log path fact] 2026-02-23 15:06:24.822042 | localhost | ok 2026-02-23 15:06:24.831893 | 2026-02-23 15:06:24.831963 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 15:06:24.848458 | localhost | ok 2026-02-23 15:06:24.855030 | 2026-02-23 15:06:24.855091 | TASK [emit-job-header : Print job information] 2026-02-23 15:06:24.881449 | # Job Information 2026-02-23 15:06:24.881558 | Ansible Version: 2.15.12 2026-02-23 15:06:24.881586 | Job: cifmw-molecule-config_drive 2026-02-23 15:06:24.881607 | Pipeline: github-check 2026-02-23 15:06:24.881627 | Executor: ibm-bm4-ze.softwarefactory-project.io 2026-02-23 15:06:24.881645 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3683 2026-02-23 15:06:24.881663 | Log URL (when completed): https://logserver.rdoproject.org/02f/rdoproject.org/02fd759dc8bc4d9a8a433c8eb268fbc4/ 2026-02-23 15:06:24.881681 | Event ID: 0c6bfa70-10c9-11f1-9fe4-6fc01c9b6110 2026-02-23 15:06:24.885069 | 2026-02-23 15:06:24.885131 | LOOP [emit-job-header : Print node information] 2026-02-23 15:06:24.962944 | localhost | ok: 2026-02-23 15:06:24.963144 | localhost | # Node Information 2026-02-23 15:06:24.963173 | localhost | Inventory Hostname: controller 2026-02-23 15:06:24.963200 | localhost | Hostname: np0005626905 2026-02-23 15:06:24.963221 | localhost | Username: zuul 2026-02-23 15:06:24.963242 | localhost | Distro: CentOS 9 2026-02-23 15:06:24.963260 | localhost | Provider: ibm-bm4-nodepool 2026-02-23 15:06:24.963277 | localhost | Region: regionOne 2026-02-23 15:06:24.963326 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2026-02-23 15:06:24.963356 | localhost | Product Name: OpenStack Compute 2026-02-23 15:06:24.963376 | localhost | Interface IP: 192.168.26.19 2026-02-23 15:06:24.985397 | 2026-02-23 15:06:24.985470 | PLAY [all] 2026-02-23 15:06:24.991119 | 2026-02-23 15:06:24.991179 | TASK [Gather network facts] 2026-02-23 15:06:25.344236 | controller | ok 2026-02-23 15:06:25.357622 | 2026-02-23 15:06:25.357707 | TASK [include_role : start-zuul-console] 2026-02-23 15:06:25.375198 | controller | ok 2026-02-23 15:06:25.386083 | 2026-02-23 15:06:25.386143 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-23 15:06:25.688656 | controller | ok 2026-02-23 15:06:25.696894 | 2026-02-23 15:06:25.696969 | TASK [include_role : add-build-sshkey] 2026-02-23 15:06:25.714429 | controller | ok 2026-02-23 15:06:25.728351 | 2026-02-23 15:06:25.728472 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 15:06:25.903834 | controller -> localhost | ok 2026-02-23 15:06:25.908972 | 2026-02-23 15:06:25.909033 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 15:06:25.926198 | controller | ok 2026-02-23 15:06:25.938212 | controller | included: /var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 15:06:25.943189 | 2026-02-23 15:06:25.943246 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 15:06:26.350439 | controller -> localhost | Generating public/private rsa key pair. 2026-02-23 15:06:26.350616 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/02fd759dc8bc4d9a8a433c8eb268fbc4_id_rsa. 2026-02-23 15:06:26.350648 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/02fd759dc8bc4d9a8a433c8eb268fbc4_id_rsa.pub. 2026-02-23 15:06:26.350672 | controller -> localhost | The key fingerprint is: 2026-02-23 15:06:26.350692 | controller -> localhost | SHA256:Zs7TJpQiCtCCa1Zt5IySkxabo7e9oZa0EYeZHWAVJBw zuul-build-sshkey 2026-02-23 15:06:26.350711 | controller -> localhost | The key's randomart image is: 2026-02-23 15:06:26.350728 | controller -> localhost | +---[RSA 3072]----+ 2026-02-23 15:06:26.350753 | controller -> localhost | | oE=+o | 2026-02-23 15:06:26.350773 | controller -> localhost | |.oB.B | 2026-02-23 15:06:26.350790 | controller -> localhost | |+X.B * | 2026-02-23 15:06:26.350807 | controller -> localhost | |+oX + . | 2026-02-23 15:06:26.350824 | controller -> localhost | |+o.o. . S | 2026-02-23 15:06:26.350841 | controller -> localhost | |ooo+ . B . | 2026-02-23 15:06:26.350857 | controller -> localhost | | .o+o = o | 2026-02-23 15:06:26.350875 | controller -> localhost | | +. o + | 2026-02-23 15:06:26.350893 | controller -> localhost | | .. . | 2026-02-23 15:06:26.350910 | controller -> localhost | +----[SHA256]-----+ 2026-02-23 15:06:26.350959 | controller -> localhost | ok: Runtime: 0:00:00.081132 2026-02-23 15:06:26.356081 | 2026-02-23 15:06:26.356140 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 15:06:26.374169 | controller | ok 2026-02-23 15:06:26.384646 | controller | included: /var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 15:06:26.391645 | 2026-02-23 15:06:26.391707 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 15:06:26.404271 | controller | skipping: Conditional result was False 2026-02-23 15:06:26.409106 | 2026-02-23 15:06:26.409172 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 15:06:26.770157 | controller | changed 2026-02-23 15:06:26.775863 | 2026-02-23 15:06:26.775933 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 15:06:26.957695 | controller | ok 2026-02-23 15:06:26.962800 | 2026-02-23 15:06:26.962860 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 15:06:27.516069 | controller | changed 2026-02-23 15:06:27.520807 | 2026-02-23 15:06:27.520874 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 15:06:28.064189 | controller | changed 2026-02-23 15:06:28.069063 | 2026-02-23 15:06:28.069123 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 15:06:28.082944 | controller | skipping: Conditional result was False 2026-02-23 15:06:28.087634 | 2026-02-23 15:06:28.087697 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 15:06:28.355667 | controller -> localhost | changed 2026-02-23 15:06:28.364708 | 2026-02-23 15:06:28.364770 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 15:06:28.580697 | controller -> localhost | Identity added: /var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/02fd759dc8bc4d9a8a433c8eb268fbc4_id_rsa (zuul-build-sshkey) 2026-02-23 15:06:28.580863 | controller -> localhost | ok: Runtime: 0:00:00.006340 2026-02-23 15:06:28.586057 | 2026-02-23 15:06:28.586118 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 15:06:28.857461 | controller | ok 2026-02-23 15:06:28.861908 | 2026-02-23 15:06:28.861982 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 15:06:28.885517 | controller | skipping: Conditional result was False 2026-02-23 15:06:28.894683 | 2026-02-23 15:06:28.894750 | TASK [include_role : validate-host] 2026-02-23 15:06:28.911722 | controller | ok 2026-02-23 15:06:28.929285 | 2026-02-23 15:06:28.929361 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-23 15:06:28.947223 | controller | ok 2026-02-23 15:06:28.951336 | 2026-02-23 15:06:28.951397 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-23 15:06:29.136775 | controller -> localhost | ok 2026-02-23 15:06:29.142318 | 2026-02-23 15:06:29.142385 | TASK [validate-host : Collect information about the host] 2026-02-23 15:06:29.739432 | controller | ok 2026-02-23 15:06:29.746687 | 2026-02-23 15:06:29.746748 | TASK [validate-host : Sanitize hostname] 2026-02-23 15:06:29.805612 | controller | ok 2026-02-23 15:06:29.815688 | 2026-02-23 15:06:29.815752 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-23 15:06:30.184731 | controller -> localhost | changed 2026-02-23 15:06:30.206154 | 2026-02-23 15:06:30.206235 | TASK [validate-host : Collect information about zuul worker] 2026-02-23 15:06:30.516939 | controller | ok 2026-02-23 15:06:30.521092 | 2026-02-23 15:06:30.521151 | TASK [validate-host : Write out all zuul information for each host] 2026-02-23 15:06:30.859520 | controller -> localhost | changed 2026-02-23 15:06:30.867671 | 2026-02-23 15:06:30.867729 | TASK [include_role : prepare-workspace-openshift] 2026-02-23 15:06:30.880903 | controller | skipping: Conditional result was False 2026-02-23 15:06:30.885382 | 2026-02-23 15:06:30.885444 | TASK [include_role : remove-zuul-sshkey] 2026-02-23 15:06:30.898521 | controller | skipping: Conditional result was False 2026-02-23 15:06:30.903343 | 2026-02-23 15:06:30.903404 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-23 15:06:31.086533 | controller | ok: "logs" 2026-02-23 15:06:31.086743 | controller | ok: All items complete 2026-02-23 15:06:31.086774 | 2026-02-23 15:06:31.247097 | controller | ok: "artifacts" 2026-02-23 15:06:31.412369 | controller | ok: "docs" 2026-02-23 15:06:31.418395 | 2026-02-23 15:06:31.418506 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-23 15:06:31.607789 | controller | changed: "logs" 2026-02-23 15:06:31.767599 | controller | changed: "artifacts" 2026-02-23 15:06:31.934450 | controller | changed: "docs" 2026-02-23 15:06:31.961590 | 2026-02-23 15:06:31.961689 | PLAY RECAP 2026-02-23 15:06:31.961736 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-02-23 15:06:31.961764 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-23 15:06:31.961783 | 2026-02-23 15:06:32.032819 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-02-23 15:06:32.033558 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-02-23 15:06:32.558143 | 2026-02-23 15:06:32.558251 | PLAY [all] 2026-02-23 15:06:32.576683 | 2026-02-23 15:06:32.576752 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-02-23 15:06:32.624745 | controller | ok 2026-02-23 15:06:32.629046 | 2026-02-23 15:06:32.629126 | TASK [mirror-info-fork : Create /etc/ci] 2026-02-23 15:06:32.951035 | controller | changed 2026-02-23 15:06:32.956460 | 2026-02-23 15:06:32.956527 | TASK [mirror-info-fork : Install ci_mirror script] 2026-02-23 15:06:33.744250 | controller | changed 2026-02-23 15:06:33.753022 | 2026-02-23 15:06:33.753093 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2026-02-23 15:06:34.098912 | controller | changed: 2026-02-23 15:06:34.099142 | controller | { 2026-02-23 15:06:34.099176 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2026-02-23 15:06:34.099207 | controller | } 2026-02-23 15:06:34.295375 | controller | changed: 2026-02-23 15:06:34.295468 | controller | { 2026-02-23 15:06:34.295497 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2026-02-23 15:06:34.295520 | controller | } 2026-02-23 15:06:34.493437 | controller | changed: 2026-02-23 15:06:34.493595 | controller | { 2026-02-23 15:06:34.493630 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2026-02-23 15:06:34.493655 | controller | } 2026-02-23 15:06:34.686208 | controller | changed: 2026-02-23 15:06:34.686313 | controller | { 2026-02-23 15:06:34.686345 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2026-02-23 15:06:34.686368 | controller | } 2026-02-23 15:06:34.891520 | controller | changed: 2026-02-23 15:06:34.891582 | controller | { 2026-02-23 15:06:34.891610 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2026-02-23 15:06:34.891632 | controller | } 2026-02-23 15:06:35.101062 | controller | changed: 2026-02-23 15:06:35.101119 | controller | { 2026-02-23 15:06:35.101147 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2026-02-23 15:06:35.101170 | controller | } 2026-02-23 15:06:35.297144 | controller | changed: 2026-02-23 15:06:35.297197 | controller | { 2026-02-23 15:06:35.297223 | 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-02-23 15:06:35.297245 | controller | } 2026-02-23 15:06:35.492898 | controller | changed: 2026-02-23 15:06:35.492956 | controller | { 2026-02-23 15:06:35.492983 | 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-02-23 15:06:35.493003 | controller | } 2026-02-23 15:06:35.681561 | controller | changed: 2026-02-23 15:06:35.681619 | controller | { 2026-02-23 15:06:35.681646 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2026-02-23 15:06:35.681668 | controller | } 2026-02-23 15:06:35.874008 | controller | changed: 2026-02-23 15:06:35.874055 | controller | { 2026-02-23 15:06:35.874080 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2026-02-23 15:06:35.874098 | controller | } 2026-02-23 15:06:36.071006 | controller | changed: 2026-02-23 15:06:36.071083 | controller | { 2026-02-23 15:06:36.071112 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2026-02-23 15:06:36.071134 | controller | } 2026-02-23 15:06:36.297497 | controller | changed: 2026-02-23 15:06:36.297577 | controller | { 2026-02-23 15:06:36.297605 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2026-02-23 15:06:36.297625 | controller | } 2026-02-23 15:06:36.482179 | controller | changed: 2026-02-23 15:06:36.482269 | controller | { 2026-02-23 15:06:36.482312 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com" 2026-02-23 15:06:36.482340 | controller | } 2026-02-23 15:06:36.681148 | controller | changed: 2026-02-23 15:06:36.681330 | controller | { 2026-02-23 15:06:36.681372 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2026-02-23 15:06:36.681397 | controller | } 2026-02-23 15:06:36.883100 | controller | changed: 2026-02-23 15:06:36.883187 | controller | { 2026-02-23 15:06:36.883214 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2026-02-23 15:06:36.883235 | controller | } 2026-02-23 15:06:37.080389 | controller | changed: 2026-02-23 15:06:37.080473 | controller | { 2026-02-23 15:06:37.080500 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2026-02-23 15:06:37.080520 | controller | } 2026-02-23 15:06:37.281227 | controller | changed: 2026-02-23 15:06:37.281330 | controller | { 2026-02-23 15:06:37.281363 | 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-02-23 15:06:37.281386 | controller | } 2026-02-23 15:06:37.475736 | controller | changed: 2026-02-23 15:06:37.475822 | controller | { 2026-02-23 15:06:37.475848 | 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-02-23 15:06:37.475876 | controller | } 2026-02-23 15:06:37.673556 | controller | changed: 2026-02-23 15:06:37.673648 | controller | { 2026-02-23 15:06:37.673675 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2026-02-23 15:06:37.673695 | controller | } 2026-02-23 15:06:37.861679 | controller | changed: 2026-02-23 15:06:37.861727 | controller | { 2026-02-23 15:06:37.861752 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2026-02-23 15:06:37.861771 | controller | } 2026-02-23 15:06:38.052459 | controller | changed: 2026-02-23 15:06:38.052507 | controller | { 2026-02-23 15:06:38.052532 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2026-02-23 15:06:38.052551 | controller | } 2026-02-23 15:06:38.241493 | controller | changed: 2026-02-23 15:06:38.241553 | controller | { 2026-02-23 15:06:38.241587 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2026-02-23 15:06:38.241613 | controller | } 2026-02-23 15:06:38.434708 | controller | changed: 2026-02-23 15:06:38.434768 | controller | { 2026-02-23 15:06:38.434802 | 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-02-23 15:06:38.434830 | controller | } 2026-02-23 15:06:38.624602 | controller | changed: 2026-02-23 15:06:38.624651 | controller | { 2026-02-23 15:06:38.624677 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2026-02-23 15:06:38.624696 | controller | } 2026-02-23 15:06:38.811528 | controller | changed: 2026-02-23 15:06:38.811599 | controller | { 2026-02-23 15:06:38.811625 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2026-02-23 15:06:38.811646 | controller | } 2026-02-23 15:06:39.002189 | controller | changed: 2026-02-23 15:06:39.002242 | controller | { 2026-02-23 15:06:39.002269 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2026-02-23 15:06:39.002289 | controller | } 2026-02-23 15:06:39.019466 | 2026-02-23 15:06:39.019569 | TASK [Set timezone to UTC] 2026-02-23 15:06:39.398513 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2026-02-23 15:06:39.406625 | 2026-02-23 15:06:39.406692 | TASK [Create nodepool directory] 2026-02-23 15:06:39.608703 | controller | changed 2026-02-23 15:06:39.613990 | 2026-02-23 15:06:39.614056 | TASK [Create nodepool sub_nodes file] 2026-02-23 15:06:40.078445 | controller | changed 2026-02-23 15:06:40.083168 | 2026-02-23 15:06:40.083234 | TASK [Create nodepool sub_nodes_private file] 2026-02-23 15:06:40.559046 | controller | changed 2026-02-23 15:06:40.564553 | 2026-02-23 15:06:40.564615 | LOOP [Populate nodepool sub_nodes file] 2026-02-23 15:06:40.593235 | 2026-02-23 15:06:40.593369 | LOOP [Populate nodepool sub_nodes_private file] 2026-02-23 15:06:40.622071 | 2026-02-23 15:06:40.622191 | TASK [Create nodepool primary file] 2026-02-23 15:06:40.645593 | controller | skipping: Conditional result was False 2026-02-23 15:06:40.650373 | 2026-02-23 15:06:40.650445 | TASK [Create nodepool node_private for this node] 2026-02-23 15:06:41.166051 | controller | changed 2026-02-23 15:06:41.171473 | 2026-02-23 15:06:41.171535 | LOOP [Copy ssh keys to nodepool directory] 2026-02-23 15:06:41.470084 | controller | ok: Item: id_rsa Runtime: 0:00:00.005496 2026-02-23 15:06:41.470264 | 2026-02-23 15:06:41.624863 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004524 2026-02-23 15:06:41.636796 | 2026-02-23 15:06:41.636886 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2026-02-23 15:06:42.150773 | controller | changed 2026-02-23 15:06:42.155602 | 2026-02-23 15:06:42.155665 | TASK [Validate sudoers config after edits] 2026-02-23 15:06:42.363715 | controller | /etc/sudoers: parsed OK 2026-02-23 15:06:42.363803 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2026-02-23 15:06:42.363814 | controller | /etc/sudoers.d/zuul: parsed OK 2026-02-23 15:06:42.363822 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2026-02-23 15:06:42.681150 | controller | ok: Runtime: 0:00:00.005414 2026-02-23 15:06:42.685938 | 2026-02-23 15:06:42.686006 | TASK [Show the environment passed in to job shell scripts] 2026-02-23 15:06:42.872855 | controller | SHELL=/bin/bash 2026-02-23 15:06:42.872892 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2026-02-23 15:06:42.872902 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2026-02-23 15:06:42.872908 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/83/3683/79c9f076cfc30eb45ee6c461fa8d8dfda5624e2b 2026-02-23 15:06:42.872914 | controller | PWD=/home/zuul 2026-02-23 15:06:42.872920 | controller | ZUUL_PIPELINE=github-check 2026-02-23 15:06:42.872925 | controller | LOGNAME=zuul 2026-02-23 15:06:42.872930 | controller | XDG_SESSION_TYPE=tty 2026-02-23 15:06:42.872956 | controller | _=/usr/bin/env 2026-02-23 15:06:42.872963 | controller | MOTD_SHOWN=pam 2026-02-23 15:06:42.872968 | controller | HOME=/home/zuul 2026-02-23 15:06:42.872973 | controller | LANG=en_US.UTF-8 2026-02-23 15:06:42.872979 | controller | SSH_CONNECTION=192.168.26.12 59536 192.168.26.19 22 2026-02-23 15:06:42.872984 | 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-02-23 15:06:42.872992 | controller | ZUUL_CHANGE_IDS=3683,79c9f076cfc30eb45ee6c461fa8d8dfda5624e2b 2026-02-23 15:06:42.872997 | controller | WORKSPACE=/home/zuul/workspace 2026-02-23 15:06:42.873003 | controller | XDG_SESSION_CLASS=user 2026-02-23 15:06:42.873008 | controller | SELINUX_ROLE_REQUESTED= 2026-02-23 15:06:42.873013 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2026-02-23 15:06:42.873018 | controller | USER=zuul 2026-02-23 15:06:42.873024 | controller | ZUUL_VOTING=True 2026-02-23 15:06:42.873029 | controller | BUILD_TIMEOUT=1800000 2026-02-23 15:06:42.873034 | controller | SELINUX_USE_CURRENT_RANGE= 2026-02-23 15:06:42.873039 | controller | SHLVL=1 2026-02-23 15:06:42.873045 | controller | ZUUL_PATCHSET=79c9f076cfc30eb45ee6c461fa8d8dfda5624e2b 2026-02-23 15:06:42.873050 | controller | XDG_SESSION_ID=1 2026-02-23 15:06:42.873055 | controller | ZUUL_BRANCH=main 2026-02-23 15:06:42.873060 | controller | XDG_RUNTIME_DIR=/run/user/1000 2026-02-23 15:06:42.873066 | controller | SSH_CLIENT=192.168.26.12 59536 22 2026-02-23 15:06:42.873072 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2026-02-23 15:06:42.873078 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2026-02-23 15:06:42.873084 | controller | which_declare=declare -f 2026-02-23 15:06:42.873089 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-02-23 15:06:42.873094 | controller | SELINUX_LEVEL_REQUESTED= 2026-02-23 15:06:42.873099 | controller | ZUUL_CHANGE=3683 2026-02-23 15:06:42.873105 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2026-02-23 15:06:42.873110 | controller | ZUUL_UUID=02fd759dc8bc4d9a8a433c8eb268fbc4 2026-02-23 15:06:42.873116 | controller | BASH_FUNC_which%%=() { ( alias; 2026-02-23 15:06:42.873121 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2026-02-23 15:06:42.873126 | controller | } 2026-02-23 15:06:43.209436 | controller | ok: Runtime: 0:00:00.005808 2026-02-23 15:06:43.215012 | 2026-02-23 15:06:43.215074 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2026-02-23 15:06:43.227933 | controller | skipping: Conditional result was False 2026-02-23 15:06:43.232911 | 2026-02-23 15:06:43.232983 | TASK [Symlink /home/zuul-worker/workspace] 2026-02-23 15:06:43.756775 | controller | skipping: Conditional result was False 2026-02-23 15:06:43.762477 | 2026-02-23 15:06:43.762542 | TASK [Ensure legacy workspace directory] 2026-02-23 15:06:43.943340 | controller | changed 2026-02-23 15:06:43.960619 | 2026-02-23 15:06:43.960670 | PLAY RECAP 2026-02-23 15:06:43.960712 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-02-23 15:06:43.960737 | 2026-02-23 15:06:44.042717 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-02-23 15:06:44.043567 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-02-23 15:06:44.538360 | 2026-02-23 15:06:44.538456 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2026-02-23 15:06:44.558641 | 2026-02-23 15:06:44.558713 | TASK [Create zuul-output directory] 2026-02-23 15:06:44.861403 | controller | changed 2026-02-23 15:06:44.866230 | 2026-02-23 15:06:44.866323 | TASK [Slurp Zuul inventory test] 2026-02-23 15:06:45.133115 | controller -> localhost | ok 2026-02-23 15:06:45.139595 | 2026-02-23 15:06:45.139663 | TASK [Save zuul inventory] 2026-02-23 15:06:45.836361 | controller | changed 2026-02-23 15:06:45.841185 | 2026-02-23 15:06:45.841250 | TASK [Save zuul vars without the change_message] 2026-02-23 15:06:46.386446 | controller | changed 2026-02-23 15:06:46.406041 | 2026-02-23 15:06:46.406118 | PLAY RECAP 2026-02-23 15:06:46.406160 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-23 15:06:46.406183 | 2026-02-23 15:06:46.469102 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-02-23 15:06:46.469858 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-02-23 15:06:46.990910 | 2026-02-23 15:06:46.991039 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2026-02-23 15:06:47.010884 | 2026-02-23 15:06:47.010964 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2026-02-23 15:06:47.029049 | controller | ok 2026-02-23 15:06:47.044376 | 2026-02-23 15:06:47.044456 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-02-23 15:06:47.067844 | controller | skipping: Conditional result was False 2026-02-23 15:06:47.073276 | 2026-02-23 15:06:47.073366 | TASK [mirror-info-fork : Create /etc/ci] 2026-02-23 15:06:47.374620 | controller | ok 2026-02-23 15:06:47.379786 | 2026-02-23 15:06:47.379855 | TASK [mirror-info-fork : Install ci_mirror script] 2026-02-23 15:06:47.977515 | controller | ok 2026-02-23 15:06:47.986730 | 2026-02-23 15:06:47.986796 | TASK [Prepare workspace] 2026-02-23 15:06:48.003668 | controller | ok 2026-02-23 15:06:48.018834 | 2026-02-23 15:06:48.018896 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-23 15:06:48.289186 | controller | ok 2026-02-23 15:06:48.294966 | 2026-02-23 15:06:48.295032 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-23 15:06:50.589894 | controller | Output suppressed because no_log was given 2026-02-23 15:06:50.598953 | 2026-02-23 15:06:50.599016 | LOOP [Create zuul-output directory] 2026-02-23 15:06:50.781913 | controller | changed: "/home/zuul/ci-framework-data/logs" 2026-02-23 15:06:50.931024 | controller | ok: "/home/zuul/zuul-output/logs" 2026-02-23 15:06:50.945331 | 2026-02-23 15:06:50.945397 | TASK [Install required packages] 2026-02-23 15:07:28.272732 | controller | changed 2026-02-23 15:07:28.277991 | 2026-02-23 15:07:28.278052 | TASK [Install venv] 2026-02-23 15:08:28.155064 | controller | changed 2026-02-23 15:08:28.179544 | 2026-02-23 15:08:28.179610 | PLAY RECAP 2026-02-23 15:08:28.179658 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-23 15:08:28.179680 | 2026-02-23 15:08:28.248361 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-02-23 15:08:28.249160 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2026-02-23 15:08:28.730098 | 2026-02-23 15:08:28.730195 | PLAY [Run ci/playbooks/molecule-test.yml] 2026-02-23 15:08:28.748914 | 2026-02-23 15:08:28.748992 | TASK [Gather required facts] 2026-02-23 15:08:29.203061 | controller | ok 2026-02-23 15:08:29.208254 | 2026-02-23 15:08:29.208347 | TASK [Load environment var if instructed to] 2026-02-23 15:08:29.233681 | controller | skipping: Conditional result was False 2026-02-23 15:08:29.239088 | 2026-02-23 15:08:29.239153 | TASK [Ensure group_vars dir exists] 2026-02-23 15:08:29.530339 | controller | ok 2026-02-23 15:08:29.536272 | 2026-02-23 15:08:29.536367 | TASK [Print related variables] 2026-02-23 15:08:29.564651 | controller | ok: 2026-02-23 15:08:29.564760 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml 2026-02-23 15:08:29.564788 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/config_drive 2026-02-23 15:08:29.569253 | 2026-02-23 15:08:29.569341 | TASK [Run molecule] 2026-02-23 15:08:30.447492 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2026-02-23 15:08:30.512227 | controller | INFO Performing prerun with role_name_check=0... 2026-02-23 15:08:47.467484 | controller | WARNING Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.467908 | controller | WARNING Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.468354 | controller | WARNING Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.468780 | controller | WARNING Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.469249 | controller | WARNING Another version of 'cifmw.general' 1.0.0+79c9f076 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 1.0.0+79c9f076 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.469681 | controller | WARNING Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.470129 | controller | WARNING Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.470558 | controller | WARNING Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.470996 | controller | WARNING Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.471407 | controller | WARNING Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.471841 | controller | WARNING Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.472285 | controller | WARNING Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.472692 | controller | WARNING Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.473164 | controller | WARNING Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.473580 | controller | WARNING Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/8c3967/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections). 2026-02-23 15:08:47.482778 | controller | INFO Running default > prepare 2026-02-23 15:08:48.092901 | controller | 2026-02-23 15:08:48.092965 | controller | PLAY [Prepare] ***************************************************************** 2026-02-23 15:08:48.093011 | controller | 2026-02-23 15:08:48.093119 | controller | TASK [Gathering Facts] ********************************************************* 2026-02-23 15:08:48.093187 | controller | Monday 23 February 2026 15:08:48 +0000 (0:00:00.011) 0:00:00.011 ******* 2026-02-23 15:08:48.885929 | controller | ok: [instance] 2026-02-23 15:08:48.885989 | controller | 2026-02-23 15:08:48.886110 | controller | TASK [test_deps : Gather facts if they don't exist] **************************** 2026-02-23 15:08:48.886232 | controller | Monday 23 February 2026 15:08:48 +0000 (0:00:00.793) 0:00:00.804 ******* 2026-02-23 15:08:48.902345 | controller | skipping: [instance] 2026-02-23 15:08:48.902435 | controller | 2026-02-23 15:08:48.902532 | controller | TASK [test_deps : Gather variables for each operating system] ****************** 2026-02-23 15:08:48.902627 | controller | Monday 23 February 2026 15:08:48 +0000 (0:00:00.016) 0:00:00.821 ******* 2026-02-23 15:08:48.941108 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml) 2026-02-23 15:08:48.941197 | controller | 2026-02-23 15:08:48.941300 | controller | TASK [test_deps : Detect mirrors file] ***************************************** 2026-02-23 15:08:48.941406 | controller | Monday 23 February 2026 15:08:48 +0000 (0:00:00.038) 0:00:00.860 ******* 2026-02-23 15:08:49.208124 | controller | ok: [instance] 2026-02-23 15:08:49.208186 | controller | 2026-02-23 15:08:49.208294 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] *********** 2026-02-23 15:08:49.208389 | controller | Monday 23 February 2026 15:08:49 +0000 (0:00:00.266) 0:00:01.127 ******* 2026-02-23 15:08:49.507950 | controller | ok: [instance] 2026-02-23 15:08:49.508025 | controller | 2026-02-23 15:08:49.508128 | controller | TASK [test_deps : Disable ubi 9 repos] ***************************************** 2026-02-23 15:08:49.508221 | controller | Monday 23 February 2026 15:08:49 +0000 (0:00:00.299) 0:00:01.427 ******* 2026-02-23 15:08:50.166852 | controller | ok: [instance] => (item=ubi-9-appstream) 2026-02-23 15:08:50.166936 | controller | ok: [instance] => (item=ubi-9-baseos) 2026-02-23 15:08:50.167031 | controller | ok: [instance] => (item=ubi-9-codeready-builder) 2026-02-23 15:08:50.167116 | controller | 2026-02-23 15:08:50.167212 | controller | TASK [Deploy repo-setup] ******************************************************* 2026-02-23 15:08:50.167301 | controller | Monday 23 February 2026 15:08:50 +0000 (0:00:00.658) 0:00:02.085 ******* 2026-02-23 15:08:50.222456 | controller | 2026-02-23 15:08:50.222624 | controller | TASK [repo_setup : Ensure directories are present] ***************************** 2026-02-23 15:08:50.222821 | controller | Monday 23 February 2026 15:08:50 +0000 (0:00:00.055) 0:00:02.141 ******* 2026-02-23 15:08:50.708660 | controller | changed: [instance] => (item=tmp) 2026-02-23 15:08:50.708736 | controller | changed: [instance] => (item=artifacts/repositories) 2026-02-23 15:08:50.708825 | controller | changed: [instance] => (item=venv/repo_setup) 2026-02-23 15:08:50.708920 | controller | 2026-02-23 15:08:50.709007 | controller | TASK [repo_setup : Make sure git-core package is installed] ******************** 2026-02-23 15:08:50.709090 | controller | Monday 23 February 2026 15:08:50 +0000 (0:00:00.486) 0:00:02.627 ******* 2026-02-23 15:08:51.444527 | controller | ok: [instance] 2026-02-23 15:08:51.444772 | controller | 2026-02-23 15:08:51.444920 | controller | TASK [repo_setup : Get repo-setup repository] ********************************** 2026-02-23 15:08:51.444936 | controller | Monday 23 February 2026 15:08:51 +0000 (0:00:00.735) 0:00:03.363 ******* 2026-02-23 15:08:52.495230 | controller | changed: [instance] 2026-02-23 15:08:59.886461 | controller | 2026-02-23 15:08:59.886499 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************ 2026-02-23 15:08:59.886508 | controller | Monday 23 February 2026 15:08:52 +0000 (0:00:01.050) 0:00:04.414 ******* 2026-02-23 15:08:59.886518 | controller | changed: [instance] 2026-02-23 15:09:00.529924 | controller | 2026-02-23 15:09:00.529957 | controller | TASK [repo_setup : Install repo-setup package] ********************************* 2026-02-23 15:09:00.529965 | controller | Monday 23 February 2026 15:08:59 +0000 (0:00:07.391) 0:00:11.805 ******* 2026-02-23 15:09:00.529974 | controller | changed: [instance] 2026-02-23 15:09:00.550203 | controller | 2026-02-23 15:09:00.550222 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] *** 2026-02-23 15:09:00.550230 | controller | Monday 23 February 2026 15:09:00 +0000 (0:00:00.643) 0:00:12.448 ******* 2026-02-23 15:09:00.550239 | controller | skipping: [instance] 2026-02-23 15:09:02.915218 | controller | 2026-02-23 15:09:02.915246 | controller | TASK [repo_setup : Run repo-setup] ********************************************* 2026-02-23 15:09:02.915254 | controller | Monday 23 February 2026 15:09:00 +0000 (0:00:00.020) 0:00:12.469 ******* 2026-02-23 15:09:02.915264 | controller | changed: [instance] 2026-02-23 15:09:02.961288 | controller | 2026-02-23 15:09:02.961310 | controller | TASK [repo_setup : Get component repo] ***************************************** 2026-02-23 15:09:02.961320 | controller | Monday 23 February 2026 15:09:02 +0000 (0:00:02.364) 0:00:14.834 ******* 2026-02-23 15:09:02.961332 | controller | skipping: [instance] 2026-02-23 15:09:02.993823 | controller | 2026-02-23 15:09:02.993864 | controller | TASK [repo_setup : Rename component repo] ************************************** 2026-02-23 15:09:02.993894 | controller | Monday 23 February 2026 15:09:02 +0000 (0:00:00.046) 0:00:14.880 ******* 2026-02-23 15:09:02.993908 | controller | skipping: [instance] 2026-02-23 15:09:02.993936 | controller | 2026-02-23 15:09:02.993945 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] ******* 2026-02-23 15:09:02.994013 | controller | Monday 23 February 2026 15:09:02 +0000 (0:00:00.032) 0:00:14.912 ******* 2026-02-23 15:09:03.027765 | controller | skipping: [instance] 2026-02-23 15:09:03.028138 | controller | 2026-02-23 15:09:03.554753 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************ 2026-02-23 15:09:03.554783 | controller | Monday 23 February 2026 15:09:03 +0000 (0:00:00.034) 0:00:14.946 ******* 2026-02-23 15:09:03.554795 | controller | changed: [instance] 2026-02-23 15:09:03.960015 | controller | 2026-02-23 15:09:03.960046 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] ******************* 2026-02-23 15:09:03.960054 | controller | Monday 23 February 2026 15:09:03 +0000 (0:00:00.526) 0:00:15.473 ******* 2026-02-23 15:09:03.960064 | controller | changed: [instance] 2026-02-23 15:09:03.988239 | controller | 2026-02-23 15:09:03.988255 | controller | TASK [repo_setup : Dump current-podified hash] ********************************* 2026-02-23 15:09:03.988262 | controller | Monday 23 February 2026 15:09:03 +0000 (0:00:00.405) 0:00:15.878 ******* 2026-02-23 15:09:03.988270 | controller | skipping: [instance] 2026-02-23 15:09:04.016435 | controller | 2026-02-23 15:09:04.016451 | controller | TASK [repo_setup : Slurp current podified hash] ******************************** 2026-02-23 15:09:04.016459 | controller | Monday 23 February 2026 15:09:03 +0000 (0:00:00.028) 0:00:15.907 ******* 2026-02-23 15:09:04.016471 | controller | skipping: [instance] 2026-02-23 15:09:04.044794 | controller | 2026-02-23 15:09:04.044834 | controller | TASK [repo_setup : Update the value of full_hash] ****************************** 2026-02-23 15:09:04.044843 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.028) 0:00:15.935 ******* 2026-02-23 15:09:04.044854 | controller | skipping: [instance] 2026-02-23 15:09:04.045133 | controller | 2026-02-23 15:09:04.045153 | controller | TASK [repo_setup : Export hashes facts for further use] ************************ 2026-02-23 15:09:04.082223 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.028) 0:00:15.963 ******* 2026-02-23 15:09:04.082241 | controller | ok: [instance] 2026-02-23 15:09:04.106776 | controller | 2026-02-23 15:09:04.106808 | controller | TASK [repo_setup : Create download directory] ********************************** 2026-02-23 15:09:04.106815 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.037) 0:00:16.001 ******* 2026-02-23 15:09:04.106825 | controller | skipping: [instance] 2026-02-23 15:09:04.106848 | controller | 2026-02-23 15:09:04.106856 | controller | TASK [repo_setup : Print the URL to request] *********************************** 2026-02-23 15:09:04.106925 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.024) 0:00:16.026 ******* 2026-02-23 15:09:04.132333 | controller | skipping: [instance] 2026-02-23 15:09:04.157506 | controller | 2026-02-23 15:09:04.157525 | controller | TASK [Download the RPM] ******************************************************** 2026-02-23 15:09:04.157534 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.025) 0:00:16.051 ******* 2026-02-23 15:09:04.157545 | controller | skipping: [instance] 2026-02-23 15:09:04.183509 | controller | 2026-02-23 15:09:04.183527 | controller | TASK [repo_setup : Install RHOS Release tool] ********************************** 2026-02-23 15:09:04.183535 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.025) 0:00:16.076 ******* 2026-02-23 15:09:04.183545 | controller | skipping: [instance] 2026-02-23 15:09:04.209406 | controller | 2026-02-23 15:09:04.209438 | controller | TASK [repo_setup : Get rhos-release tool version] ****************************** 2026-02-23 15:09:04.209452 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.025) 0:00:16.102 ******* 2026-02-23 15:09:04.209468 | controller | skipping: [instance] 2026-02-23 15:09:04.237186 | controller | 2026-02-23 15:09:04.237218 | controller | TASK [repo_setup : Print rhos-release tool version] **************************** 2026-02-23 15:09:04.237233 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.025) 0:00:16.128 ******* 2026-02-23 15:09:04.237249 | controller | skipping: [instance] 2026-02-23 15:09:04.260820 | controller | 2026-02-23 15:09:04.260861 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] *** 2026-02-23 15:09:04.260871 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.027) 0:00:16.155 ******* 2026-02-23 15:09:04.260894 | controller | skipping: [instance] 2026-02-23 15:09:04.260924 | controller | 2026-02-23 15:09:04.261290 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] *************************** 2026-02-23 15:09:04.435054 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.024) 0:00:16.179 ******* 2026-02-23 15:09:04.435076 | controller | ok: [instance] 2026-02-23 15:09:04.629816 | controller | 2026-02-23 15:09:04.629846 | controller | TASK [repo_setup : Use RDO proxy mirrors] ************************************** 2026-02-23 15:09:04.629855 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.174) 0:00:16.354 ******* 2026-02-23 15:09:04.629865 | controller | changed: [instance] 2026-02-23 15:09:04.629901 | controller | 2026-02-23 15:09:04.629911 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] *** 2026-02-23 15:09:04.630006 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.194) 0:00:16.549 ******* 2026-02-23 15:09:04.862187 | controller | changed: [instance] 2026-02-23 15:09:04.885321 | controller | 2026-02-23 15:09:04.885344 | controller | TASK [repo_setup : Check for gating.repo file on content provider] ************* 2026-02-23 15:09:04.885353 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.231) 0:00:16.780 ******* 2026-02-23 15:09:04.885363 | controller | skipping: [instance] 2026-02-23 15:09:04.907659 | controller | 2026-02-23 15:09:04.907679 | controller | TASK [repo_setup : Populate gating repo from content provider ip] ************** 2026-02-23 15:09:04.907687 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.023) 0:00:16.804 ******* 2026-02-23 15:09:04.907717 | controller | skipping: [instance] 2026-02-23 15:09:04.929784 | controller | 2026-02-23 15:09:04.929818 | controller | TASK [repo_setup : Check for DLRN repo at the destination] ********************* 2026-02-23 15:09:04.929834 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.022) 0:00:16.826 ******* 2026-02-23 15:09:04.929845 | controller | skipping: [instance] 2026-02-23 15:09:04.929863 | controller | 2026-02-23 15:09:04.929871 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] *** 2026-02-23 15:09:04.929957 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.022) 0:00:16.849 ******* 2026-02-23 15:09:04.952172 | controller | skipping: [instance] 2026-02-23 15:09:04.952262 | controller | 2026-02-23 15:09:04.952361 | controller | TASK [repo_setup : Check for DLRN component repo] ****************************** 2026-02-23 15:09:04.952456 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.022) 0:00:16.871 ******* 2026-02-23 15:09:04.973794 | controller | skipping: [instance] 2026-02-23 15:09:04.973905 | controller | 2026-02-23 15:09:04.974013 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] *** 2026-02-23 15:09:04.974100 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.021) 0:00:16.893 ******* 2026-02-23 15:09:04.996091 | controller | skipping: [instance] 2026-02-23 15:09:04.996170 | controller | 2026-02-23 15:09:04.996274 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ******** 2026-02-23 15:09:04.996372 | controller | Monday 23 February 2026 15:09:04 +0000 (0:00:00.022) 0:00:16.915 ******* 2026-02-23 15:09:05.013852 | controller | skipping: [instance] 2026-02-23 15:09:05.013964 | controller | 2026-02-23 15:09:05.014058 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ****** 2026-02-23 15:09:05.014155 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.017) 0:00:16.933 ******* 2026-02-23 15:09:05.042048 | controller | skipping: [instance] 2026-02-23 15:09:05.042136 | controller | 2026-02-23 15:09:05.042234 | controller | TASK [repo_setup : Cleanup existing metadata] ********************************** 2026-02-23 15:09:05.042334 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.028) 0:00:16.961 ******* 2026-02-23 15:09:05.058627 | controller | skipping: [instance] 2026-02-23 15:09:05.058731 | controller | 2026-02-23 15:09:05.058840 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] ********* 2026-02-23 15:09:05.058958 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.016) 0:00:16.978 ******* 2026-02-23 15:09:05.079027 | controller | skipping: [instance] 2026-02-23 15:09:05.079116 | controller | 2026-02-23 15:09:05.079217 | controller | TASK [test_deps : Look for redhat-release rpm] ********************************* 2026-02-23 15:09:05.079314 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.020) 0:00:16.998 ******* 2026-02-23 15:09:05.108114 | controller | skipping: [instance] 2026-02-23 15:09:05.108160 | controller | 2026-02-23 15:09:05.108465 | controller | TASK [test_deps : Remove redhat-release] *************************************** 2026-02-23 15:09:05.108576 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.029) 0:00:17.027 ******* 2026-02-23 15:09:05.142204 | controller | skipping: [instance] 2026-02-23 15:09:05.170461 | controller | 2026-02-23 15:09:05.170483 | controller | TASK [test_deps : Install centos-stream-release] ******************************* 2026-02-23 15:09:05.170493 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.033) 0:00:17.061 ******* 2026-02-23 15:09:05.170505 | controller | skipping: [instance] 2026-02-23 15:09:05.198814 | controller | 2026-02-23 15:09:05.198841 | controller | TASK [test_deps : Install additional packages] ********************************* 2026-02-23 15:09:05.198851 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.028) 0:00:17.089 ******* 2026-02-23 15:09:05.198862 | controller | skipping: [instance] 2026-02-23 15:09:05.198903 | controller | 2026-02-23 15:09:05.198915 | controller | TASK [test_deps : Install selinux python libs] ********************************* 2026-02-23 15:09:05.199025 | controller | Monday 23 February 2026 15:09:05 +0000 (0:00:00.028) 0:00:17.118 ******* 2026-02-23 15:09:47.402623 | controller | ok: [instance] 2026-02-23 15:09:48.519610 | controller | 2026-02-23 15:09:48.519641 | controller | TASK [test_deps : Install python yaml libs] ************************************ 2026-02-23 15:09:48.519649 | controller | Monday 23 February 2026 15:09:47 +0000 (0:00:42.203) 0:00:59.321 ******* 2026-02-23 15:09:48.519660 | controller | ok: [instance] 2026-02-23 15:09:48.564354 | controller | 2026-02-23 15:09:48.564374 | controller | TASK [test_deps : Install extra packages] ************************************** 2026-02-23 15:09:48.564381 | controller | Monday 23 February 2026 15:09:48 +0000 (0:00:01.117) 0:01:00.438 ******* 2026-02-23 15:09:48.564390 | controller | skipping: [instance] 2026-02-23 15:09:48.619304 | controller | 2026-02-23 15:09:48.619333 | controller | PLAY RECAP ********************************************************************* 2026-02-23 15:09:48.619341 | controller | instance : ok=19 changed=9 unreachable=0 failed=0 skipped=30 rescued=0 ignored=0 2026-02-23 15:09:48.619347 | controller | 2026-02-23 15:09:48.619352 | controller | Monday 23 February 2026 15:09:48 +0000 (0:00:00.042) 0:01:00.481 ******* 2026-02-23 15:09:48.619358 | controller | =============================================================================== 2026-02-23 15:09:48.619363 | controller | test_deps : Install selinux python libs -------------------------------- 42.20s 2026-02-23 15:09:48.619373 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.39s 2026-02-23 15:09:48.619379 | controller | repo_setup : Run repo-setup --------------------------------------------- 2.36s 2026-02-23 15:09:48.619388 | controller | test_deps : Install python yaml libs ------------------------------------ 1.12s 2026-02-23 15:09:48.619393 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.05s 2026-02-23 15:09:48.619398 | controller | Gathering Facts --------------------------------------------------------- 0.79s 2026-02-23 15:09:48.619403 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.74s 2026-02-23 15:09:48.619408 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.66s 2026-02-23 15:09:48.619413 | controller | repo_setup : Install repo-setup package --------------------------------- 0.64s 2026-02-23 15:09:48.619418 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s 2026-02-23 15:09:48.619422 | controller | repo_setup : Ensure directories are present ----------------------------- 0.49s 2026-02-23 15:09:48.619427 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.41s 2026-02-23 15:09:48.619432 | controller | test_deps : Disable ubi host subscription-manager integration ----------- 0.30s 2026-02-23 15:09:48.619437 | controller | test_deps : Detect mirrors file ----------------------------------------- 0.27s 2026-02-23 15:09:48.619442 | controller | repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.23s 2026-02-23 15:09:48.619447 | controller | repo_setup : Use RDO proxy mirrors -------------------------------------- 0.19s 2026-02-23 15:09:48.619452 | controller | repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.17s 2026-02-23 15:09:48.619457 | controller | Deploy repo-setup ------------------------------------------------------- 0.06s 2026-02-23 15:09:48.619462 | controller | repo_setup : Get component repo ----------------------------------------- 0.05s 2026-02-23 15:09:48.619466 | controller | test_deps : Install extra packages -------------------------------------- 0.04s 2026-02-23 15:09:48.619476 | controller | INFO Running default > converge 2026-02-23 15:09:49.009395 | controller | 2026-02-23 15:09:49.009577 | controller | PLAY [Converge] **************************************************************** 2026-02-23 15:09:49.009733 | controller | 2026-02-23 15:09:49.009880 | controller | TASK [Gathering Facts] ********************************************************* 2026-02-23 15:09:49.010011 | controller | Monday 23 February 2026 15:09:49 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-02-23 15:09:49.746819 | controller | ok: [instance] 2026-02-23 15:09:49.746879 | controller | 2026-02-23 15:09:49.746892 | controller | TASK [Include config_drive role with full configuration] *********************** 2026-02-23 15:09:49.746919 | controller | Monday 23 February 2026 15:09:49 +0000 (0:00:00.737) 0:00:00.750 ******* 2026-02-23 15:09:49.774118 | controller | 2026-02-23 15:09:50.189480 | controller | TASK [config_drive : Ensure needed directories exist] ************************** 2026-02-23 15:09:50.189509 | controller | Monday 23 February 2026 15:09:49 +0000 (0:00:00.027) 0:00:00.777 ******* 2026-02-23 15:09:50.189521 | controller | ok: [instance] => (item=artifacts) 2026-02-23 15:09:54.135535 | controller | ok: [instance] => (item=logs) 2026-02-23 15:09:54.135566 | controller | 2026-02-23 15:09:54.135575 | controller | TASK [config_drive : Install required RPM packages] **************************** 2026-02-23 15:09:54.135581 | controller | Monday 23 February 2026 15:09:50 +0000 (0:00:00.414) 0:00:01.192 ******* 2026-02-23 15:09:54.135591 | controller | changed: [instance] 2026-02-23 15:09:54.325775 | controller | 2026-02-23 15:09:54.325815 | controller | TASK [config_drive : Crate config drive instance directory] ******************** 2026-02-23 15:09:54.325824 | controller | Monday 23 February 2026 15:09:54 +0000 (0:00:03.946) 0:00:05.138 ******* 2026-02-23 15:09:54.325834 | controller | changed: [instance] 2026-02-23 15:09:54.325851 | controller | 2026-02-23 15:09:54.325928 | controller | TASK [config_drive : Generate meta-data] *************************************** 2026-02-23 15:09:54.326061 | controller | Monday 23 February 2026 15:09:54 +0000 (0:00:00.190) 0:00:05.329 ******* 2026-02-23 15:09:54.863108 | controller | changed: [instance] 2026-02-23 15:09:55.215802 | controller | 2026-02-23 15:09:55.215833 | controller | TASK [config_drive : Generate user-data] *************************************** 2026-02-23 15:09:55.215842 | controller | Monday 23 February 2026 15:09:54 +0000 (0:00:00.536) 0:00:05.866 ******* 2026-02-23 15:09:55.215852 | controller | changed: [instance] 2026-02-23 15:09:55.555546 | controller | 2026-02-23 15:09:55.555576 | controller | TASK [config_drive : Generate network-data] ************************************ 2026-02-23 15:09:55.555585 | controller | Monday 23 February 2026 15:09:55 +0000 (0:00:00.352) 0:00:06.219 ******* 2026-02-23 15:09:55.555595 | controller | changed: [instance] 2026-02-23 15:09:55.720041 | controller | 2026-02-23 15:09:55.720063 | controller | TASK [config_drive : Check ISO availability] *********************************** 2026-02-23 15:09:55.720071 | controller | Monday 23 February 2026 15:09:55 +0000 (0:00:00.339) 0:00:06.559 ******* 2026-02-23 15:09:55.720090 | controller | ok: [instance] 2026-02-23 15:09:55.739765 | controller | 2026-02-23 15:09:55.739789 | controller | TASK [config_drive : Assert we don't try to change an existing ISO] ************ 2026-02-23 15:09:55.739797 | controller | Monday 23 February 2026 15:09:55 +0000 (0:00:00.164) 0:00:06.723 ******* 2026-02-23 15:09:55.739808 | controller | skipping: [instance] 2026-02-23 15:09:55.928777 | controller | 2026-02-23 15:09:55.928809 | controller | TASK [config_drive : Generate nocloud iso image] ******************************* 2026-02-23 15:09:55.928818 | controller | Monday 23 February 2026 15:09:55 +0000 (0:00:00.019) 0:00:06.743 ******* 2026-02-23 15:09:55.928828 | controller | Follow script's output here: /home/zuul/ci-framework-data/logs/ci_script_000_generate_nocloud_iso.log 2026-02-23 15:09:55.928852 | controller | changed: [instance] 2026-02-23 15:09:55.928859 | controller | 2026-02-23 15:09:55.928866 | controller | TASK [Run config_drive role again without user-data or network-config (soft-clean scenario)] *** 2026-02-23 15:09:55.928909 | controller | Monday 23 February 2026 15:09:55 +0000 (0:00:00.189) 0:00:06.932 ******* 2026-02-23 15:09:55.958174 | controller | 2026-02-23 15:09:56.295480 | controller | TASK [config_drive : Ensure needed directories exist] ************************** 2026-02-23 15:09:56.295512 | controller | Monday 23 February 2026 15:09:55 +0000 (0:00:00.029) 0:00:06.961 ******* 2026-02-23 15:09:56.295524 | controller | ok: [instance] => (item=artifacts) 2026-02-23 15:09:57.402188 | controller | ok: [instance] => (item=logs) 2026-02-23 15:09:57.402217 | controller | 2026-02-23 15:09:57.402225 | controller | TASK [config_drive : Install required RPM packages] **************************** 2026-02-23 15:09:57.402230 | controller | Monday 23 February 2026 15:09:56 +0000 (0:00:00.337) 0:00:07.298 ******* 2026-02-23 15:09:57.402241 | controller | ok: [instance] 2026-02-23 15:09:57.574659 | controller | 2026-02-23 15:09:57.574680 | controller | TASK [config_drive : Crate config drive instance directory] ******************** 2026-02-23 15:09:57.574687 | controller | Monday 23 February 2026 15:09:57 +0000 (0:00:01.106) 0:00:08.405 ******* 2026-02-23 15:09:57.574710 | controller | ok: [instance] 2026-02-23 15:09:57.893776 | controller | 2026-02-23 15:09:57.893807 | controller | TASK [config_drive : Generate meta-data] *************************************** 2026-02-23 15:09:57.893815 | controller | Monday 23 February 2026 15:09:57 +0000 (0:00:00.172) 0:00:08.578 ******* 2026-02-23 15:09:57.893824 | controller | ok: [instance] 2026-02-23 15:09:57.894047 | controller | 2026-02-23 15:09:57.894062 | controller | TASK [config_drive : Generate user-data] *************************************** 2026-02-23 15:09:57.913292 | controller | Monday 23 February 2026 15:09:57 +0000 (0:00:00.319) 0:00:08.897 ******* 2026-02-23 15:09:57.913321 | controller | skipping: [instance] 2026-02-23 15:09:57.934975 | controller | 2026-02-23 15:09:57.935014 | controller | TASK [config_drive : Generate network-data] ************************************ 2026-02-23 15:09:57.935022 | controller | Monday 23 February 2026 15:09:57 +0000 (0:00:00.019) 0:00:08.916 ******* 2026-02-23 15:09:57.935032 | controller | fatal: [instance]: FAILED! => 2026-02-23 15:09:57.935118 | controller | msg: |- 2026-02-23 15:09:57.935131 | controller | The conditional check 'cifmw_config_drive_networkconfig | default({}) | length > 0' failed. The error was: Unexpected templating type error occurred on ({% if cifmw_config_drive_networkconfig | default({}) | length > 0 %} True {% else %} False {% endif %}): object of type 'NoneType' has no len(). object of type 'NoneType' has no len() 2026-02-23 15:09:57.935146 | controller | 2026-02-23 15:09:57.935152 | controller | The error appears to be in '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/config_drive/tasks/main.yml': line 62, column 3, but may 2026-02-23 15:09:57.935158 | controller | be elsewhere in the file depending on the exact syntax problem. 2026-02-23 15:09:57.935163 | controller | 2026-02-23 15:09:57.935171 | controller | The offending line appears to be: 2026-02-23 15:09:57.935388 | controller | 2026-02-23 15:09:57.935398 | controller | 2026-02-23 15:09:57.936732 | controller | - name: Generate network-data 2026-02-23 15:09:57.936767 | controller | ^ here 2026-02-23 15:09:57.936779 | controller | 2026-02-23 15:09:57.936808 | controller | PLAY RECAP ********************************************************************* 2026-02-23 15:09:57.937747 | controller | instance : ok=13 changed=6 unreachable=0 failed=1 skipped=2 rescued=0 ignored=0 2026-02-23 15:09:57.937834 | controller | 2026-02-23 15:09:57.937843 | controller | Monday 23 February 2026 15:09:57 +0000 (0:00:00.023) 0:00:08.940 ******* 2026-02-23 15:09:57.937848 | controller | =============================================================================== 2026-02-23 15:09:57.937853 | controller | config_drive : Install required RPM packages ---------------------------- 3.95s 2026-02-23 15:09:57.937858 | controller | config_drive : Install required RPM packages ---------------------------- 1.11s 2026-02-23 15:09:57.937863 | controller | Gathering Facts --------------------------------------------------------- 0.74s 2026-02-23 15:09:57.937868 | controller | config_drive : Generate meta-data --------------------------------------- 0.54s 2026-02-23 15:09:57.937873 | controller | config_drive : Ensure needed directories exist -------------------------- 0.42s 2026-02-23 15:09:57.937878 | controller | config_drive : Generate user-data --------------------------------------- 0.35s 2026-02-23 15:09:57.937883 | controller | config_drive : Generate network-data ------------------------------------ 0.34s 2026-02-23 15:09:57.937892 | controller | config_drive : Ensure needed directories exist -------------------------- 0.34s 2026-02-23 15:09:57.937900 | controller | config_drive : Generate meta-data --------------------------------------- 0.32s 2026-02-23 15:09:57.937941 | controller | config_drive : Crate config drive instance directory -------------------- 0.19s 2026-02-23 15:09:57.938043 | controller | config_drive : Generate nocloud iso image ------------------------------- 0.19s 2026-02-23 15:09:57.938157 | controller | config_drive : Crate config drive instance directory -------------------- 0.17s 2026-02-23 15:09:57.938251 | controller | config_drive : Check ISO availability ----------------------------------- 0.16s 2026-02-23 15:09:57.938356 | controller | Run config_drive role again without user-data or network-config (soft-clean scenario) --- 0.03s 2026-02-23 15:09:57.938448 | controller | Include config_drive role with full configuration ----------------------- 0.03s 2026-02-23 15:09:57.938544 | controller | config_drive : Generate network-data ------------------------------------ 0.02s 2026-02-23 15:09:57.938641 | controller | config_drive : Assert we don't try to change an existing ISO ------------ 0.02s 2026-02-23 15:09:57.938754 | controller | config_drive : Generate user-data --------------------------------------- 0.02s 2026-02-23 15:09:57.985723 | controller | CRITICAL Ansible return code was 2, command was: ['ansible-playbook', '--inventory', '/home/zuul/.cache/molecule/config_drive/default/inventory', '--skip-tags', 'molecule-notest,notest', '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/config_drive/molecule/default/converge.yml'] 2026-02-23 15:09:57.986111 | controller | WARNING An error occurred during the test sequence action: 'converge'. Cleaning up. 2026-02-23 15:09:57.995051 | controller | INFO Running default > cleanup 2026-02-23 15:09:57.995463 | controller | WARNING Skipping, cleanup playbook not configured. 2026-02-23 15:09:58.005265 | controller | INFO Running default > destroy 2026-02-23 15:09:58.005606 | controller | WARNING Skipping, instances are delegated. 2026-02-23 15:09:58.005973 | controller | INFO Pruning extra files from scenario ephemeral directory 2026-02-23 15:09:58.007492 | controller | INFO Writing /tmp/report.html report. 2026-02-23 15:09:58.189521 | controller | ERROR 2026-02-23 15:09:58.189647 | controller | { 2026-02-23 15:09:58.189681 | controller | "delta": "0:01:28.183108", 2026-02-23 15:09:58.189702 | controller | "end": "2026-02-23 15:09:58.055980", 2026-02-23 15:09:58.189720 | controller | "msg": "non-zero return code", 2026-02-23 15:09:58.189735 | controller | "rc": 1, 2026-02-23 15:09:58.189749 | controller | "start": "2026-02-23 15:08:29.872872" 2026-02-23 15:09:58.189764 | controller | } failure 2026-02-23 15:09:58.194420 | 2026-02-23 15:09:58.194472 | PLAY RECAP 2026-02-23 15:09:58.194517 | controller | ok: 3 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2026-02-23 15:09:58.194540 | 2026-02-23 15:09:58.283039 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2026-02-23 15:09:58.283889 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-02-23 15:09:58.799671 | 2026-02-23 15:09:58.799908 | PLAY [Run ci/playbooks/collect-logs.yml] 2026-02-23 15:09:58.823112 | 2026-02-23 15:09:58.823194 | TASK [Filter out host if needed] 2026-02-23 15:09:58.831985 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2026-02-23 15:09:58.836079 | 2026-02-23 15:09:58.836146 | TASK [Ensure file is present] 2026-02-23 15:09:59.150775 | controller | ok 2026-02-23 15:09:59.157967 | 2026-02-23 15:09:59.158041 | TASK [Manage molecule report file] 2026-02-23 15:09:59.683374 | controller | changed 2026-02-23 15:09:59.689786 | 2026-02-23 15:09:59.689859 | TASK [Check if we get ci-framework-data basedir] 2026-02-23 15:09:59.884820 | controller | ok 2026-02-23 15:09:59.890197 | 2026-02-23 15:09:59.890271 | TASK [Create ci-framework-data log directory for zuul] 2026-02-23 15:10:00.207504 | controller | changed 2026-02-23 15:10:00.213308 | 2026-02-23 15:10:00.213390 | TASK [Copy ci-framework interesting files] 2026-02-23 15:10:00.407169 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2026-02-23 15:10:00.742909 | controller | changed 2026-02-23 15:10:00.747831 | 2026-02-23 15:10:00.747899 | TASK [Get SELinux listing] 2026-02-23 15:10:01.274191 | controller | changed 2026-02-23 15:10:01.279739 | 2026-02-23 15:10:01.279804 | TASK [Generate log index] 2026-02-23 15:10:01.900766 | controller | changed 2026-02-23 15:10:01.905358 | 2026-02-23 15:10:01.905429 | TASK [Get some env related data] 2026-02-23 15:10:02.425451 | controller | /home/zuul/.local/bin/ansible 2026-02-23 15:10:02.950157 | controller | changed 2026-02-23 15:10:02.955253 | 2026-02-23 15:10:02.955338 | TASK [Generate list of logs to collect in home directory] 2026-02-23 15:10:03.263521 | controller | ok: All paths examined 2026-02-23 15:10:03.268993 | 2026-02-23 15:10:03.269065 | LOOP [Copy logs from home directory] 2026-02-23 15:10:03.588575 | controller | changed: 2026-02-23 15:10:03.588760 | controller | { 2026-02-23 15:10:03.588789 | controller | "atime": 1771859291.8598266, 2026-02-23 15:10:03.588810 | controller | "ctime": 1771859307.7419522, 2026-02-23 15:10:03.588827 | controller | "dev": 64513, 2026-02-23 15:10:03.588842 | controller | "gid": 1000, 2026-02-23 15:10:03.588857 | controller | "gr_name": "zuul", 2026-02-23 15:10:03.588873 | controller | "inode": 760168, 2026-02-23 15:10:03.588887 | controller | "isblk": false, 2026-02-23 15:10:03.588901 | controller | "ischr": false, 2026-02-23 15:10:03.588915 | controller | "isdir": false, 2026-02-23 15:10:03.588928 | controller | "isfifo": false, 2026-02-23 15:10:03.588953 | controller | "isgid": false, 2026-02-23 15:10:03.588970 | controller | "islnk": false, 2026-02-23 15:10:03.588985 | controller | "isreg": true, 2026-02-23 15:10:03.588999 | controller | "issock": false, 2026-02-23 15:10:03.589013 | controller | "isuid": false, 2026-02-23 15:10:03.589026 | controller | "mode": "0644", 2026-02-23 15:10:03.589040 | controller | "mtime": 1771859307.7419522, 2026-02-23 15:10:03.589053 | controller | "nlink": 1, 2026-02-23 15:10:03.589066 | controller | "path": "/home/zuul/ansible.log", 2026-02-23 15:10:03.589081 | controller | "pw_name": "zuul", 2026-02-23 15:10:03.589095 | controller | "rgrp": true, 2026-02-23 15:10:03.589108 | controller | "roth": true, 2026-02-23 15:10:03.589122 | controller | "rusr": true, 2026-02-23 15:10:03.589135 | controller | "size": 6749, 2026-02-23 15:10:03.589150 | controller | "uid": 1000, 2026-02-23 15:10:03.589165 | controller | "wgrp": false, 2026-02-23 15:10:03.589180 | controller | "woth": false, 2026-02-23 15:10:03.589197 | controller | "wusr": true, 2026-02-23 15:10:03.589212 | controller | "xgrp": false, 2026-02-23 15:10:03.589227 | controller | "xoth": false, 2026-02-23 15:10:03.589241 | controller | "xusr": false 2026-02-23 15:10:03.589254 | controller | } 2026-02-23 15:10:03.603045 | 2026-02-23 15:10:03.603181 | TASK [Copy crio stats log file] 2026-02-23 15:10:03.618484 | controller | skipping: Conditional result was False 2026-02-23 15:10:03.624535 | 2026-02-23 15:10:03.624602 | TASK [Get SELinux related data] 2026-02-23 15:10:03.834453 | controller | 2026-02-23 15:10:04.153393 | controller | ERROR 2026-02-23 15:10:04.153689 | controller | { 2026-02-23 15:10:04.153730 | controller | "delta": "0:00:00.009496", 2026-02-23 15:10:04.153755 | controller | "end": "2026-02-23 15:10:03.835295", 2026-02-23 15:10:04.153776 | controller | "msg": "non-zero return code", 2026-02-23 15:10:04.153795 | controller | "rc": 1, 2026-02-23 15:10:04.153825 | controller | "start": "2026-02-23 15:10:03.825799" 2026-02-23 15:10:04.153845 | controller | } 2026-02-23 15:10:04.153872 | controller | ERROR: Ignoring Errors 2026-02-23 15:10:04.160160 | 2026-02-23 15:10:04.160233 | TASK [Create system configuration directory] 2026-02-23 15:10:04.343749 | controller | changed 2026-02-23 15:10:04.348742 | 2026-02-23 15:10:04.348814 | TASK [Get some of the system configurations] 2026-02-23 15:10:04.877470 | controller | changed 2026-02-23 15:10:04.885284 | 2026-02-23 15:10:04.885523 | TASK [Copy generated documentation if available] 2026-02-23 15:10:04.912314 | controller | skipping: Conditional result was False 2026-02-23 15:10:04.918686 | 2026-02-23 15:10:04.918764 | TASK [Copy generated AsciiDoc documentation if available] 2026-02-23 15:10:04.944809 | controller | skipping: Conditional result was False 2026-02-23 15:10:04.952285 | 2026-02-23 15:10:04.952530 | TASK [Compress logs bigger than 2MB] 2026-02-23 15:10:05.481540 | controller | changed 2026-02-23 15:10:05.488613 | 2026-02-23 15:10:05.488684 | TASK [Copy files from workspace on node] 2026-02-23 15:10:05.509068 | controller | ok 2026-02-23 15:10:05.532414 | 2026-02-23 15:10:05.532486 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-23 15:10:05.557207 | controller | skipping: Conditional result was False 2026-02-23 15:10:05.562989 | 2026-02-23 15:10:05.563060 | TASK [fetch-output : Set log path for single node] 2026-02-23 15:10:05.593756 | controller | ok 2026-02-23 15:10:05.598531 | 2026-02-23 15:10:05.598596 | LOOP [fetch-output : Ensure local output dirs] 2026-02-23 15:10:05.805134 | controller -> localhost | ok: "/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/logs" 2026-02-23 15:10:05.805680 | controller -> localhost | changed: All items complete 2026-02-23 15:10:05.805722 | 2026-02-23 15:10:06.000224 | controller -> localhost | changed: "/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/artifacts" 2026-02-23 15:10:06.214953 | controller -> localhost | changed: "/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/docs" 2026-02-23 15:10:06.227793 | 2026-02-23 15:10:06.227957 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-23 15:10:06.797607 | controller | changed: 2026-02-23 15:10:06.797836 | controller | .d..t...... ./ 2026-02-23 15:10:06.797867 | controller | >f+++++++++ README.html 2026-02-23 15:10:06.797890 | controller | >f+++++++++ ansible-execution.log 2026-02-23 15:10:06.797912 | controller | >f+++++++++ ansible.log 2026-02-23 15:10:06.797931 | controller | >f+++++++++ dmesg.log 2026-02-23 15:10:06.797981 | controller | >f+++++++++ installed-pkgs.log 2026-02-23 15:10:06.798005 | controller | >f+++++++++ python.log 2026-02-23 15:10:06.798027 | controller | >f+++++++++ registries.conf 2026-02-23 15:10:06.798044 | controller | >f+++++++++ report.html 2026-02-23 15:10:06.798063 | controller | >f+++++++++ selinux-denials.log 2026-02-23 15:10:06.798080 | controller | >f+++++++++ selinux-listing.log 2026-02-23 15:10:06.798097 | controller | cd+++++++++ ci-framework-data/ 2026-02-23 15:10:06.798114 | controller | cd+++++++++ ci-framework-data/artifacts/ 2026-02-23 15:10:06.798131 | controller | >f+++++++++ ci-framework-data/artifacts/ci_script_000_generate_nocloud_iso.sh 2026-02-23 15:10:06.798147 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2026-02-23 15:10:06.798164 | controller | cd+++++++++ ci-framework-data/artifacts/cifmw_config_drive/ 2026-02-23 15:10:06.798180 | controller | >f+++++++++ ci-framework-data/artifacts/cifmw_config_drive/de2f369a-1886-4a90-8e50-e419289e6850.iso 2026-02-23 15:10:06.798196 | controller | cd+++++++++ ci-framework-data/artifacts/cifmw_config_drive/de2f369a-1886-4a90-8e50-e419289e6850/ 2026-02-23 15:10:06.798212 | controller | >f+++++++++ ci-framework-data/artifacts/cifmw_config_drive/de2f369a-1886-4a90-8e50-e419289e6850/meta-data 2026-02-23 15:10:06.798227 | controller | >f+++++++++ ci-framework-data/artifacts/cifmw_config_drive/de2f369a-1886-4a90-8e50-e419289e6850/network-config 2026-02-23 15:10:06.798250 | controller | >f+++++++++ ci-framework-data/artifacts/cifmw_config_drive/de2f369a-1886-4a90-8e50-e419289e6850/user-data 2026-02-23 15:10:06.798267 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2026-02-23 15:10:06.798285 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2026-02-23 15:10:06.798324 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/ 2026-02-23 15:10:06.798346 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5 2026-02-23 15:10:06.798364 | controller | cd+++++++++ ci-framework-data/logs/ 2026-02-23 15:10:06.798381 | controller | >f+++++++++ ci-framework-data/logs/ci_script_000_generate_nocloud_iso.log 2026-02-23 15:10:06.798398 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2026-02-23 15:10:06.798414 | controller | cd+++++++++ registries.conf.d/ 2026-02-23 15:10:06.798431 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2026-02-23 15:10:06.798447 | controller | cd+++++++++ system-config/ 2026-02-23 15:10:06.798464 | controller | cd+++++++++ system-config/libvirt/ 2026-02-23 15:10:06.798481 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2026-02-23 15:10:06.798497 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2026-02-23 15:10:07.155794 | controller | changed: .d..t...... ./ 2026-02-23 15:10:07.525502 | controller | changed: .d..t...... ./ 2026-02-23 15:10:07.547651 | 2026-02-23 15:10:07.547795 | TASK [Return artifact to Zuul] 2026-02-23 15:10:07.578411 | controller | ok 2026-02-23 15:10:07.597836 | 2026-02-23 15:10:07.597893 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2026-02-23 15:10:07.598019 | 2026-02-23 15:10:07.598048 | PLAY RECAP 2026-02-23 15:10:07.598092 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2026-02-23 15:10:07.598113 | 2026-02-23 15:10:07.690151 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-02-23 15:10:07.691953 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-02-23 15:10:08.246256 | 2026-02-23 15:10:08.246402 | PLAY [all] 2026-02-23 15:10:08.265161 | 2026-02-23 15:10:08.265240 | TASK [include_role : fetch-output] 2026-02-23 15:10:08.295496 | controller | ok 2026-02-23 15:10:08.312333 | 2026-02-23 15:10:08.312417 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-23 15:10:08.358037 | controller | skipping: Conditional result was False 2026-02-23 15:10:08.363772 | 2026-02-23 15:10:08.363849 | TASK [fetch-output : Set log path for single node] 2026-02-23 15:10:08.392375 | controller | ok 2026-02-23 15:10:08.397473 | 2026-02-23 15:10:08.397544 | LOOP [fetch-output : Ensure local output dirs] 2026-02-23 15:10:08.749319 | controller -> localhost | ok: "/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/logs" 2026-02-23 15:10:08.940736 | controller -> localhost | ok: "/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/artifacts" 2026-02-23 15:10:09.129551 | controller -> localhost | ok: "/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/docs" 2026-02-23 15:10:09.139059 | 2026-02-23 15:10:09.139218 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-23 15:10:09.668261 | controller | ok 2026-02-23 15:10:09.668524 | controller | ok: All items complete 2026-02-23 15:10:09.668559 | 2026-02-23 15:10:10.037439 | controller | ok 2026-02-23 15:10:10.423056 | controller | ok 2026-02-23 15:10:10.445281 | 2026-02-23 15:10:10.445518 | TASK [include_role : fetch-output-openshift] 2026-02-23 15:10:10.472451 | controller | skipping: Conditional result was False 2026-02-23 15:10:10.479067 | 2026-02-23 15:10:10.479145 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-23 15:10:10.859647 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008894 2026-02-23 15:10:11.065014 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007963 2026-02-23 15:10:11.094107 | 2026-02-23 15:10:11.094185 | PLAY [all] 2026-02-23 15:10:11.108047 | 2026-02-23 15:10:11.108119 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-23 15:10:11.516102 | controller | changed 2026-02-23 15:10:11.537730 | 2026-02-23 15:10:11.537788 | PLAY RECAP 2026-02-23 15:10:11.537834 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-02-23 15:10:11.537856 | 2026-02-23 15:10:11.631505 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-02-23 15:10:11.632404 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-02-23 15:10:12.196782 | 2026-02-23 15:10:12.196927 | PLAY [localhost] 2026-02-23 15:10:12.214505 | 2026-02-23 15:10:12.214581 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-23 15:10:12.550400 | localhost | changed 2026-02-23 15:10:12.554975 | 2026-02-23 15:10:12.555056 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-23 15:10:12.584395 | localhost | ok 2026-02-23 15:10:12.591785 | 2026-02-23 15:10:12.591848 | TASK [add-fileserver : Create SSH private key tempfile] 2026-02-23 15:10:12.914751 | localhost | changed 2026-02-23 15:10:12.920720 | 2026-02-23 15:10:12.920794 | TASK [add-fileserver : Create SSH private key from secret] 2026-02-23 15:10:13.499471 | localhost | changed 2026-02-23 15:10:13.504558 | 2026-02-23 15:10:13.504629 | TASK [add-fileserver : Add fileserver ssh key] 2026-02-23 15:10:13.859292 | localhost | Identity added: /var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/tmp/ansible.inr96dvy (/var/lib/zuul/builds/02fd759dc8bc4d9a8a433c8eb268fbc4/work/tmp/ansible.inr96dvy) 2026-02-23 15:10:13.859636 | localhost | ok: Runtime: 0:00:00.008168 2026-02-23 15:10:13.864069 | 2026-02-23 15:10:13.864136 | TASK [add-fileserver : Remove SSH private key from disk] 2026-02-23 15:10:14.087741 | localhost | ok: Runtime: 0:00:00.004835 2026-02-23 15:10:14.092758 | 2026-02-23 15:10:14.092832 | TASK [add-fileserver : Add fileserver to inventory] 2026-02-23 15:10:14.143690 | localhost | changed 2026-02-23 15:10:14.147787 | 2026-02-23 15:10:14.147850 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-02-23 15:10:14.470206 | localhost | changed 2026-02-23 15:10:14.490130 | 2026-02-23 15:10:14.490190 | PLAY [localhost] 2026-02-23 15:10:14.501537 | 2026-02-23 15:10:14.501600 | TASK [Generate bulk log download script] 2026-02-23 15:10:14.522155 | localhost | ok 2026-02-23 15:10:14.534092 | 2026-02-23 15:10:14.534161 | TASK [local-log-download : Check API endpoint is defined] 2026-02-23 15:10:14.562713 | localhost | ok: All assertions passed 2026-02-23 15:10:14.567102 | 2026-02-23 15:10:14.567166 | TASK [local-log-download : Create download script] 2026-02-23 15:10:14.936487 | localhost -> localhost | changed 2026-02-23 15:10:14.946325 | 2026-02-23 15:10:14.946406 | TASK [Register quick-download link] 2026-02-23 15:10:14.964630 | localhost | ok 2026-02-23 15:10:15.004277 | 2026-02-23 15:10:15.004375 | PLAY [logserver.rdoproject.org] 2026-02-23 15:10:15.014021 | 2026-02-23 15:10:15.014084 | TASK [Set zuul-log-path fact] 2026-02-23 15:10:15.031058 | logserver.rdoproject.org | ok 2026-02-23 15:10:15.040783 | 2026-02-23 15:10:15.040857 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 15:10:15.066862 | logserver.rdoproject.org | ok 2026-02-23 15:10:15.072123 | 2026-02-23 15:10:15.072199 | TASK [upload-logs : Create log directories] 2026-02-23 15:10:16.860578 | logserver.rdoproject.org | changed 2026-02-23 15:10:16.869153 | 2026-02-23 15:10:16.869250 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-23 15:10:17.137015 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.029335 2026-02-23 15:10:17.143181 | 2026-02-23 15:10:17.143250 | TASK [upload-logs : Upload logs to log server] 2026-02-23 15:10:18.662327 | logserver.rdoproject.org | Output suppressed because no_log was given 2026-02-23 15:10:18.665994 | 2026-02-23 15:10:18.666057 | LOOP [upload-logs : Compress console log and json output] 2026-02-23 15:10:18.706377 | logserver.rdoproject.org | skipping: Conditional result was False 2026-02-23 15:10:18.715395 | logserver.rdoproject.org | skipping: Conditional result was False 2026-02-23 15:10:18.723470 | 2026-02-23 15:10:18.723548 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-23 15:10:18.764007 | logserver.rdoproject.org | skipping: Conditional result was False 2026-02-23 15:10:18.764234 | 2026-02-23 15:10:18.766768 | logserver.rdoproject.org | skipping: Conditional result was False 2026-02-23 15:10:18.771404 | 2026-02-23 15:10:18.771468 | LOOP [upload-logs : Upload console log and json output]