2026-03-16 16:38:33.064119 | Job console starting... 2026-03-16 16:38:33.313217 | Updating repositories 2026-03-16 16:38:34.127968 | Preparing job workspace 2026-03-16 16:38:49.535963 | Running Ansible setup... 2026-03-16 16:38:56.474721 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-16 16:38:57.348824 | 2026-03-16 16:38:57.348921 | PLAY [localhost] 2026-03-16 16:38:57.357524 | 2026-03-16 16:38:57.357596 | TASK [Gathering Facts] 2026-03-16 16:38:58.734394 | localhost | ok 2026-03-16 16:38:58.753454 | 2026-03-16 16:38:58.753555 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 16:38:59.407209 | localhost -> localhost | changed 2026-03-16 16:38:59.412748 | 2026-03-16 16:38:59.412830 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 16:39:00.620003 | localhost -> localhost | changed 2026-03-16 16:39:00.628396 | 2026-03-16 16:39:00.628482 | TASK [Setup log path fact] 2026-03-16 16:39:00.652570 | localhost | ok 2026-03-16 16:39:00.687158 | 2026-03-16 16:39:00.687259 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:39:00.784471 | localhost | ok 2026-03-16 16:39:00.804060 | 2026-03-16 16:39:00.804152 | TASK [emit-job-header : Print job information] 2026-03-16 16:39:00.874783 | # Job Information 2026-03-16 16:39:00.874918 | Ansible Version: 2.15.12 2026-03-16 16:39:00.874949 | Job: cifmw-molecule-os_net_setup 2026-03-16 16:39:00.874974 | Pipeline: github-check 2026-03-16 16:39:00.874995 | Executor: ibm-bm4-ze.softwarefactory-project.io 2026-03-16 16:39:00.875015 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3770 2026-03-16 16:39:00.875052 | Log URL (when completed): https://logserver.rdoproject.org/700/rdoproject.org/700739a52b064fdd83b852106ba4087c/ 2026-03-16 16:39:00.875075 | Event ID: 072a8580-2155-11f1-9026-7307b7bf6b98 2026-03-16 16:39:00.879125 | 2026-03-16 16:39:00.879195 | LOOP [emit-job-header : Print node information] 2026-03-16 16:39:01.257352 | localhost | ok: 2026-03-16 16:39:01.258832 | localhost | # Node Information 2026-03-16 16:39:01.259228 | localhost | Inventory Hostname: controller 2026-03-16 16:39:01.259266 | localhost | Hostname: np0005648848 2026-03-16 16:39:01.259311 | localhost | Username: zuul 2026-03-16 16:39:01.259770 | localhost | Distro: CentOS 9 2026-03-16 16:39:01.259799 | localhost | Provider: ibm-bm4-nodepool 2026-03-16 16:39:01.259821 | localhost | Region: regionOne 2026-03-16 16:39:01.259841 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2026-03-16 16:39:01.260345 | localhost | Product Name: OpenStack Compute 2026-03-16 16:39:01.260379 | localhost | Interface IP: 192.168.26.88 2026-03-16 16:39:01.326355 | 2026-03-16 16:39:01.326437 | PLAY [all] 2026-03-16 16:39:01.349391 | 2026-03-16 16:39:01.349460 | TASK [Gather network facts] 2026-03-16 16:39:01.771677 | controller | ok 2026-03-16 16:39:01.836221 | 2026-03-16 16:39:01.838758 | TASK [include_role : start-zuul-console] 2026-03-16 16:39:01.905404 | controller | ok 2026-03-16 16:39:01.926256 | 2026-03-16 16:39:01.926402 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 16:39:02.467421 | controller | ok 2026-03-16 16:39:02.483325 | 2026-03-16 16:39:02.483427 | TASK [include_role : add-build-sshkey] 2026-03-16 16:39:02.531117 | controller | ok 2026-03-16 16:39:02.595675 | 2026-03-16 16:39:02.595755 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:39:03.073925 | controller -> localhost | ok 2026-03-16 16:39:03.079736 | 2026-03-16 16:39:03.079804 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:39:03.132566 | controller | ok 2026-03-16 16:39:03.145759 | controller | included: /var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:39:03.156965 | 2026-03-16 16:39:03.157056 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:39:03.798587 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 16:39:03.798785 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/700739a52b064fdd83b852106ba4087c_id_rsa. 2026-03-16 16:39:03.798822 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/700739a52b064fdd83b852106ba4087c_id_rsa.pub. 2026-03-16 16:39:03.798847 | controller -> localhost | The key fingerprint is: 2026-03-16 16:39:03.798869 | controller -> localhost | SHA256:vkfwT2+Wz/UBbOGFOmcRAiB6vUGOMPkuR6HgAWe5tso zuul-build-sshkey 2026-03-16 16:39:03.798890 | controller -> localhost | The key's randomart image is: 2026-03-16 16:39:03.798910 | controller -> localhost | +---[RSA 3072]----+ 2026-03-16 16:39:03.798930 | controller -> localhost | |o o+.. o.... . | 2026-03-16 16:39:03.798951 | controller -> localhost | | =..+.* . o | 2026-03-16 16:39:03.798970 | controller -> localhost | |. oooo.+ + . | 2026-03-16 16:39:03.798989 | controller -> localhost | | .o..o + + + | 2026-03-16 16:39:03.799007 | controller -> localhost | | . .o .So o B | 2026-03-16 16:39:03.799025 | controller -> localhost | | .. o . o * . | 2026-03-16 16:39:03.799058 | controller -> localhost | |.. o .. o . o.| 2026-03-16 16:39:03.799081 | controller -> localhost | |.E .. . =.+| 2026-03-16 16:39:03.799100 | controller -> localhost | | .. o .+| 2026-03-16 16:39:03.799118 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:39:03.799160 | controller -> localhost | ok: Runtime: 0:00:00.082022 2026-03-16 16:39:03.804589 | 2026-03-16 16:39:03.804657 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:39:03.832658 | controller | ok 2026-03-16 16:39:03.841978 | controller | included: /var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:39:03.849791 | 2026-03-16 16:39:03.849858 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:39:03.863947 | controller | skipping: Conditional result was False 2026-03-16 16:39:03.869791 | 2026-03-16 16:39:03.869866 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:39:04.256509 | controller | changed 2026-03-16 16:39:04.262114 | 2026-03-16 16:39:04.262189 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:39:04.473388 | controller | ok 2026-03-16 16:39:04.479663 | 2026-03-16 16:39:04.479741 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:39:05.169046 | controller | changed 2026-03-16 16:39:05.174408 | 2026-03-16 16:39:05.174491 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:39:05.882119 | controller | changed 2026-03-16 16:39:05.886923 | 2026-03-16 16:39:05.886990 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:39:05.920793 | controller | skipping: Conditional result was False 2026-03-16 16:39:05.925999 | 2026-03-16 16:39:05.926082 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:39:06.607008 | controller -> localhost | changed 2026-03-16 16:39:06.622283 | 2026-03-16 16:39:06.622388 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:39:07.027198 | controller -> localhost | Identity added: /var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/700739a52b064fdd83b852106ba4087c_id_rsa (zuul-build-sshkey) 2026-03-16 16:39:07.027394 | controller -> localhost | ok: Runtime: 0:00:00.007681 2026-03-16 16:39:07.033894 | 2026-03-16 16:39:07.033966 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:39:07.577430 | controller | ok 2026-03-16 16:39:07.581919 | 2026-03-16 16:39:07.581985 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:39:07.605925 | controller | skipping: Conditional result was False 2026-03-16 16:39:07.614665 | 2026-03-16 16:39:07.614734 | TASK [include_role : validate-host] 2026-03-16 16:39:07.645660 | controller | ok 2026-03-16 16:39:07.684581 | 2026-03-16 16:39:07.684674 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-16 16:39:07.712527 | controller | ok 2026-03-16 16:39:07.718342 | 2026-03-16 16:39:07.718417 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-16 16:39:08.018075 | controller -> localhost | ok 2026-03-16 16:39:08.028287 | 2026-03-16 16:39:08.028418 | TASK [validate-host : Collect information about the host] 2026-03-16 16:39:08.658354 | controller | ok 2026-03-16 16:39:08.667393 | 2026-03-16 16:39:08.667473 | TASK [validate-host : Sanitize hostname] 2026-03-16 16:39:08.722431 | controller | ok 2026-03-16 16:39:08.730894 | 2026-03-16 16:39:08.730972 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-16 16:39:09.238598 | controller -> localhost | changed 2026-03-16 16:39:09.251585 | 2026-03-16 16:39:09.251674 | TASK [validate-host : Collect information about zuul worker] 2026-03-16 16:39:09.698669 | controller | ok 2026-03-16 16:39:09.703913 | 2026-03-16 16:39:09.704370 | TASK [validate-host : Write out all zuul information for each host] 2026-03-16 16:39:10.159897 | controller -> localhost | changed 2026-03-16 16:39:10.169773 | 2026-03-16 16:39:10.169836 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 16:39:10.196792 | controller | skipping: Conditional result was False 2026-03-16 16:39:10.201673 | 2026-03-16 16:39:10.201801 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 16:39:10.245579 | controller | skipping: Conditional result was False 2026-03-16 16:39:10.250943 | 2026-03-16 16:39:10.251009 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 16:39:10.473938 | controller | ok: "logs" 2026-03-16 16:39:10.474159 | controller | ok: All items complete 2026-03-16 16:39:10.474190 | 2026-03-16 16:39:10.643370 | controller | ok: "artifacts" 2026-03-16 16:39:10.817549 | controller | ok: "docs" 2026-03-16 16:39:10.827962 | 2026-03-16 16:39:10.828049 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 16:39:11.047696 | controller | changed: "logs" 2026-03-16 16:39:11.220287 | controller | changed: "artifacts" 2026-03-16 16:39:11.385839 | controller | changed: "docs" 2026-03-16 16:39:11.419657 | 2026-03-16 16:39:11.419738 | PLAY RECAP 2026-03-16 16:39:11.419785 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 16:39:11.419814 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:39:11.419833 | 2026-03-16 16:39:11.576672 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-16 16:39:11.577381 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-03-16 16:39:12.165427 | 2026-03-16 16:39:12.165532 | PLAY [all] 2026-03-16 16:39:12.185066 | 2026-03-16 16:39:12.185145 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-16 16:39:12.244126 | controller | ok 2026-03-16 16:39:12.249566 | 2026-03-16 16:39:12.249667 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-16 16:39:12.609179 | controller | changed 2026-03-16 16:39:12.614735 | 2026-03-16 16:39:12.614808 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-16 16:39:13.692251 | controller | changed 2026-03-16 16:39:13.712289 | 2026-03-16 16:39:13.712456 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2026-03-16 16:39:14.092989 | controller | changed: 2026-03-16 16:39:14.093167 | controller | { 2026-03-16 16:39:14.093200 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2026-03-16 16:39:14.093230 | controller | } 2026-03-16 16:39:14.300895 | controller | changed: 2026-03-16 16:39:14.300976 | controller | { 2026-03-16 16:39:14.301008 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2026-03-16 16:39:14.301048 | controller | } 2026-03-16 16:39:14.512668 | controller | changed: 2026-03-16 16:39:14.512855 | controller | { 2026-03-16 16:39:14.512895 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2026-03-16 16:39:14.512919 | controller | } 2026-03-16 16:39:14.727141 | controller | changed: 2026-03-16 16:39:14.727241 | controller | { 2026-03-16 16:39:14.727272 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2026-03-16 16:39:14.727317 | controller | } 2026-03-16 16:39:14.935183 | controller | changed: 2026-03-16 16:39:14.935266 | controller | { 2026-03-16 16:39:14.935322 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2026-03-16 16:39:14.935353 | controller | } 2026-03-16 16:39:15.161358 | controller | changed: 2026-03-16 16:39:15.161438 | controller | { 2026-03-16 16:39:15.161466 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2026-03-16 16:39:15.161488 | controller | } 2026-03-16 16:39:15.400488 | controller | changed: 2026-03-16 16:39:15.400566 | controller | { 2026-03-16 16:39:15.400594 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2026-03-16 16:39:15.400617 | controller | } 2026-03-16 16:39:15.608497 | controller | changed: 2026-03-16 16:39:15.608585 | controller | { 2026-03-16 16:39:15.608616 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2026-03-16 16:39:15.608639 | controller | } 2026-03-16 16:39:15.829250 | controller | changed: 2026-03-16 16:39:15.829363 | controller | { 2026-03-16 16:39:15.829395 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2026-03-16 16:39:15.829417 | controller | } 2026-03-16 16:39:16.030247 | controller | changed: 2026-03-16 16:39:16.030444 | controller | { 2026-03-16 16:39:16.030484 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2026-03-16 16:39:16.030507 | controller | } 2026-03-16 16:39:16.260611 | controller | changed: 2026-03-16 16:39:16.260694 | controller | { 2026-03-16 16:39:16.260724 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2026-03-16 16:39:16.260746 | controller | } 2026-03-16 16:39:16.492493 | controller | changed: 2026-03-16 16:39:16.492576 | controller | { 2026-03-16 16:39:16.492605 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2026-03-16 16:39:16.492627 | controller | } 2026-03-16 16:39:16.709018 | controller | changed: 2026-03-16 16:39:16.709118 | controller | { 2026-03-16 16:39:16.709148 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com" 2026-03-16 16:39:16.709170 | controller | } 2026-03-16 16:39:16.923066 | controller | changed: 2026-03-16 16:39:16.923152 | controller | { 2026-03-16 16:39:16.923181 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2026-03-16 16:39:16.923202 | controller | } 2026-03-16 16:39:17.162575 | controller | changed: 2026-03-16 16:39:17.162652 | controller | { 2026-03-16 16:39:17.162680 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2026-03-16 16:39:17.162703 | controller | } 2026-03-16 16:39:17.365675 | controller | changed: 2026-03-16 16:39:17.365757 | controller | { 2026-03-16 16:39:17.365786 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2026-03-16 16:39:17.365807 | controller | } 2026-03-16 16:39:17.581127 | controller | changed: 2026-03-16 16:39:17.581367 | controller | { 2026-03-16 16:39:17.581410 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2026-03-16 16:39:17.581435 | controller | } 2026-03-16 16:39:17.805373 | controller | changed: 2026-03-16 16:39:17.805474 | controller | { 2026-03-16 16:39:17.805505 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2026-03-16 16:39:17.805535 | controller | } 2026-03-16 16:39:18.041768 | controller | changed: 2026-03-16 16:39:18.041851 | controller | { 2026-03-16 16:39:18.041877 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2026-03-16 16:39:18.041898 | controller | } 2026-03-16 16:39:18.273912 | controller | changed: 2026-03-16 16:39:18.273994 | controller | { 2026-03-16 16:39:18.274024 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2026-03-16 16:39:18.274069 | controller | } 2026-03-16 16:39:18.500465 | controller | changed: 2026-03-16 16:39:18.500564 | controller | { 2026-03-16 16:39:18.500591 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2026-03-16 16:39:18.500613 | controller | } 2026-03-16 16:39:18.739513 | controller | changed: 2026-03-16 16:39:18.739595 | controller | { 2026-03-16 16:39:18.739623 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2026-03-16 16:39:18.739644 | controller | } 2026-03-16 16:39:18.988734 | controller | changed: 2026-03-16 16:39:18.988828 | controller | { 2026-03-16 16:39:18.988855 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2026-03-16 16:39:18.988878 | controller | } 2026-03-16 16:39:19.205289 | controller | changed: 2026-03-16 16:39:19.205972 | controller | { 2026-03-16 16:39:19.206023 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2026-03-16 16:39:19.206070 | controller | } 2026-03-16 16:39:19.428548 | controller | changed: 2026-03-16 16:39:19.428640 | controller | { 2026-03-16 16:39:19.428667 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2026-03-16 16:39:19.428689 | controller | } 2026-03-16 16:39:19.642709 | controller | changed: 2026-03-16 16:39:19.642877 | controller | { 2026-03-16 16:39:19.642918 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2026-03-16 16:39:19.642943 | controller | } 2026-03-16 16:39:19.669887 | 2026-03-16 16:39:19.669995 | TASK [Set timezone to UTC] 2026-03-16 16:39:20.117640 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2026-03-16 16:39:20.123975 | 2026-03-16 16:39:20.124070 | TASK [Create nodepool directory] 2026-03-16 16:39:20.357644 | controller | changed 2026-03-16 16:39:20.365973 | 2026-03-16 16:39:20.366071 | TASK [Create nodepool sub_nodes file] 2026-03-16 16:39:20.934869 | controller | changed 2026-03-16 16:39:20.939746 | 2026-03-16 16:39:20.939828 | TASK [Create nodepool sub_nodes_private file] 2026-03-16 16:39:21.496628 | controller | changed 2026-03-16 16:39:21.501759 | 2026-03-16 16:39:21.501827 | LOOP [Populate nodepool sub_nodes file] 2026-03-16 16:39:21.533997 | 2026-03-16 16:39:21.534131 | LOOP [Populate nodepool sub_nodes_private file] 2026-03-16 16:39:21.568998 | 2026-03-16 16:39:21.569140 | TASK [Create nodepool primary file] 2026-03-16 16:39:21.595888 | controller | skipping: Conditional result was False 2026-03-16 16:39:21.601639 | 2026-03-16 16:39:21.601732 | TASK [Create nodepool node_private for this node] 2026-03-16 16:39:22.193407 | controller | changed 2026-03-16 16:39:22.208714 | 2026-03-16 16:39:22.208799 | LOOP [Copy ssh keys to nodepool directory] 2026-03-16 16:39:22.619639 | controller | ok: Item: id_rsa Runtime: 0:00:00.005313 2026-03-16 16:39:22.619806 | 2026-03-16 16:39:22.806416 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004954 2026-03-16 16:39:22.821554 | 2026-03-16 16:39:22.821791 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2026-03-16 16:39:23.432328 | controller | changed 2026-03-16 16:39:23.438808 | 2026-03-16 16:39:23.438890 | TASK [Validate sudoers config after edits] 2026-03-16 16:39:23.782781 | controller | /etc/sudoers: parsed OK 2026-03-16 16:39:23.782869 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2026-03-16 16:39:23.782880 | controller | /etc/sudoers.d/zuul: parsed OK 2026-03-16 16:39:23.782905 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2026-03-16 16:39:24.034564 | controller | ok: Runtime: 0:00:00.005778 2026-03-16 16:39:24.041772 | 2026-03-16 16:39:24.041857 | TASK [Show the environment passed in to job shell scripts] 2026-03-16 16:39:24.272103 | controller | SHELL=/bin/bash 2026-03-16 16:39:24.272156 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2026-03-16 16:39:24.272166 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2026-03-16 16:39:24.272172 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/70/3770/235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:39:24.272178 | controller | PWD=/home/zuul 2026-03-16 16:39:24.272184 | controller | ZUUL_PIPELINE=github-check 2026-03-16 16:39:24.272233 | controller | LOGNAME=zuul 2026-03-16 16:39:24.272242 | controller | XDG_SESSION_TYPE=tty 2026-03-16 16:39:24.272248 | controller | _=/usr/bin/env 2026-03-16 16:39:24.272254 | controller | MOTD_SHOWN=pam 2026-03-16 16:39:24.272259 | controller | HOME=/home/zuul 2026-03-16 16:39:24.272264 | controller | LANG=en_US.UTF-8 2026-03-16 16:39:24.272270 | controller | SSH_CONNECTION=192.168.26.12 57564 192.168.26.88 22 2026-03-16 16:39:24.272275 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2026-03-16 16:39:24.272284 | controller | ZUUL_CHANGE_IDS=3770,235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:39:24.272290 | controller | WORKSPACE=/home/zuul/workspace 2026-03-16 16:39:24.272296 | controller | XDG_SESSION_CLASS=user 2026-03-16 16:39:24.272301 | controller | SELINUX_ROLE_REQUESTED= 2026-03-16 16:39:24.272307 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2026-03-16 16:39:24.272312 | controller | USER=zuul 2026-03-16 16:39:24.272318 | controller | ZUUL_VOTING=True 2026-03-16 16:39:24.272323 | controller | BUILD_TIMEOUT=1800000 2026-03-16 16:39:24.272328 | controller | SELINUX_USE_CURRENT_RANGE= 2026-03-16 16:39:24.272334 | controller | SHLVL=1 2026-03-16 16:39:24.272339 | controller | ZUUL_PATCHSET=235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:39:24.272345 | controller | XDG_SESSION_ID=1 2026-03-16 16:39:24.272350 | controller | ZUUL_BRANCH=main 2026-03-16 16:39:24.272355 | controller | XDG_RUNTIME_DIR=/run/user/1000 2026-03-16 16:39:24.272361 | controller | SSH_CLIENT=192.168.26.12 57564 22 2026-03-16 16:39:24.272366 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2026-03-16 16:39:24.272372 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2026-03-16 16:39:24.272379 | controller | which_declare=declare -f 2026-03-16 16:39:24.272384 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 16:39:24.272390 | controller | SELINUX_LEVEL_REQUESTED= 2026-03-16 16:39:24.272396 | controller | ZUUL_CHANGE=3770 2026-03-16 16:39:24.272401 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2026-03-16 16:39:24.272407 | controller | ZUUL_UUID=700739a52b064fdd83b852106ba4087c 2026-03-16 16:39:24.272414 | controller | BASH_FUNC_which%%=() { ( alias; 2026-03-16 16:39:24.272420 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2026-03-16 16:39:24.272425 | controller | } 2026-03-16 16:39:24.581414 | controller | ok: Runtime: 0:00:00.005898 2026-03-16 16:39:24.587206 | 2026-03-16 16:39:24.587287 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2026-03-16 16:39:24.611052 | controller | skipping: Conditional result was False 2026-03-16 16:39:24.616871 | 2026-03-16 16:39:24.616939 | TASK [Symlink /home/zuul-worker/workspace] 2026-03-16 16:39:25.143009 | controller | skipping: Conditional result was False 2026-03-16 16:39:25.148757 | 2026-03-16 16:39:25.148841 | TASK [Ensure legacy workspace directory] 2026-03-16 16:39:25.339378 | controller | changed 2026-03-16 16:39:25.380928 | 2026-03-16 16:39:25.381018 | PLAY RECAP 2026-03-16 16:39:25.381083 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 16:39:25.381110 | 2026-03-16 16:39:25.555957 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-03-16 16:39:25.557079 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-03-16 16:39:26.490020 | 2026-03-16 16:39:26.490131 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2026-03-16 16:39:26.532133 | 2026-03-16 16:39:26.532228 | TASK [Create zuul-output directory] 2026-03-16 16:39:27.038095 | controller | changed 2026-03-16 16:39:27.043197 | 2026-03-16 16:39:27.043314 | TASK [Slurp Zuul inventory test] 2026-03-16 16:39:27.915265 | controller -> localhost | ok 2026-03-16 16:39:27.923340 | 2026-03-16 16:39:27.923412 | TASK [Save zuul inventory] 2026-03-16 16:39:29.020882 | controller | changed 2026-03-16 16:39:29.026343 | 2026-03-16 16:39:29.026438 | TASK [Save zuul vars without the change_message] 2026-03-16 16:39:29.725474 | controller | changed 2026-03-16 16:39:29.746473 | 2026-03-16 16:39:29.746563 | PLAY RECAP 2026-03-16 16:39:29.746612 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:39:29.746636 | 2026-03-16 16:39:29.832073 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-03-16 16:39:29.832856 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-03-16 16:39:30.704166 | 2026-03-16 16:39:30.704268 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2026-03-16 16:39:30.763234 | 2026-03-16 16:39:30.765381 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2026-03-16 16:39:30.806662 | controller | ok 2026-03-16 16:39:30.836842 | 2026-03-16 16:39:30.836934 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-16 16:39:30.904669 | controller | skipping: Conditional result was False 2026-03-16 16:39:30.910525 | 2026-03-16 16:39:30.910606 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-16 16:39:31.446078 | controller | ok 2026-03-16 16:39:31.458813 | 2026-03-16 16:39:31.458898 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-16 16:39:32.190092 | controller | ok 2026-03-16 16:39:32.204715 | 2026-03-16 16:39:32.204801 | TASK [Prepare workspace] 2026-03-16 16:39:32.243380 | controller | ok 2026-03-16 16:39:32.273087 | 2026-03-16 16:39:32.273198 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 16:39:32.657219 | controller | ok 2026-03-16 16:39:32.682374 | 2026-03-16 16:39:32.682473 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 16:39:36.400089 | controller | Output suppressed because no_log was given 2026-03-16 16:39:36.414414 | 2026-03-16 16:39:36.414484 | LOOP [Create zuul-output directory] 2026-03-16 16:39:36.672055 | controller | changed: "/home/zuul/ci-framework-data/logs" 2026-03-16 16:39:36.835663 | controller | ok: "/home/zuul/zuul-output/logs" 2026-03-16 16:39:36.846835 | 2026-03-16 16:39:36.846945 | TASK [Install required packages] 2026-03-16 16:40:14.062463 | controller | changed 2026-03-16 16:40:14.068608 | 2026-03-16 16:40:14.068887 | TASK [Install venv] 2026-03-16 16:40:29.477209 | controller | ERROR 2026-03-16 16:40:29.477442 | controller | { 2026-03-16 16:40:29.477482 | controller | "msg": "gmake: *** [Makefile:56: setup_tests] Error 1", 2026-03-16 16:40:29.477508 | controller | "rc": 2 2026-03-16 16:40:29.477528 | controller | } failure 2026-03-16 16:40:29.490379 | 2026-03-16 16:40:29.490440 | PLAY RECAP 2026-03-16 16:40:29.490487 | controller | ok: 6 changed: 3 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2026-03-16 16:40:29.490512 | 2026-03-16 16:40:29.825339 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-03-16 16:40:29.826218 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-03-16 16:40:31.495168 | 2026-03-16 16:40:31.495272 | PLAY [Run ci/playbooks/collect-logs.yml] 2026-03-16 16:40:31.545131 | 2026-03-16 16:40:31.545224 | TASK [Filter out host if needed] 2026-03-16 16:40:31.560797 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2026-03-16 16:40:31.569530 | 2026-03-16 16:40:31.569600 | TASK [Ensure file is present] 2026-03-16 16:40:32.211830 | controller | ok 2026-03-16 16:40:32.224039 | 2026-03-16 16:40:32.224134 | TASK [Manage molecule report file] 2026-03-16 16:40:32.798329 | controller | skipping: Conditional result was False 2026-03-16 16:40:32.804837 | 2026-03-16 16:40:32.805074 | TASK [Check if we get ci-framework-data basedir] 2026-03-16 16:40:33.013118 | controller | ok 2026-03-16 16:40:33.018865 | 2026-03-16 16:40:33.018943 | TASK [Create ci-framework-data log directory for zuul] 2026-03-16 16:40:33.398679 | controller | changed 2026-03-16 16:40:33.404077 | 2026-03-16 16:40:33.404160 | TASK [Copy ci-framework interesting files] 2026-03-16 16:40:33.974975 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2026-03-16 16:40:34.007427 | controller | changed 2026-03-16 16:40:34.017251 | 2026-03-16 16:40:34.017360 | TASK [Get SELinux listing] 2026-03-16 16:40:34.604532 | controller | changed 2026-03-16 16:40:34.612945 | 2026-03-16 16:40:34.613049 | TASK [Generate log index] 2026-03-16 16:40:35.416278 | controller | changed 2026-03-16 16:40:35.421255 | 2026-03-16 16:40:35.421362 | TASK [Get some env related data] 2026-03-16 16:40:36.494943 | controller | changed 2026-03-16 16:40:36.500842 | 2026-03-16 16:40:36.500933 | TASK [Generate list of logs to collect in home directory] 2026-03-16 16:40:37.022428 | controller | ok: All paths examined 2026-03-16 16:40:37.027706 | 2026-03-16 16:40:37.027789 | LOOP [Copy logs from home directory] 2026-03-16 16:40:37.070805 | 2026-03-16 16:40:37.070960 | TASK [Copy crio stats log file] 2026-03-16 16:40:37.094923 | controller | skipping: Conditional result was False 2026-03-16 16:40:37.122411 | 2026-03-16 16:40:37.122485 | TASK [Get SELinux related data] 2026-03-16 16:40:37.346652 | controller | 2026-03-16 16:40:37.653699 | controller | ERROR 2026-03-16 16:40:37.653827 | controller | { 2026-03-16 16:40:37.653862 | controller | "delta": "0:00:00.009099", 2026-03-16 16:40:37.653886 | controller | "end": "2026-03-16 16:40:37.347529", 2026-03-16 16:40:37.653906 | controller | "msg": "non-zero return code", 2026-03-16 16:40:37.653924 | controller | "rc": 1, 2026-03-16 16:40:37.653943 | controller | "start": "2026-03-16 16:40:37.338430" 2026-03-16 16:40:37.653962 | controller | } 2026-03-16 16:40:37.653987 | controller | ERROR: Ignoring Errors 2026-03-16 16:40:37.659986 | 2026-03-16 16:40:37.660065 | TASK [Create system configuration directory] 2026-03-16 16:40:37.880244 | controller | changed 2026-03-16 16:40:37.889139 | 2026-03-16 16:40:37.889234 | TASK [Get some of the system configurations] 2026-03-16 16:40:38.471735 | controller | changed 2026-03-16 16:40:38.477153 | 2026-03-16 16:40:38.477236 | TASK [Copy generated documentation if available] 2026-03-16 16:40:38.501317 | controller | skipping: Conditional result was False 2026-03-16 16:40:38.506964 | 2026-03-16 16:40:38.507048 | TASK [Copy generated AsciiDoc documentation if available] 2026-03-16 16:40:38.531068 | controller | skipping: Conditional result was False 2026-03-16 16:40:38.536340 | 2026-03-16 16:40:38.536406 | TASK [Compress logs bigger than 2MB] 2026-03-16 16:40:39.107537 | controller | changed 2026-03-16 16:40:39.112796 | 2026-03-16 16:40:39.112861 | TASK [Copy files from workspace on node] 2026-03-16 16:40:39.141548 | controller | ok 2026-03-16 16:40:39.166822 | 2026-03-16 16:40:39.166924 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:40:39.201421 | controller | skipping: Conditional result was False 2026-03-16 16:40:39.207330 | 2026-03-16 16:40:39.207423 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:40:39.236040 | controller | ok 2026-03-16 16:40:39.240892 | 2026-03-16 16:40:39.240961 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:40:39.490158 | controller -> localhost | ok: "/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/logs" 2026-03-16 16:40:39.490605 | 2026-03-16 16:40:39.735930 | controller -> localhost | changed: "/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/artifacts" 2026-03-16 16:40:39.944505 | controller -> localhost | changed: "/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/docs" 2026-03-16 16:40:39.958393 | 2026-03-16 16:40:39.958537 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:40:40.558544 | controller | changed: 2026-03-16 16:40:40.558727 | controller | .d..t...... ./ 2026-03-16 16:40:40.558761 | controller | >f+++++++++ README.html 2026-03-16 16:40:40.558786 | controller | >f+++++++++ dmesg.log 2026-03-16 16:40:40.558808 | controller | >f+++++++++ installed-pkgs.log 2026-03-16 16:40:40.558830 | controller | >f+++++++++ python.log 2026-03-16 16:40:40.558850 | controller | >f+++++++++ registries.conf 2026-03-16 16:40:40.558869 | controller | >f+++++++++ selinux-denials.log 2026-03-16 16:40:40.558887 | controller | >f+++++++++ selinux-listing.log 2026-03-16 16:40:40.558906 | controller | cd+++++++++ ci-framework-data/ 2026-03-16 16:40:40.558925 | controller | cd+++++++++ ci-framework-data/artifacts/ 2026-03-16 16:40:40.558943 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2026-03-16 16:40:40.558962 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2026-03-16 16:40:40.558980 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2026-03-16 16:40:40.558998 | controller | cd+++++++++ ci-framework-data/logs/ 2026-03-16 16:40:40.559015 | controller | cd+++++++++ registries.conf.d/ 2026-03-16 16:40:40.559057 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2026-03-16 16:40:40.559078 | controller | cd+++++++++ system-config/ 2026-03-16 16:40:40.559096 | controller | cd+++++++++ system-config/libvirt/ 2026-03-16 16:40:40.559113 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2026-03-16 16:40:40.559131 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2026-03-16 16:40:40.930664 | controller | changed: .d..t...... ./ 2026-03-16 16:40:41.356061 | controller | changed: .d..t...... ./ 2026-03-16 16:40:41.377991 | 2026-03-16 16:40:41.378091 | TASK [Return artifact to Zuul] 2026-03-16 16:40:41.421554 | controller | skipping: Conditional result was False 2026-03-16 16:40:41.442898 | 2026-03-16 16:40:41.442997 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2026-03-16 16:40:41.443127 | 2026-03-16 16:40:41.443156 | PLAY RECAP 2026-03-16 16:40:41.443197 | controller | ok: 15 changed: 11 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 1 2026-03-16 16:40:41.443218 | 2026-03-16 16:40:41.531911 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-03-16 16:40:41.532736 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-16 16:40:42.222459 | 2026-03-16 16:40:42.222554 | PLAY [all] 2026-03-16 16:40:42.246966 | 2026-03-16 16:40:42.247064 | TASK [include_role : fetch-output] 2026-03-16 16:40:42.285880 | controller | ok 2026-03-16 16:40:42.303158 | 2026-03-16 16:40:42.303253 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:40:42.347624 | controller | skipping: Conditional result was False 2026-03-16 16:40:42.353326 | 2026-03-16 16:40:42.353408 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:40:42.424773 | controller | ok 2026-03-16 16:40:42.429904 | 2026-03-16 16:40:42.429983 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:40:42.966948 | controller -> localhost | ok: "/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/logs" 2026-03-16 16:40:43.260119 | controller -> localhost | ok: "/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/artifacts" 2026-03-16 16:40:43.455477 | controller -> localhost | ok: "/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/docs" 2026-03-16 16:40:43.463899 | 2026-03-16 16:40:43.463977 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:40:43.999472 | controller | ok 2026-03-16 16:40:43.999659 | controller | ok: All items complete 2026-03-16 16:40:43.999691 | 2026-03-16 16:40:44.414910 | controller | ok 2026-03-16 16:40:44.930345 | controller | ok 2026-03-16 16:40:44.955433 | 2026-03-16 16:40:44.955532 | TASK [include_role : fetch-output-openshift] 2026-03-16 16:40:44.969284 | controller | skipping: Conditional result was False 2026-03-16 16:40:44.975600 | 2026-03-16 16:40:44.975680 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 16:40:45.429227 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006709 2026-03-16 16:40:45.649604 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.025553 2026-03-16 16:40:45.694517 | 2026-03-16 16:40:45.694602 | PLAY [all] 2026-03-16 16:40:45.720977 | 2026-03-16 16:40:45.721088 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-16 16:40:46.239859 | controller | changed 2026-03-16 16:40:46.287007 | 2026-03-16 16:40:46.287101 | PLAY RECAP 2026-03-16 16:40:46.287150 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-03-16 16:40:46.287174 | 2026-03-16 16:40:46.374870 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-16 16:40:46.375758 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-03-16 16:40:47.134599 | 2026-03-16 16:40:47.134700 | PLAY [localhost] 2026-03-16 16:40:47.153832 | 2026-03-16 16:40:47.153919 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 16:40:47.527771 | localhost | changed 2026-03-16 16:40:47.533240 | 2026-03-16 16:40:47.533357 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 16:40:47.561932 | localhost | ok 2026-03-16 16:40:47.577808 | 2026-03-16 16:40:47.577889 | TASK [add-fileserver : Create SSH private key tempfile] 2026-03-16 16:40:47.951793 | localhost | changed 2026-03-16 16:40:47.961008 | 2026-03-16 16:40:47.961113 | TASK [add-fileserver : Create SSH private key from secret] 2026-03-16 16:40:48.681458 | localhost | changed 2026-03-16 16:40:48.686648 | 2026-03-16 16:40:48.686730 | TASK [add-fileserver : Add fileserver ssh key] 2026-03-16 16:40:49.332456 | localhost | Identity added: /var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/tmp/ansible.qbh3s4cx (/var/lib/zuul/builds/700739a52b064fdd83b852106ba4087c/work/tmp/ansible.qbh3s4cx) 2026-03-16 16:40:49.332639 | localhost | ok: Runtime: 0:00:00.015245 2026-03-16 16:40:49.336998 | 2026-03-16 16:40:49.337090 | TASK [add-fileserver : Remove SSH private key from disk] 2026-03-16 16:40:49.774703 | localhost | ok: Runtime: 0:00:00.011721 2026-03-16 16:40:49.779353 | 2026-03-16 16:40:49.779423 | TASK [add-fileserver : Add fileserver to inventory] 2026-03-16 16:40:49.881790 | localhost | changed 2026-03-16 16:40:49.886750 | 2026-03-16 16:40:49.886831 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-03-16 16:40:50.279119 | localhost | changed 2026-03-16 16:40:50.302507 | 2026-03-16 16:40:50.302590 | PLAY [localhost] 2026-03-16 16:40:50.338660 | 2026-03-16 16:40:50.338840 | TASK [Generate bulk log download script] 2026-03-16 16:40:50.356360 | localhost | ok 2026-03-16 16:40:50.369391 | 2026-03-16 16:40:50.369466 | TASK [local-log-download : Check API endpoint is defined] 2026-03-16 16:40:50.396683 | localhost | ok: All assertions passed 2026-03-16 16:40:50.401544 | 2026-03-16 16:40:50.401607 | TASK [local-log-download : Create download script] 2026-03-16 16:40:50.761313 | localhost -> localhost | changed 2026-03-16 16:40:50.771204 | 2026-03-16 16:40:50.771288 | TASK [Register quick-download link] 2026-03-16 16:40:50.807996 | localhost | ok 2026-03-16 16:40:50.822964 | 2026-03-16 16:40:50.823019 | PLAY [logserver.rdoproject.org] 2026-03-16 16:40:50.832444 | 2026-03-16 16:40:50.832506 | TASK [Set zuul-log-path fact] 2026-03-16 16:40:50.847941 | logserver.rdoproject.org | ok 2026-03-16 16:40:50.857237 | 2026-03-16 16:40:50.857326 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:40:50.884054 | logserver.rdoproject.org | ok 2026-03-16 16:40:50.889431 | 2026-03-16 16:40:50.889498 | TASK [upload-logs : Create log directories] 2026-03-16 16:40:52.488770 | logserver.rdoproject.org | changed 2026-03-16 16:40:52.491951 | 2026-03-16 16:40:52.492018 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-16 16:40:52.741470 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.012572 2026-03-16 16:40:52.746514 | 2026-03-16 16:40:52.746580 | TASK [upload-logs : Upload logs to log server] 2026-03-16 16:40:54.175637 | logserver.rdoproject.org | Output suppressed because no_log was given 2026-03-16 16:40:54.178783 | 2026-03-16 16:40:54.178872 | LOOP [upload-logs : Compress console log and json output] 2026-03-16 16:40:54.217086 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:40:54.231713 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:40:54.235857 | 2026-03-16 16:40:54.235934 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-16 16:40:54.271496 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:40:54.271724 | 2026-03-16 16:40:54.274841 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:40:54.283738 | 2026-03-16 16:40:54.283824 | LOOP [upload-logs : Upload console log and json output]