2026-03-16 16:28:45.033968 | Job console starting... 2026-03-16 16:28:45.240907 | Updating repositories 2026-03-16 16:28:46.196115 | Preparing job workspace 2026-03-16 16:29:01.767335 | Running Ansible setup... 2026-03-16 16:29:08.189647 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-16 16:29:09.907804 | 2026-03-16 16:29:09.907943 | PLAY [localhost] 2026-03-16 16:29:09.935437 | 2026-03-16 16:29:09.935515 | TASK [Gathering Facts] 2026-03-16 16:29:11.889941 | localhost | ok 2026-03-16 16:29:11.928189 | 2026-03-16 16:29:11.936352 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 16:29:12.913428 | localhost -> localhost | changed 2026-03-16 16:29:12.919000 | 2026-03-16 16:29:12.919082 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 16:29:15.434587 | localhost -> localhost | changed 2026-03-16 16:29:15.443906 | 2026-03-16 16:29:15.443979 | TASK [Setup log path fact] 2026-03-16 16:29:15.526124 | localhost | ok 2026-03-16 16:29:15.581046 | 2026-03-16 16:29:15.581143 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:29:15.627586 | localhost | ok 2026-03-16 16:29:15.642765 | 2026-03-16 16:29:15.642835 | TASK [emit-job-header : Print job information] 2026-03-16 16:29:15.736784 | # Job Information 2026-03-16 16:29:15.736928 | Ansible Version: 2.15.12 2026-03-16 16:29:15.736960 | Job: cifmw-molecule-ci_gen_kustomize_values 2026-03-16 16:29:15.736983 | Pipeline: github-check 2026-03-16 16:29:15.737005 | Executor: ibm-bm3-ze.softwarefactory-project.io 2026-03-16 16:29:15.737025 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3770 2026-03-16 16:29:15.737046 | Log URL (when completed): https://logserver.rdoproject.org/941/rdoproject.org/941ecb86a10c46a5a3114da087b0b414/ 2026-03-16 16:29:15.737066 | Event ID: 072a8580-2155-11f1-9026-7307b7bf6b98 2026-03-16 16:29:15.740743 | 2026-03-16 16:29:15.740809 | LOOP [emit-job-header : Print node information] 2026-03-16 16:29:15.993603 | localhost | ok: 2026-03-16 16:29:15.993813 | localhost | # Node Information 2026-03-16 16:29:15.993845 | localhost | Inventory Hostname: controller 2026-03-16 16:29:15.993871 | localhost | Hostname: np0005648706 2026-03-16 16:29:15.993894 | localhost | Username: zuul 2026-03-16 16:29:15.993916 | localhost | Distro: CentOS 9 2026-03-16 16:29:15.993936 | localhost | Provider: ibm-bm3-nodepool 2026-03-16 16:29:15.993954 | localhost | Region: regionOne 2026-03-16 16:29:15.993972 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2026-03-16 16:29:15.993990 | localhost | Product Name: OpenStack Compute 2026-03-16 16:29:15.994007 | localhost | Interface IP: 192.168.25.2 2026-03-16 16:29:16.038080 | 2026-03-16 16:29:16.038139 | PLAY [all] 2026-03-16 16:29:16.060439 | 2026-03-16 16:29:16.060624 | TASK [Gather network facts] 2026-03-16 16:29:16.483718 | controller | ok 2026-03-16 16:29:16.519092 | 2026-03-16 16:29:16.519175 | TASK [include_role : start-zuul-console] 2026-03-16 16:29:16.588360 | controller | ok 2026-03-16 16:29:16.638554 | 2026-03-16 16:29:16.638643 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 16:29:17.744926 | controller | ok 2026-03-16 16:29:17.759425 | 2026-03-16 16:29:17.759506 | TASK [include_role : add-build-sshkey] 2026-03-16 16:29:17.880778 | controller | ok 2026-03-16 16:29:17.924965 | 2026-03-16 16:29:17.925578 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:29:18.737903 | controller -> localhost | ok 2026-03-16 16:29:18.743584 | 2026-03-16 16:29:18.743648 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:29:18.826352 | controller | ok 2026-03-16 16:29:18.844125 | controller | included: /var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:29:18.855201 | 2026-03-16 16:29:18.855305 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:29:20.685162 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 16:29:20.685357 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/941ecb86a10c46a5a3114da087b0b414_id_rsa. 2026-03-16 16:29:20.685393 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/941ecb86a10c46a5a3114da087b0b414_id_rsa.pub. 2026-03-16 16:29:20.685419 | controller -> localhost | The key fingerprint is: 2026-03-16 16:29:20.685451 | controller -> localhost | SHA256:A7zN1kuaMlIoKGbkgHJMmIGXnZBqCKXScgH5qz873VQ zuul-build-sshkey 2026-03-16 16:29:20.685473 | controller -> localhost | The key's randomart image is: 2026-03-16 16:29:20.685504 | controller -> localhost | +---[RSA 3072]----+ 2026-03-16 16:29:20.685525 | controller -> localhost | |+B== . | 2026-03-16 16:29:20.685546 | controller -> localhost | |B=+.o. | 2026-03-16 16:29:20.685564 | controller -> localhost | |X== o | 2026-03-16 16:29:20.685583 | controller -> localhost | |O*. . =E. | 2026-03-16 16:29:20.685602 | controller -> localhost | |++... o.S o | 2026-03-16 16:29:20.685621 | controller -> localhost | |+ .. ... = . | 2026-03-16 16:29:20.685945 | controller -> localhost | | . ..oo o . | 2026-03-16 16:29:20.685980 | controller -> localhost | |. o ...o | 2026-03-16 16:29:20.686003 | controller -> localhost | | .o+ | 2026-03-16 16:29:20.686024 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:29:20.686072 | controller -> localhost | ok: Runtime: 0:00:00.436619 2026-03-16 16:29:20.692907 | 2026-03-16 16:29:20.692974 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:29:20.742336 | controller | ok 2026-03-16 16:29:20.760376 | controller | included: /var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:29:20.784196 | 2026-03-16 16:29:20.784311 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:29:20.822668 | controller | skipping: Conditional result was False 2026-03-16 16:29:20.828092 | 2026-03-16 16:29:20.828158 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:29:21.480526 | controller | changed 2026-03-16 16:29:21.485993 | 2026-03-16 16:29:21.486083 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:29:21.738077 | controller | ok 2026-03-16 16:29:21.749252 | 2026-03-16 16:29:21.749353 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:29:22.614342 | controller | changed 2026-03-16 16:29:22.619319 | 2026-03-16 16:29:22.619392 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:29:23.505536 | controller | changed 2026-03-16 16:29:23.510685 | 2026-03-16 16:29:23.510751 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:29:23.554535 | controller | skipping: Conditional result was False 2026-03-16 16:29:23.561967 | 2026-03-16 16:29:23.562042 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:29:24.888916 | controller -> localhost | changed 2026-03-16 16:29:24.899509 | 2026-03-16 16:29:24.899578 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:29:25.645922 | controller -> localhost | Identity added: /var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/941ecb86a10c46a5a3114da087b0b414_id_rsa (zuul-build-sshkey) 2026-03-16 16:29:25.646169 | controller -> localhost | ok: Runtime: 0:00:00.031515 2026-03-16 16:29:25.651938 | 2026-03-16 16:29:25.652006 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:29:26.338536 | controller | ok 2026-03-16 16:29:26.359653 | 2026-03-16 16:29:26.359769 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:29:26.406506 | controller | skipping: Conditional result was False 2026-03-16 16:29:26.420141 | 2026-03-16 16:29:26.420214 | TASK [include_role : validate-host] 2026-03-16 16:29:26.457661 | controller | ok 2026-03-16 16:29:26.544554 | 2026-03-16 16:29:26.544661 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-16 16:29:26.626968 | controller | ok 2026-03-16 16:29:26.631551 | 2026-03-16 16:29:26.631612 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-16 16:29:27.650712 | controller -> localhost | ok 2026-03-16 16:29:27.662531 | 2026-03-16 16:29:27.662612 | TASK [validate-host : Collect information about the host] 2026-03-16 16:29:28.396335 | controller | ok 2026-03-16 16:29:28.449447 | 2026-03-16 16:29:28.449543 | TASK [validate-host : Sanitize hostname] 2026-03-16 16:29:28.529553 | controller | ok 2026-03-16 16:29:28.557773 | 2026-03-16 16:29:28.557876 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-16 16:29:30.262686 | controller -> localhost | changed 2026-03-16 16:29:30.268369 | 2026-03-16 16:29:30.268436 | TASK [validate-host : Collect information about zuul worker] 2026-03-16 16:29:31.288717 | controller | ok 2026-03-16 16:29:31.295653 | 2026-03-16 16:29:31.295719 | TASK [validate-host : Write out all zuul information for each host] 2026-03-16 16:29:32.628557 | controller -> localhost | changed 2026-03-16 16:29:32.639350 | 2026-03-16 16:29:32.639418 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 16:29:32.715736 | controller | skipping: Conditional result was False 2026-03-16 16:29:32.721283 | 2026-03-16 16:29:32.721353 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 16:29:32.779994 | controller | skipping: Conditional result was False 2026-03-16 16:29:32.786586 | 2026-03-16 16:29:32.786670 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 16:29:33.090806 | controller | ok: "logs" 2026-03-16 16:29:33.091022 | controller | ok: All items complete 2026-03-16 16:29:33.091059 | 2026-03-16 16:29:33.288483 | controller | ok: "artifacts" 2026-03-16 16:29:33.473780 | controller | ok: "docs" 2026-03-16 16:29:33.493657 | 2026-03-16 16:29:33.493754 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 16:29:33.802214 | controller | changed: "logs" 2026-03-16 16:29:34.002458 | controller | changed: "artifacts" 2026-03-16 16:29:34.198850 | controller | changed: "docs" 2026-03-16 16:29:34.283426 | 2026-03-16 16:29:34.283510 | PLAY RECAP 2026-03-16 16:29:34.283561 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 16:29:34.283591 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:29:34.283613 | 2026-03-16 16:29:34.634721 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2026-03-16 16:29:34.635489 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-03-16 16:29:37.079748 | 2026-03-16 16:29:37.079866 | PLAY [all] 2026-03-16 16:29:37.172839 | 2026-03-16 16:29:37.172970 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-16 16:29:37.358711 | controller | ok 2026-03-16 16:29:37.376139 | 2026-03-16 16:29:37.376256 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-16 16:29:38.005587 | controller | changed 2026-03-16 16:29:38.016974 | 2026-03-16 16:29:38.017057 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-16 16:29:39.890589 | controller | changed 2026-03-16 16:29:39.926611 | 2026-03-16 16:29:39.926725 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2026-03-16 16:29:40.778827 | controller | changed: 2026-03-16 16:29:40.779608 | controller | { 2026-03-16 16:29:40.779653 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2026-03-16 16:29:40.779687 | controller | } 2026-03-16 16:29:40.992653 | controller | changed: 2026-03-16 16:29:40.992738 | controller | { 2026-03-16 16:29:40.993040 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2026-03-16 16:29:40.993080 | controller | } 2026-03-16 16:29:41.227498 | controller | changed: 2026-03-16 16:29:41.227598 | controller | { 2026-03-16 16:29:41.227628 | 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:29:41.227841 | controller | } 2026-03-16 16:29:41.458690 | controller | changed: 2026-03-16 16:29:41.458783 | controller | { 2026-03-16 16:29:41.458811 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2026-03-16 16:29:41.458833 | controller | } 2026-03-16 16:29:41.681227 | controller | changed: 2026-03-16 16:29:41.681330 | controller | { 2026-03-16 16:29:41.681360 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2026-03-16 16:29:41.681383 | controller | } 2026-03-16 16:29:41.900347 | controller | changed: 2026-03-16 16:29:41.900431 | controller | { 2026-03-16 16:29:41.900459 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2026-03-16 16:29:41.900480 | controller | } 2026-03-16 16:29:42.126320 | controller | changed: 2026-03-16 16:29:42.126416 | controller | { 2026-03-16 16:29:42.126444 | 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:29:42.126467 | controller | } 2026-03-16 16:29:42.350883 | controller | changed: 2026-03-16 16:29:42.351021 | controller | { 2026-03-16 16:29:42.351054 | 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:29:42.351078 | controller | } 2026-03-16 16:29:42.616561 | controller | changed: 2026-03-16 16:29:42.616671 | controller | { 2026-03-16 16:29:42.616700 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2026-03-16 16:29:42.616722 | controller | } 2026-03-16 16:29:42.809817 | controller | changed: 2026-03-16 16:29:42.809913 | controller | { 2026-03-16 16:29:42.809941 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2026-03-16 16:29:42.809962 | controller | } 2026-03-16 16:29:43.044892 | controller | changed: 2026-03-16 16:29:43.045102 | controller | { 2026-03-16 16:29:43.045134 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2026-03-16 16:29:43.045157 | controller | } 2026-03-16 16:29:43.293933 | controller | changed: 2026-03-16 16:29:43.294081 | controller | { 2026-03-16 16:29:43.294115 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2026-03-16 16:29:43.294138 | controller | } 2026-03-16 16:29:43.526186 | controller | changed: 2026-03-16 16:29:43.526301 | controller | { 2026-03-16 16:29:43.526336 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com" 2026-03-16 16:29:43.526360 | controller | } 2026-03-16 16:29:43.751246 | controller | changed: 2026-03-16 16:29:43.751360 | controller | { 2026-03-16 16:29:43.751388 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2026-03-16 16:29:43.751410 | controller | } 2026-03-16 16:29:43.996148 | controller | changed: 2026-03-16 16:29:43.996244 | controller | { 2026-03-16 16:29:43.996292 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2026-03-16 16:29:43.996319 | controller | } 2026-03-16 16:29:44.230767 | controller | changed: 2026-03-16 16:29:44.230859 | controller | { 2026-03-16 16:29:44.230887 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2026-03-16 16:29:44.230908 | controller | } 2026-03-16 16:29:44.460920 | controller | changed: 2026-03-16 16:29:44.461015 | controller | { 2026-03-16 16:29:44.461043 | 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:29:44.461066 | controller | } 2026-03-16 16:29:44.704503 | controller | changed: 2026-03-16 16:29:44.704590 | controller | { 2026-03-16 16:29:44.704618 | 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:29:44.704646 | controller | } 2026-03-16 16:29:44.943705 | controller | changed: 2026-03-16 16:29:44.943808 | controller | { 2026-03-16 16:29:44.943837 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2026-03-16 16:29:44.943859 | controller | } 2026-03-16 16:29:45.181418 | controller | changed: 2026-03-16 16:29:45.181495 | controller | { 2026-03-16 16:29:45.181522 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2026-03-16 16:29:45.181543 | controller | } 2026-03-16 16:29:45.424129 | controller | changed: 2026-03-16 16:29:45.424221 | controller | { 2026-03-16 16:29:45.424248 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2026-03-16 16:29:45.424294 | controller | } 2026-03-16 16:29:45.662747 | controller | changed: 2026-03-16 16:29:45.662930 | controller | { 2026-03-16 16:29:45.662985 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2026-03-16 16:29:45.663009 | controller | } 2026-03-16 16:29:45.885087 | controller | changed: 2026-03-16 16:29:45.885190 | controller | { 2026-03-16 16:29:45.885219 | 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:29:45.885242 | controller | } 2026-03-16 16:29:46.103214 | controller | changed: 2026-03-16 16:29:46.103321 | controller | { 2026-03-16 16:29:46.103352 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2026-03-16 16:29:46.103374 | controller | } 2026-03-16 16:29:46.329588 | controller | changed: 2026-03-16 16:29:46.329665 | controller | { 2026-03-16 16:29:46.329693 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2026-03-16 16:29:46.329716 | controller | } 2026-03-16 16:29:46.550557 | controller | changed: 2026-03-16 16:29:46.550652 | controller | { 2026-03-16 16:29:46.550679 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2026-03-16 16:29:46.550702 | controller | } 2026-03-16 16:29:46.587162 | 2026-03-16 16:29:46.587289 | TASK [Set timezone to UTC] 2026-03-16 16:29:47.413387 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2026-03-16 16:29:47.425643 | 2026-03-16 16:29:47.425720 | TASK [Create nodepool directory] 2026-03-16 16:29:47.741396 | controller | changed 2026-03-16 16:29:47.749998 | 2026-03-16 16:29:47.750083 | TASK [Create nodepool sub_nodes file] 2026-03-16 16:29:48.502199 | controller | changed 2026-03-16 16:29:48.507868 | 2026-03-16 16:29:48.507952 | TASK [Create nodepool sub_nodes_private file] 2026-03-16 16:29:49.151984 | controller | changed 2026-03-16 16:29:49.157837 | 2026-03-16 16:29:49.157911 | LOOP [Populate nodepool sub_nodes file] 2026-03-16 16:29:49.235000 | 2026-03-16 16:29:49.235160 | LOOP [Populate nodepool sub_nodes_private file] 2026-03-16 16:29:49.321116 | 2026-03-16 16:29:49.321298 | TASK [Create nodepool primary file] 2026-03-16 16:29:49.415937 | controller | skipping: Conditional result was False 2026-03-16 16:29:49.422095 | 2026-03-16 16:29:49.422182 | TASK [Create nodepool node_private for this node] 2026-03-16 16:29:50.162426 | controller | changed 2026-03-16 16:29:50.185021 | 2026-03-16 16:29:50.185125 | LOOP [Copy ssh keys to nodepool directory] 2026-03-16 16:29:50.913673 | controller | ok: Item: id_rsa Runtime: 0:00:00.004490 2026-03-16 16:29:50.913878 | 2026-03-16 16:29:51.097766 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004407 2026-03-16 16:29:51.120086 | 2026-03-16 16:29:51.120253 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2026-03-16 16:29:51.834008 | controller | changed 2026-03-16 16:29:51.839736 | 2026-03-16 16:29:51.839802 | TASK [Validate sudoers config after edits] 2026-03-16 16:29:52.233485 | controller | /etc/sudoers: parsed OK 2026-03-16 16:29:52.233538 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2026-03-16 16:29:52.233547 | controller | /etc/sudoers.d/zuul: parsed OK 2026-03-16 16:29:52.233553 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2026-03-16 16:29:52.447500 | controller | ok: Runtime: 0:00:00.005107 2026-03-16 16:29:52.454526 | 2026-03-16 16:29:52.454598 | TASK [Show the environment passed in to job shell scripts] 2026-03-16 16:29:52.814222 | controller | SHELL=/bin/bash 2026-03-16 16:29:52.814256 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2026-03-16 16:29:52.814265 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2026-03-16 16:29:52.814271 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/70/3770/235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:29:52.814277 | controller | PWD=/home/zuul 2026-03-16 16:29:52.814283 | controller | ZUUL_PIPELINE=github-check 2026-03-16 16:29:52.814288 | controller | LOGNAME=zuul 2026-03-16 16:29:52.814293 | controller | XDG_SESSION_TYPE=tty 2026-03-16 16:29:52.814299 | controller | _=/usr/bin/env 2026-03-16 16:29:52.814304 | controller | MOTD_SHOWN=pam 2026-03-16 16:29:52.814309 | controller | HOME=/home/zuul 2026-03-16 16:29:52.814314 | controller | LANG=en_US.UTF-8 2026-03-16 16:29:52.814351 | controller | SSH_CONNECTION=192.168.25.12 60384 192.168.25.2 22 2026-03-16 16:29:52.814359 | 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:29:52.814368 | controller | ZUUL_CHANGE_IDS=3770,235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:29:52.814373 | controller | WORKSPACE=/home/zuul/workspace 2026-03-16 16:29:52.814378 | controller | XDG_SESSION_CLASS=user 2026-03-16 16:29:52.814384 | controller | SELINUX_ROLE_REQUESTED= 2026-03-16 16:29:52.814389 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2026-03-16 16:29:52.814394 | controller | USER=zuul 2026-03-16 16:29:52.814400 | controller | ZUUL_VOTING=True 2026-03-16 16:29:52.814405 | controller | BUILD_TIMEOUT=1800000 2026-03-16 16:29:52.814410 | controller | SELINUX_USE_CURRENT_RANGE= 2026-03-16 16:29:52.814415 | controller | SHLVL=1 2026-03-16 16:29:52.814420 | controller | ZUUL_PATCHSET=235f23c012043ef9e6fbd3c71c40da700f09e62a 2026-03-16 16:29:52.814426 | controller | XDG_SESSION_ID=1 2026-03-16 16:29:52.814431 | controller | ZUUL_BRANCH=main 2026-03-16 16:29:52.814436 | controller | XDG_RUNTIME_DIR=/run/user/1000 2026-03-16 16:29:52.814441 | controller | SSH_CLIENT=192.168.25.12 60384 22 2026-03-16 16:29:52.814448 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2026-03-16 16:29:52.814454 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2026-03-16 16:29:52.814459 | controller | which_declare=declare -f 2026-03-16 16:29:52.814465 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 16:29:52.814470 | controller | SELINUX_LEVEL_REQUESTED= 2026-03-16 16:29:52.814475 | controller | ZUUL_CHANGE=3770 2026-03-16 16:29:52.814481 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2026-03-16 16:29:52.814486 | controller | ZUUL_UUID=941ecb86a10c46a5a3114da087b0b414 2026-03-16 16:29:52.814491 | controller | BASH_FUNC_which%%=() { ( alias; 2026-03-16 16:29:52.814497 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2026-03-16 16:29:52.814502 | controller | } 2026-03-16 16:29:53.045989 | controller | ok: Runtime: 0:00:00.004770 2026-03-16 16:29:53.051321 | 2026-03-16 16:29:53.051387 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2026-03-16 16:29:53.117948 | controller | skipping: Conditional result was False 2026-03-16 16:29:53.127007 | 2026-03-16 16:29:53.127092 | TASK [Symlink /home/zuul-worker/workspace] 2026-03-16 16:29:53.717349 | controller | skipping: Conditional result was False 2026-03-16 16:29:53.805845 | 2026-03-16 16:29:53.805973 | TASK [Ensure legacy workspace directory] 2026-03-16 16:29:54.045415 | controller | changed 2026-03-16 16:29:54.117188 | 2026-03-16 16:29:54.117338 | PLAY RECAP 2026-03-16 16:29:54.117393 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 16:29:54.117417 | 2026-03-16 16:29:54.485348 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2026-03-16 16:29:54.486085 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-03-16 16:29:56.679625 | 2026-03-16 16:29:56.679757 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2026-03-16 16:29:56.774846 | 2026-03-16 16:29:56.774992 | TASK [Create zuul-output directory] 2026-03-16 16:29:57.429746 | controller | changed 2026-03-16 16:29:57.451086 | 2026-03-16 16:29:57.453199 | TASK [Slurp Zuul inventory test] 2026-03-16 16:29:58.659429 | controller -> localhost | ok 2026-03-16 16:29:58.668056 | 2026-03-16 16:29:58.668149 | TASK [Save zuul inventory] 2026-03-16 16:30:00.396033 | controller | changed 2026-03-16 16:30:00.410103 | 2026-03-16 16:30:00.410188 | TASK [Save zuul vars without the change_message] 2026-03-16 16:30:01.472640 | controller | changed 2026-03-16 16:30:01.544032 | 2026-03-16 16:30:01.544130 | PLAY RECAP 2026-03-16 16:30:01.544179 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:30:01.544203 | 2026-03-16 16:30:01.827766 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2026-03-16 16:30:01.828666 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-03-16 16:30:02.995238 | 2026-03-16 16:30:02.995369 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2026-03-16 16:30:03.062662 | 2026-03-16 16:30:03.062777 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2026-03-16 16:30:03.112312 | controller | ok 2026-03-16 16:30:03.149463 | 2026-03-16 16:30:03.149570 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2026-03-16 16:30:03.217526 | controller | skipping: Conditional result was False 2026-03-16 16:30:03.226038 | 2026-03-16 16:30:03.226112 | TASK [mirror-info-fork : Create /etc/ci] 2026-03-16 16:30:03.688467 | controller | ok 2026-03-16 16:30:03.697558 | 2026-03-16 16:30:03.697629 | TASK [mirror-info-fork : Install ci_mirror script] 2026-03-16 16:30:04.429354 | controller | ok 2026-03-16 16:30:04.458623 | 2026-03-16 16:30:04.458722 | TASK [Prepare workspace] 2026-03-16 16:30:04.509728 | controller | ok 2026-03-16 16:30:04.554069 | 2026-03-16 16:30:04.554194 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 16:30:05.200569 | controller | ok 2026-03-16 16:30:05.211256 | 2026-03-16 16:30:05.211357 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 16:30:10.886973 | controller | Output suppressed because no_log was given 2026-03-16 16:30:10.906783 | 2026-03-16 16:30:10.906874 | LOOP [Create zuul-output directory] 2026-03-16 16:30:11.168315 | controller | changed: "/home/zuul/ci-framework-data/logs" 2026-03-16 16:30:11.312136 | controller | ok: "/home/zuul/zuul-output/logs" 2026-03-16 16:30:11.335756 | 2026-03-16 16:30:11.335856 | TASK [Install required packages] 2026-03-16 16:30:54.904944 | controller | changed 2026-03-16 16:30:54.914113 | 2026-03-16 16:30:54.914187 | TASK [Install venv] 2026-03-16 16:31:09.711610 | controller | ERROR 2026-03-16 16:31:09.711838 | controller | { 2026-03-16 16:31:09.711871 | controller | "msg": "gmake: *** [Makefile:56: setup_tests] Error 1", 2026-03-16 16:31:09.711896 | controller | "rc": 2 2026-03-16 16:31:09.711916 | controller | } failure 2026-03-16 16:31:09.726724 | 2026-03-16 16:31:09.726829 | PLAY RECAP 2026-03-16 16:31:09.726883 | controller | ok: 6 changed: 3 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2026-03-16 16:31:09.726908 | 2026-03-16 16:31:09.943095 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2026-03-16 16:31:09.944051 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-03-16 16:31:10.756736 | 2026-03-16 16:31:10.756875 | PLAY [Run ci/playbooks/collect-logs.yml] 2026-03-16 16:31:10.783797 | 2026-03-16 16:31:10.783878 | TASK [Filter out host if needed] 2026-03-16 16:31:10.793686 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2026-03-16 16:31:10.808845 | 2026-03-16 16:31:10.808922 | TASK [Ensure file is present] 2026-03-16 16:31:11.348382 | controller | ok 2026-03-16 16:31:11.359914 | 2026-03-16 16:31:11.360032 | TASK [Manage molecule report file] 2026-03-16 16:31:11.912503 | controller | skipping: Conditional result was False 2026-03-16 16:31:11.918810 | 2026-03-16 16:31:11.918896 | TASK [Check if we get ci-framework-data basedir] 2026-03-16 16:31:12.169826 | controller | ok 2026-03-16 16:31:12.175236 | 2026-03-16 16:31:12.175321 | TASK [Create ci-framework-data log directory for zuul] 2026-03-16 16:31:12.704340 | controller | changed 2026-03-16 16:31:12.709667 | 2026-03-16 16:31:12.709740 | TASK [Copy ci-framework interesting files] 2026-03-16 16:31:13.156796 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2026-03-16 16:31:13.245785 | controller | changed 2026-03-16 16:31:13.251152 | 2026-03-16 16:31:13.251227 | TASK [Get SELinux listing] 2026-03-16 16:31:13.796611 | controller | changed 2026-03-16 16:31:13.807207 | 2026-03-16 16:31:13.807315 | TASK [Generate log index] 2026-03-16 16:31:14.609681 | controller | changed 2026-03-16 16:31:14.620665 | 2026-03-16 16:31:14.620746 | TASK [Get some env related data] 2026-03-16 16:31:15.698351 | controller | changed 2026-03-16 16:31:15.703954 | 2026-03-16 16:31:15.704042 | TASK [Generate list of logs to collect in home directory] 2026-03-16 16:31:16.152420 | controller | ok: All paths examined 2026-03-16 16:31:16.157501 | 2026-03-16 16:31:16.157569 | LOOP [Copy logs from home directory] 2026-03-16 16:31:16.194746 | 2026-03-16 16:31:16.194905 | TASK [Copy crio stats log file] 2026-03-16 16:31:16.220790 | controller | skipping: Conditional result was False 2026-03-16 16:31:16.304438 | 2026-03-16 16:31:16.304554 | TASK [Get SELinux related data] 2026-03-16 16:31:16.599953 | controller | 2026-03-16 16:31:16.874647 | controller | ERROR 2026-03-16 16:31:16.874844 | controller | { 2026-03-16 16:31:16.874880 | controller | "delta": "0:00:00.009047", 2026-03-16 16:31:16.874903 | controller | "end": "2026-03-16 16:31:16.601278", 2026-03-16 16:31:16.874923 | controller | "msg": "non-zero return code", 2026-03-16 16:31:16.874941 | controller | "rc": 1, 2026-03-16 16:31:16.874960 | controller | "start": "2026-03-16 16:31:16.592231" 2026-03-16 16:31:16.874978 | controller | } 2026-03-16 16:31:16.875019 | controller | ERROR: Ignoring Errors 2026-03-16 16:31:16.885200 | 2026-03-16 16:31:16.885320 | TASK [Create system configuration directory] 2026-03-16 16:31:17.148512 | controller | changed 2026-03-16 16:31:17.160381 | 2026-03-16 16:31:17.160466 | TASK [Get some of the system configurations] 2026-03-16 16:31:17.730227 | controller | changed 2026-03-16 16:31:17.736539 | 2026-03-16 16:31:17.736617 | TASK [Copy generated documentation if available] 2026-03-16 16:31:17.760945 | controller | skipping: Conditional result was False 2026-03-16 16:31:17.767241 | 2026-03-16 16:31:17.767339 | TASK [Copy generated AsciiDoc documentation if available] 2026-03-16 16:31:17.801728 | controller | skipping: Conditional result was False 2026-03-16 16:31:17.808805 | 2026-03-16 16:31:17.808886 | TASK [Compress logs bigger than 2MB] 2026-03-16 16:31:18.344873 | controller | changed 2026-03-16 16:31:18.350755 | 2026-03-16 16:31:18.350843 | TASK [Copy files from workspace on node] 2026-03-16 16:31:18.380579 | controller | ok 2026-03-16 16:31:18.403984 | 2026-03-16 16:31:18.404086 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:31:18.427844 | controller | skipping: Conditional result was False 2026-03-16 16:31:18.435639 | 2026-03-16 16:31:18.435715 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:31:18.484609 | controller | ok 2026-03-16 16:31:18.503130 | 2026-03-16 16:31:18.503227 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:31:18.970376 | controller -> localhost | ok: "/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/logs" 2026-03-16 16:31:18.970632 | 2026-03-16 16:31:19.544372 | controller -> localhost | changed: "/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/artifacts" 2026-03-16 16:31:19.990342 | controller -> localhost | changed: "/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/docs" 2026-03-16 16:31:20.001088 | 2026-03-16 16:31:20.001212 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:31:21.467985 | controller | changed: 2026-03-16 16:31:21.468204 | controller | .d..t...... ./ 2026-03-16 16:31:21.468237 | controller | >f+++++++++ README.html 2026-03-16 16:31:21.468262 | controller | >f+++++++++ dmesg.log 2026-03-16 16:31:21.474221 | controller | >f+++++++++ installed-pkgs.log 2026-03-16 16:31:21.474255 | controller | >f+++++++++ python.log 2026-03-16 16:31:21.474300 | controller | >f+++++++++ registries.conf 2026-03-16 16:31:21.474324 | controller | >f+++++++++ selinux-denials.log 2026-03-16 16:31:21.474344 | controller | >f+++++++++ selinux-listing.log 2026-03-16 16:31:21.474363 | controller | cd+++++++++ ci-framework-data/ 2026-03-16 16:31:21.474382 | controller | cd+++++++++ ci-framework-data/artifacts/ 2026-03-16 16:31:21.474401 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2026-03-16 16:31:21.474419 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2026-03-16 16:31:21.474436 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2026-03-16 16:31:21.474453 | controller | cd+++++++++ ci-framework-data/logs/ 2026-03-16 16:31:21.474470 | controller | cd+++++++++ registries.conf.d/ 2026-03-16 16:31:21.474488 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2026-03-16 16:31:21.474506 | controller | cd+++++++++ system-config/ 2026-03-16 16:31:21.474523 | controller | cd+++++++++ system-config/libvirt/ 2026-03-16 16:31:21.474540 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2026-03-16 16:31:21.474557 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2026-03-16 16:31:22.428753 | controller | changed: .d..t...... ./ 2026-03-16 16:31:23.571816 | controller | changed: .d..t...... ./ 2026-03-16 16:31:23.589363 | 2026-03-16 16:31:23.589482 | TASK [Return artifact to Zuul] 2026-03-16 16:31:23.625908 | controller | skipping: Conditional result was False 2026-03-16 16:31:23.648553 | 2026-03-16 16:31:23.648631 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2026-03-16 16:31:23.648736 | 2026-03-16 16:31:23.648763 | PLAY RECAP 2026-03-16 16:31:23.648803 | controller | ok: 15 changed: 11 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 1 2026-03-16 16:31:23.648825 | 2026-03-16 16:31:23.902100 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2026-03-16 16:31:23.902931 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-16 16:31:25.253009 | 2026-03-16 16:31:25.253142 | PLAY [all] 2026-03-16 16:31:25.334818 | 2026-03-16 16:31:25.334961 | TASK [include_role : fetch-output] 2026-03-16 16:31:25.438723 | controller | ok 2026-03-16 16:31:25.493156 | 2026-03-16 16:31:25.493319 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:31:25.741715 | controller | skipping: Conditional result was False 2026-03-16 16:31:25.751690 | 2026-03-16 16:31:25.751789 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:31:25.826433 | controller | ok 2026-03-16 16:31:25.843687 | 2026-03-16 16:31:25.843783 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:31:26.896211 | controller -> localhost | ok: "/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/logs" 2026-03-16 16:31:27.343912 | controller -> localhost | ok: "/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/artifacts" 2026-03-16 16:31:28.134792 | controller -> localhost | ok: "/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/docs" 2026-03-16 16:31:28.151837 | 2026-03-16 16:31:28.151975 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:31:29.605905 | controller | ok 2026-03-16 16:31:29.606126 | controller | ok: All items complete 2026-03-16 16:31:29.606157 | 2026-03-16 16:31:30.677403 | controller | ok 2026-03-16 16:31:31.448946 | controller | ok 2026-03-16 16:31:31.471504 | 2026-03-16 16:31:31.471615 | TASK [include_role : fetch-output-openshift] 2026-03-16 16:31:31.543728 | controller | skipping: Conditional result was False 2026-03-16 16:31:31.550210 | 2026-03-16 16:31:31.550303 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 16:31:32.905146 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.070449 2026-03-16 16:31:33.745160 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.047606 2026-03-16 16:31:33.845896 | 2026-03-16 16:31:33.846032 | PLAY [all] 2026-03-16 16:31:33.899889 | 2026-03-16 16:31:33.900027 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-16 16:31:34.585197 | controller | changed 2026-03-16 16:31:34.674413 | 2026-03-16 16:31:34.674518 | PLAY RECAP 2026-03-16 16:31:34.674569 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-03-16 16:31:34.674593 | 2026-03-16 16:31:35.170518 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2026-03-16 16:31:35.171321 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2026-03-16 16:31:36.596531 | 2026-03-16 16:31:36.596694 | PLAY [localhost] 2026-03-16 16:31:36.660256 | 2026-03-16 16:31:36.660412 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 16:31:37.739591 | localhost | changed 2026-03-16 16:31:37.744300 | 2026-03-16 16:31:37.744378 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 16:31:37.815314 | localhost | ok 2026-03-16 16:31:37.828901 | 2026-03-16 16:31:37.828976 | TASK [add-fileserver : Create SSH private key tempfile] 2026-03-16 16:31:38.765953 | localhost | changed 2026-03-16 16:31:38.780807 | 2026-03-16 16:31:38.780933 | TASK [add-fileserver : Create SSH private key from secret] 2026-03-16 16:31:40.796229 | localhost | changed 2026-03-16 16:31:40.801563 | 2026-03-16 16:31:40.801650 | TASK [add-fileserver : Add fileserver ssh key] 2026-03-16 16:31:41.931342 | localhost | Identity added: /var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/tmp/ansible.kmvd6u_z (/var/lib/zuul/builds/941ecb86a10c46a5a3114da087b0b414/work/tmp/ansible.kmvd6u_z) 2026-03-16 16:31:41.931558 | localhost | ok: Runtime: 0:00:00.023745 2026-03-16 16:31:41.935796 | 2026-03-16 16:31:41.935866 | TASK [add-fileserver : Remove SSH private key from disk] 2026-03-16 16:31:43.134476 | localhost | ok: Runtime: 0:00:00.026210 2026-03-16 16:31:43.139151 | 2026-03-16 16:31:43.139223 | TASK [add-fileserver : Add fileserver to inventory] 2026-03-16 16:31:43.486191 | localhost | changed 2026-03-16 16:31:43.490713 | 2026-03-16 16:31:43.490788 | TASK [add-fileserver : Add fileserver server to known hosts] 2026-03-16 16:31:45.038343 | localhost | changed 2026-03-16 16:31:45.241342 | 2026-03-16 16:31:45.241444 | PLAY [localhost] 2026-03-16 16:31:45.278541 | 2026-03-16 16:31:45.278638 | TASK [Generate bulk log download script] 2026-03-16 16:31:45.325471 | localhost | ok 2026-03-16 16:31:45.376615 | 2026-03-16 16:31:45.376728 | TASK [local-log-download : Check API endpoint is defined] 2026-03-16 16:31:45.497034 | localhost | ok: All assertions passed 2026-03-16 16:31:45.501641 | 2026-03-16 16:31:45.501709 | TASK [local-log-download : Create download script] 2026-03-16 16:31:46.851789 | localhost -> localhost | changed 2026-03-16 16:31:46.863468 | 2026-03-16 16:31:46.863537 | TASK [Register quick-download link] 2026-03-16 16:31:46.943081 | localhost | ok 2026-03-16 16:31:46.967890 | 2026-03-16 16:31:46.967949 | PLAY [logserver.rdoproject.org] 2026-03-16 16:31:47.000829 | 2026-03-16 16:31:47.000900 | TASK [Set zuul-log-path fact] 2026-03-16 16:31:47.053698 | logserver.rdoproject.org | ok 2026-03-16 16:31:47.078118 | 2026-03-16 16:31:47.078222 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:31:47.151813 | logserver.rdoproject.org | ok 2026-03-16 16:31:47.157730 | 2026-03-16 16:31:47.157820 | TASK [upload-logs : Create log directories] 2026-03-16 16:31:49.093006 | logserver.rdoproject.org | changed 2026-03-16 16:31:49.097803 | 2026-03-16 16:31:49.097878 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-16 16:31:49.896715 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.020733 2026-03-16 16:31:49.903429 | 2026-03-16 16:31:49.903552 | TASK [upload-logs : Upload logs to log server] 2026-03-16 16:31:52.267018 | logserver.rdoproject.org | Output suppressed because no_log was given 2026-03-16 16:31:52.270122 | 2026-03-16 16:31:52.270188 | LOOP [upload-logs : Compress console log and json output] 2026-03-16 16:31:52.365811 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:31:52.366575 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:31:52.371583 | 2026-03-16 16:31:52.371654 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-16 16:31:52.548917 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:31:52.549246 | 2026-03-16 16:31:52.552058 | logserver.rdoproject.org | skipping: Conditional result was False 2026-03-16 16:31:52.563970 | 2026-03-16 16:31:52.564056 | LOOP [upload-logs : Upload console log and json output]