2025-10-13 07:06:57.711665 | Job console starting... 2025-10-13 07:06:57.724038 | Updating repositories 2025-10-13 07:06:57.939729 | Preparing job workspace 2025-10-13 07:07:13.857009 | Running Ansible setup... 2025-10-13 07:07:17.838086 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-13 07:07:18.474993 | 2025-10-13 07:07:18.475143 | PLAY [localhost] 2025-10-13 07:07:18.484619 | 2025-10-13 07:07:18.484688 | TASK [Gathering Facts] 2025-10-13 07:07:19.572986 | localhost | ok 2025-10-13 07:07:19.601084 | 2025-10-13 07:07:19.601264 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-13 07:07:20.101233 | localhost -> localhost | changed 2025-10-13 07:07:20.113708 | 2025-10-13 07:07:20.113858 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-13 07:07:21.099157 | localhost -> localhost | changed 2025-10-13 07:07:21.108720 | 2025-10-13 07:07:21.108834 | TASK [Setup log path fact] 2025-10-13 07:07:21.135785 | localhost | ok 2025-10-13 07:07:21.147092 | 2025-10-13 07:07:21.147155 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-13 07:07:21.185894 | localhost | ok 2025-10-13 07:07:21.193037 | 2025-10-13 07:07:21.193098 | TASK [emit-job-header : Print job information] 2025-10-13 07:07:21.245071 | # Job Information 2025-10-13 07:07:21.245414 | Ansible Version: 2.15.12 2025-10-13 07:07:21.245479 | Job: openstack-k8s-operators-content-provider 2025-10-13 07:07:21.245522 | Pipeline: github-check 2025-10-13 07:07:21.245560 | Executor: ze01.softwarefactory-project.io 2025-10-13 07:07:21.245596 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237 2025-10-13 07:07:21.245634 | Log URL (when completed): https://logserver.rdoproject.org/5df/rdoproject.org/5df7fbee49684e7d90b5af3b3b3621ef/ 2025-10-13 07:07:21.245671 | Event ID: 07b5c7c0-a802-11f0-8dbe-38d1533757a8 2025-10-13 07:07:21.253572 | 2025-10-13 07:07:21.253730 | LOOP [emit-job-header : Print node information] 2025-10-13 07:07:21.402402 | localhost | ok: 2025-10-13 07:07:21.402723 | localhost | # Node Information 2025-10-13 07:07:21.402759 | localhost | Inventory Hostname: controller 2025-10-13 07:07:21.402782 | localhost | Hostname: np0005482712 2025-10-13 07:07:21.402801 | localhost | Username: zuul 2025-10-13 07:07:21.402821 | localhost | Distro: CentOS 9 2025-10-13 07:07:21.402838 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-13 07:07:21.402855 | localhost | Region: RegionOne 2025-10-13 07:07:21.402871 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost 2025-10-13 07:07:21.402887 | localhost | Product Name: OpenStack Nova 2025-10-13 07:07:21.402903 | localhost | Interface IP: 38.102.83.153 2025-10-13 07:07:21.431295 | 2025-10-13 07:07:21.431403 | PLAY [all] 2025-10-13 07:07:21.438209 | 2025-10-13 07:07:21.438290 | TASK [Gather network facts] 2025-10-13 07:07:21.945903 | controller | ok 2025-10-13 07:07:21.979441 | 2025-10-13 07:07:21.979592 | TASK [include_role : start-zuul-console] 2025-10-13 07:07:22.001636 | controller | ok 2025-10-13 07:07:22.024185 | 2025-10-13 07:07:22.024416 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-13 07:07:22.458312 | controller | ok 2025-10-13 07:07:22.479756 | 2025-10-13 07:07:22.479926 | TASK [include_role : add-build-sshkey] 2025-10-13 07:07:22.517835 | controller | ok 2025-10-13 07:07:22.545528 | 2025-10-13 07:07:22.545663 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-13 07:07:22.795055 | controller -> localhost | ok 2025-10-13 07:07:22.807202 | 2025-10-13 07:07:22.807377 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-13 07:07:22.839343 | controller | ok 2025-10-13 07:07:22.852358 | controller | included: /var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-13 07:07:22.858047 | 2025-10-13 07:07:22.858110 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-13 07:07:23.782481 | controller -> localhost | Generating public/private rsa key pair. 2025-10-13 07:07:23.782727 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/5df7fbee49684e7d90b5af3b3b3621ef_id_rsa. 2025-10-13 07:07:23.782763 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/5df7fbee49684e7d90b5af3b3b3621ef_id_rsa.pub. 2025-10-13 07:07:23.782788 | controller -> localhost | The key fingerprint is: 2025-10-13 07:07:23.782811 | controller -> localhost | SHA256:D9/0k1sR6Ky+TDncTMMSv9tXDlelGs9+n4MzqLMxAfg zuul-build-sshkey 2025-10-13 07:07:23.782834 | controller -> localhost | The key's randomart image is: 2025-10-13 07:07:23.782856 | controller -> localhost | +---[RSA 3072]----+ 2025-10-13 07:07:23.782877 | controller -> localhost | | | 2025-10-13 07:07:23.782898 | controller -> localhost | | . . .| 2025-10-13 07:07:23.782920 | controller -> localhost | | . . . . o.| 2025-10-13 07:07:23.782941 | controller -> localhost | | . . B . o| 2025-10-13 07:07:23.782962 | controller -> localhost | | ES. ..% ..| 2025-10-13 07:07:23.782982 | controller -> localhost | | +ooO.*.+| 2025-10-13 07:07:23.783003 | controller -> localhost | | oo*o==+o| 2025-10-13 07:07:23.783080 | controller -> localhost | | .*..++==| 2025-10-13 07:07:23.783109 | controller -> localhost | | o++..++=| 2025-10-13 07:07:23.783132 | controller -> localhost | +----[SHA256]-----+ 2025-10-13 07:07:23.783188 | controller -> localhost | ok: Runtime: 0:00:00.523787 2025-10-13 07:07:23.790983 | 2025-10-13 07:07:23.791147 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-13 07:07:23.813542 | controller | ok 2025-10-13 07:07:23.832466 | controller | included: /var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-13 07:07:23.842619 | 2025-10-13 07:07:23.842721 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-13 07:07:23.856944 | controller | skipping: Conditional result was False 2025-10-13 07:07:23.864312 | 2025-10-13 07:07:23.864422 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-13 07:07:24.385470 | controller | changed 2025-10-13 07:07:24.396945 | 2025-10-13 07:07:24.397126 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-13 07:07:24.656523 | controller | ok 2025-10-13 07:07:24.673910 | 2025-10-13 07:07:24.674116 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-13 07:07:25.674951 | controller | changed 2025-10-13 07:07:25.691982 | 2025-10-13 07:07:25.692204 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-13 07:07:26.601333 | controller | changed 2025-10-13 07:07:26.613405 | 2025-10-13 07:07:26.613550 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-13 07:07:26.630896 | controller | skipping: Conditional result was False 2025-10-13 07:07:26.647457 | 2025-10-13 07:07:26.647666 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-13 07:07:27.043323 | controller -> localhost | changed 2025-10-13 07:07:27.055752 | 2025-10-13 07:07:27.055861 | TASK [add-build-sshkey : Add back temp key] 2025-10-13 07:07:27.435877 | controller -> localhost | Identity added: /var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/5df7fbee49684e7d90b5af3b3b3621ef_id_rsa (zuul-build-sshkey) 2025-10-13 07:07:27.436127 | controller -> localhost | ok: Runtime: 0:00:00.017613 2025-10-13 07:07:27.446203 | 2025-10-13 07:07:27.446312 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-13 07:07:27.868427 | controller | ok 2025-10-13 07:07:27.878887 | 2025-10-13 07:07:27.879044 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-13 07:07:27.916703 | controller | skipping: Conditional result was False 2025-10-13 07:07:27.926539 | 2025-10-13 07:07:27.926611 | TASK [include_role : validate-host] 2025-10-13 07:07:27.955176 | controller | ok 2025-10-13 07:07:27.999968 | 2025-10-13 07:07:28.000097 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-13 07:07:28.039239 | controller | ok 2025-10-13 07:07:28.044419 | 2025-10-13 07:07:28.044481 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-13 07:07:28.312823 | controller -> localhost | ok 2025-10-13 07:07:28.327940 | 2025-10-13 07:07:28.328154 | TASK [validate-host : Collect information about the host] 2025-10-13 07:07:29.120238 | controller | ok 2025-10-13 07:07:29.130528 | 2025-10-13 07:07:29.130628 | TASK [validate-host : Sanitize hostname] 2025-10-13 07:07:29.192379 | controller | ok 2025-10-13 07:07:29.197801 | 2025-10-13 07:07:29.197881 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-13 07:07:29.700622 | controller -> localhost | changed 2025-10-13 07:07:29.710956 | 2025-10-13 07:07:29.711100 | TASK [validate-host : Collect information about zuul worker] 2025-10-13 07:07:30.166823 | controller | ok 2025-10-13 07:07:30.178612 | 2025-10-13 07:07:30.178747 | TASK [validate-host : Write out all zuul information for each host] 2025-10-13 07:07:30.730123 | controller -> localhost | changed 2025-10-13 07:07:30.740859 | 2025-10-13 07:07:30.740999 | TASK [include_role : prepare-workspace-openshift] 2025-10-13 07:07:30.778682 | controller | skipping: Conditional result was False 2025-10-13 07:07:30.784518 | 2025-10-13 07:07:30.788418 | TASK [include_role : remove-zuul-sshkey] 2025-10-13 07:07:30.833010 | controller | skipping: Conditional result was False 2025-10-13 07:07:30.838542 | 2025-10-13 07:07:30.838625 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-13 07:07:31.089576 | controller | ok: "logs" 2025-10-13 07:07:31.089921 | controller | ok: All items complete 2025-10-13 07:07:31.089954 | 2025-10-13 07:07:31.313736 | controller | ok: "artifacts" 2025-10-13 07:07:31.564422 | controller | ok: "docs" 2025-10-13 07:07:31.586748 | 2025-10-13 07:07:31.586945 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-13 07:07:31.861663 | controller | changed: "logs" 2025-10-13 07:07:32.134095 | controller | changed: "artifacts" 2025-10-13 07:07:32.352485 | controller | changed: "docs" 2025-10-13 07:07:32.400483 | 2025-10-13 07:07:32.400611 | PLAY RECAP 2025-10-13 07:07:32.400669 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-13 07:07:32.400706 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-13 07:07:32.400732 | 2025-10-13 07:07:32.508062 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-13 07:07:32.508763 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-13 07:07:33.101189 | 2025-10-13 07:07:33.101310 | PLAY [all] 2025-10-13 07:07:33.122525 | 2025-10-13 07:07:33.122618 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-13 07:07:33.173066 | controller | ok 2025-10-13 07:07:33.177927 | 2025-10-13 07:07:33.178005 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-13 07:07:33.662142 | controller | changed 2025-10-13 07:07:33.678044 | 2025-10-13 07:07:33.678254 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-13 07:07:34.940787 | controller | changed 2025-10-13 07:07:34.954745 | 2025-10-13 07:07:34.954866 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-13 07:07:35.445140 | controller | changed: 2025-10-13 07:07:35.445507 | controller | { 2025-10-13 07:07:35.445664 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-13 07:07:35.445737 | controller | } 2025-10-13 07:07:35.772546 | controller | changed: 2025-10-13 07:07:35.772943 | controller | { 2025-10-13 07:07:35.773156 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-13 07:07:35.773261 | controller | } 2025-10-13 07:07:36.054353 | controller | changed: 2025-10-13 07:07:36.054516 | controller | { 2025-10-13 07:07:36.054568 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-10-13 07:07:36.054608 | controller | } 2025-10-13 07:07:36.319548 | controller | changed: 2025-10-13 07:07:36.319720 | controller | { 2025-10-13 07:07:36.319774 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-13 07:07:36.319815 | controller | } 2025-10-13 07:07:36.610523 | controller | changed: 2025-10-13 07:07:36.610683 | controller | { 2025-10-13 07:07:36.610734 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-13 07:07:36.610775 | controller | } 2025-10-13 07:07:36.898721 | controller | changed: 2025-10-13 07:07:36.898884 | controller | { 2025-10-13 07:07:36.898936 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-13 07:07:36.898977 | controller | } 2025-10-13 07:07:37.225249 | controller | changed: 2025-10-13 07:07:37.225410 | controller | { 2025-10-13 07:07:37.225462 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2025-10-13 07:07:37.225504 | controller | } 2025-10-13 07:07:37.495174 | controller | changed: 2025-10-13 07:07:37.495333 | controller | { 2025-10-13 07:07:37.495386 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2025-10-13 07:07:37.495430 | controller | } 2025-10-13 07:07:37.813654 | controller | changed: 2025-10-13 07:07:37.813930 | controller | { 2025-10-13 07:07:37.813991 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-13 07:07:37.814068 | controller | } 2025-10-13 07:07:38.116949 | controller | changed: 2025-10-13 07:07:38.117159 | controller | { 2025-10-13 07:07:38.117212 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-13 07:07:38.117252 | controller | } 2025-10-13 07:07:38.428391 | controller | changed: 2025-10-13 07:07:38.428512 | controller | { 2025-10-13 07:07:38.428546 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-13 07:07:38.428573 | controller | } 2025-10-13 07:07:38.705339 | controller | changed: 2025-10-13 07:07:38.705487 | controller | { 2025-10-13 07:07:38.705537 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-13 07:07:38.705580 | controller | } 2025-10-13 07:07:38.954639 | controller | changed: 2025-10-13 07:07:38.954792 | controller | { 2025-10-13 07:07:38.954840 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-13 07:07:38.954881 | controller | } 2025-10-13 07:07:39.239043 | controller | changed: 2025-10-13 07:07:39.239216 | controller | { 2025-10-13 07:07:39.239300 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-13 07:07:39.239342 | controller | } 2025-10-13 07:07:39.551906 | controller | changed: 2025-10-13 07:07:39.552126 | controller | { 2025-10-13 07:07:39.552183 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-13 07:07:39.552224 | controller | } 2025-10-13 07:07:39.821964 | controller | changed: 2025-10-13 07:07:39.826813 | controller | { 2025-10-13 07:07:39.826938 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-13 07:07:39.826987 | controller | } 2025-10-13 07:07:40.115882 | controller | changed: 2025-10-13 07:07:40.116095 | controller | { 2025-10-13 07:07:40.116150 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2025-10-13 07:07:40.116192 | controller | } 2025-10-13 07:07:40.390709 | controller | changed: 2025-10-13 07:07:40.390875 | controller | { 2025-10-13 07:07:40.390930 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2025-10-13 07:07:40.390988 | controller | } 2025-10-13 07:07:40.700164 | controller | changed: 2025-10-13 07:07:40.700401 | controller | { 2025-10-13 07:07:40.700454 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-13 07:07:40.700493 | controller | } 2025-10-13 07:07:41.003386 | controller | changed: 2025-10-13 07:07:41.007332 | controller | { 2025-10-13 07:07:41.007451 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-13 07:07:41.007485 | controller | } 2025-10-13 07:07:41.285876 | controller | changed: 2025-10-13 07:07:41.288818 | controller | { 2025-10-13 07:07:41.288885 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-13 07:07:41.288910 | controller | } 2025-10-13 07:07:41.610932 | controller | changed: 2025-10-13 07:07:41.611169 | controller | { 2025-10-13 07:07:41.611226 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-13 07:07:41.611266 | controller | } 2025-10-13 07:07:41.873286 | controller | changed: 2025-10-13 07:07:41.873454 | controller | { 2025-10-13 07:07:41.873508 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2025-10-13 07:07:41.873552 | controller | } 2025-10-13 07:07:42.134874 | controller | changed: 2025-10-13 07:07:42.135230 | controller | { 2025-10-13 07:07:42.135306 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-13 07:07:42.135366 | controller | } 2025-10-13 07:07:42.384242 | controller | changed: 2025-10-13 07:07:42.384391 | controller | { 2025-10-13 07:07:42.384442 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-13 07:07:42.384489 | controller | } 2025-10-13 07:07:42.650494 | controller | changed: 2025-10-13 07:07:42.650744 | controller | { 2025-10-13 07:07:42.650804 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-13 07:07:42.650847 | controller | } 2025-10-13 07:07:42.685938 | 2025-10-13 07:07:42.686110 | TASK [Set timezone to UTC] 2025-10-13 07:07:43.314969 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-13 07:07:43.330291 | 2025-10-13 07:07:43.330473 | TASK [Create nodepool directory] 2025-10-13 07:07:43.675690 | controller | changed 2025-10-13 07:07:43.681649 | 2025-10-13 07:07:43.681718 | TASK [Create nodepool sub_nodes file] 2025-10-13 07:07:44.461520 | controller | changed 2025-10-13 07:07:44.473121 | 2025-10-13 07:07:44.473266 | TASK [Create nodepool sub_nodes_private file] 2025-10-13 07:07:45.315975 | controller | changed 2025-10-13 07:07:45.321296 | 2025-10-13 07:07:45.321406 | LOOP [Populate nodepool sub_nodes file] 2025-10-13 07:07:45.366552 | 2025-10-13 07:07:45.366839 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-13 07:07:45.409215 | 2025-10-13 07:07:45.409371 | TASK [Create nodepool primary file] 2025-10-13 07:07:45.432992 | controller | skipping: Conditional result was False 2025-10-13 07:07:45.438770 | 2025-10-13 07:07:45.438880 | TASK [Create nodepool node_private for this node] 2025-10-13 07:07:46.354366 | controller | changed 2025-10-13 07:07:46.371053 | 2025-10-13 07:07:46.371207 | LOOP [Copy ssh keys to nodepool directory] 2025-10-13 07:07:46.828186 | controller | ok: Item: id_rsa Runtime: 0:00:00.007136 2025-10-13 07:07:46.828574 | 2025-10-13 07:07:47.044809 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.007511 2025-10-13 07:07:47.054802 | 2025-10-13 07:07:47.054932 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-13 07:07:47.924259 | controller | changed 2025-10-13 07:07:47.941486 | 2025-10-13 07:07:47.941595 | TASK [Validate sudoers config after edits] 2025-10-13 07:07:48.324621 | controller | /etc/sudoers: parsed OK 2025-10-13 07:07:48.324718 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-13 07:07:48.324850 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-13 07:07:48.324875 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-13 07:07:48.491563 | controller | ok: Runtime: 0:00:00.008643 2025-10-13 07:07:48.504072 | 2025-10-13 07:07:48.504220 | TASK [Show the environment passed in to job shell scripts] 2025-10-13 07:07:48.843760 | controller | SHELL=/bin/bash 2025-10-13 07:07:48.843855 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-13 07:07:48.843874 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-13 07:07:48.843889 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/b7deffb48ede63961bc321fbc461da66a70c6d19 2025-10-13 07:07:48.843903 | controller | PWD=/home/zuul 2025-10-13 07:07:48.843917 | controller | ZUUL_PIPELINE=github-check 2025-10-13 07:07:48.843930 | controller | LOGNAME=zuul 2025-10-13 07:07:48.843943 | controller | XDG_SESSION_TYPE=tty 2025-10-13 07:07:48.843956 | controller | _=/usr/bin/env 2025-10-13 07:07:48.843970 | controller | MOTD_SHOWN=pam 2025-10-13 07:07:48.844041 | controller | HOME=/home/zuul 2025-10-13 07:07:48.844057 | controller | LANG=en_US.UTF-8 2025-10-13 07:07:48.844070 | controller | SSH_CONNECTION=38.102.83.114 34600 38.102.83.153 22 2025-10-13 07:07:48.844083 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2025-10-13 07:07:48.844104 | controller | ZUUL_CHANGE_IDS=3237,b7deffb48ede63961bc321fbc461da66a70c6d19 2025-10-13 07:07:48.844117 | controller | WORKSPACE=/home/zuul/workspace 2025-10-13 07:07:48.844131 | controller | XDG_SESSION_CLASS=user 2025-10-13 07:07:48.844144 | controller | SELINUX_ROLE_REQUESTED= 2025-10-13 07:07:48.844157 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-13 07:07:48.844170 | controller | USER=zuul 2025-10-13 07:07:48.844184 | controller | ZUUL_VOTING=True 2025-10-13 07:07:48.844197 | controller | BUILD_TIMEOUT=1800000 2025-10-13 07:07:48.844210 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-13 07:07:48.844223 | controller | SHLVL=1 2025-10-13 07:07:48.844236 | controller | ZUUL_PATCHSET=b7deffb48ede63961bc321fbc461da66a70c6d19 2025-10-13 07:07:48.844249 | controller | XDG_SESSION_ID=1 2025-10-13 07:07:48.844262 | controller | ZUUL_BRANCH=main 2025-10-13 07:07:48.844276 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-13 07:07:48.844289 | controller | SSH_CLIENT=38.102.83.114 34600 22 2025-10-13 07:07:48.844303 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-13 07:07:48.844316 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-13 07:07:48.844332 | controller | which_declare=declare -f 2025-10-13 07:07:48.844346 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-13 07:07:48.844359 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-13 07:07:48.844372 | controller | ZUUL_CHANGE=3237 2025-10-13 07:07:48.844386 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-13 07:07:48.844399 | controller | ZUUL_UUID=5df7fbee49684e7d90b5af3b3b3621ef 2025-10-13 07:07:48.844412 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-13 07:07:48.844426 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-13 07:07:48.844439 | controller | } 2025-10-13 07:07:49.053206 | controller | ok: Runtime: 0:00:00.013209 2025-10-13 07:07:49.058584 | 2025-10-13 07:07:49.058650 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-13 07:07:49.072727 | controller | skipping: Conditional result was False 2025-10-13 07:07:49.079165 | 2025-10-13 07:07:49.079238 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-13 07:07:49.638179 | controller | skipping: Conditional result was False 2025-10-13 07:07:49.644385 | 2025-10-13 07:07:49.644464 | TASK [Ensure legacy workspace directory] 2025-10-13 07:07:49.892059 | controller | changed 2025-10-13 07:07:49.916158 | 2025-10-13 07:07:49.916286 | PLAY RECAP 2025-10-13 07:07:49.916333 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-13 07:07:49.916354 | 2025-10-13 07:07:50.015117 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-13 07:07:50.015849 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-13 07:07:50.729686 | 2025-10-13 07:07:50.729814 | PLAY [Get all repos on all hosts] 2025-10-13 07:07:50.752066 | 2025-10-13 07:07:50.752181 | TASK [Clone repos in the job workspace] 2025-10-13 07:07:50.802208 | controller | ok 2025-10-13 07:07:50.818706 | 2025-10-13 07:07:50.818822 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-13 07:07:51.200166 | controller | ok 2025-10-13 07:07:51.214237 | 2025-10-13 07:07:51.214389 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-13 07:08:09.499140 | controller | Output suppressed because no_log was given 2025-10-13 07:08:09.539088 | 2025-10-13 07:08:09.539223 | PLAY [Run ci/playbooks/e2e-prepare.yml] 2025-10-13 07:08:09.560380 | 2025-10-13 07:08:09.560471 | TASK [Read group_vars] 2025-10-13 07:08:09.583422 | controller | ok 2025-10-13 07:08:09.628212 | 2025-10-13 07:08:09.628336 | TASK [cifmw_helpers : Check directory is available] 2025-10-13 07:08:10.024738 | controller | ok 2025-10-13 07:08:10.038812 | 2025-10-13 07:08:10.039082 | TASK [cifmw_helpers : Print var] 2025-10-13 07:08:10.090804 | controller | ok: provide_var is /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars 2025-10-13 07:08:10.106074 | 2025-10-13 07:08:10.106822 | TASK [cifmw_helpers : List dir in ansible user home] 2025-10-13 07:08:10.534509 | controller | all.yml 2025-10-13 07:08:10.537057 | controller | molecule 2025-10-13 07:08:10.537084 | controller | all.yml 2025-10-13 07:08:10.539828 | controller | molecule 2025-10-13 07:08:10.539859 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied 2025-10-13 07:08:10.541678 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory 2025-10-13 07:08:10.650856 | controller | ERROR 2025-10-13 07:08:10.651109 | controller | { 2025-10-13 07:08:10.651185 | controller | "delta": "0:00:00.015709", 2025-10-13 07:08:10.651232 | controller | "end": "2025-10-13 07:08:10.542183", 2025-10-13 07:08:10.651277 | controller | "msg": "non-zero return code", 2025-10-13 07:08:10.651314 | controller | "rc": 2, 2025-10-13 07:08:10.651350 | controller | "start": "2025-10-13 07:08:10.526474" 2025-10-13 07:08:10.651384 | controller | } 2025-10-13 07:08:10.651437 | controller | ERROR: Ignoring Errors 2025-10-13 07:08:10.666763 | 2025-10-13 07:08:10.666964 | TASK [cifmw_helpers : List available files] 2025-10-13 07:08:11.217628 | controller | skipping: Conditional result was False 2025-10-13 07:08:11.230361 | 2025-10-13 07:08:11.230546 | LOOP [cifmw_helpers : Read vars] 2025-10-13 07:08:11.273544 | 2025-10-13 07:08:11.273872 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-13 07:08:11.330496 | 2025-10-13 07:08:11.330805 | TASK [Create zuul-output directory] 2025-10-13 07:08:11.696351 | controller | ok 2025-10-13 07:08:11.709283 | 2025-10-13 07:08:11.709462 | TASK [Install required packages] 2025-10-13 07:09:16.566959 | controller | changed 2025-10-13 07:09:16.580504 | 2025-10-13 07:09:16.580729 | TASK [Output pip related things] 2025-10-13 07:09:17.221430 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9) 2025-10-13 07:09:17.634482 | controller | changed 2025-10-13 07:09:17.643530 | 2025-10-13 07:09:17.643756 | TASK [Install requirements] 2025-10-13 07:10:24.242673 | controller | changed 2025-10-13 07:10:24.273640 | 2025-10-13 07:10:24.273795 | TASK [Add cronjob to trigger job stats] 2025-10-13 07:10:24.346028 | controller | skipping: Conditional result was False 2025-10-13 07:10:24.363796 | 2025-10-13 07:10:24.363986 | LOOP [Construct project change list] 2025-10-13 07:10:24.450941 | controller | ok: 2025-10-13 07:10:24.451358 | controller | { 2025-10-13 07:10:24.451417 | controller | "branch": "main", 2025-10-13 07:10:24.451464 | controller | "change": "3237", 2025-10-13 07:10:24.452418 | controller | "change_message": "WIP: Move common variable to group_vars: cifmw_project_dir & cifmw_project_dir_absolute\n\nThere is no need to parse path, or call filters etc. to get the same value. \r\nThis specific PR takes care of ci-framework repo src path (`cifmw_project_dir` and `cifmw_project_dir_absolute`) [Link](https://issues.redhat.com/browse/OSPRH-19599) for tracking.", 2025-10-13 07:10:24.452476 | controller | "change_url": "https://github.com/openstack-k8s-operators/ci-framework/pull/3237", 2025-10-13 07:10:24.452516 | controller | "commit_id": "b7deffb48ede63961bc321fbc461da66a70c6d19", 2025-10-13 07:10:24.452553 | controller | "patchset": "b7deffb48ede63961bc321fbc461da66a70c6d19", 2025-10-13 07:10:24.452589 | controller | "project": { 2025-10-13 07:10:24.452626 | controller | "canonical_hostname": "github.com", 2025-10-13 07:10:24.452661 | controller | "canonical_name": "github.com/openstack-k8s-operators/ci-framework", 2025-10-13 07:10:24.452695 | controller | "name": "openstack-k8s-operators/ci-framework", 2025-10-13 07:10:24.452730 | controller | "short_name": "ci-framework", 2025-10-13 07:10:24.452772 | controller | "src_dir": "src/github.com/openstack-k8s-operators/ci-framework" 2025-10-13 07:10:24.452943 | controller | }, 2025-10-13 07:10:24.452997 | controller | "topic": null 2025-10-13 07:10:24.453070 | controller | } 2025-10-13 07:10:24.453134 | 2025-10-13 07:10:24.552758 | 2025-10-13 07:10:24.552842 | PLAY [Run ci/playbooks/build_runner_image.yml] 2025-10-13 07:10:24.568296 | 2025-10-13 07:10:24.568372 | TASK [Filter out host if needed] 2025-10-13 07:10:24.579314 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-13 07:10:24.585198 | 2025-10-13 07:10:24.585261 | TASK [Get git tag for image tagging] 2025-10-13 07:10:25.119201 | controller | skipping: Conditional result was False 2025-10-13 07:10:25.133703 | 2025-10-13 07:10:25.133891 | TASK [Set openstack-runner image] 2025-10-13 07:10:25.164535 | controller | skipping: Conditional result was False 2025-10-13 07:10:25.182434 | 2025-10-13 07:10:25.182617 | TASK [Build openstack-runner image] 2025-10-13 07:10:25.221124 | controller | skipping: Conditional result was False 2025-10-13 07:10:25.230504 | 2025-10-13 07:10:25.230658 | TASK [Push openstack-runner image] 2025-10-13 07:10:25.255968 | controller | skipping: Conditional result was False 2025-10-13 07:10:25.264433 | 2025-10-13 07:10:25.264571 | TASK [Make sure ci-framework directory exists] 2025-10-13 07:10:25.289364 | controller | skipping: Conditional result was False 2025-10-13 07:10:25.295551 | 2025-10-13 07:10:25.295648 | TASK [Create EDPM ansible var file] 2025-10-13 07:10:25.319648 | controller | skipping: Conditional result was False 2025-10-13 07:10:25.347691 | 2025-10-13 07:10:25.347796 | PLAY RECAP 2025-10-13 07:10:25.347840 | controller | ok: 10 changed: 5 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 1 2025-10-13 07:10:25.347861 | 2025-10-13 07:10:25.461869 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-13 07:10:25.462849 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-13 07:10:26.063884 | 2025-10-13 07:10:26.064009 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-13 07:10:26.084791 | 2025-10-13 07:10:26.084870 | TASK [Create zuul-output directory] 2025-10-13 07:10:26.550792 | controller | changed 2025-10-13 07:10:26.563124 | 2025-10-13 07:10:26.563315 | TASK [Slurp Zuul inventory test] 2025-10-13 07:10:26.984474 | controller -> localhost | ok 2025-10-13 07:10:26.994110 | 2025-10-13 07:10:26.995359 | TASK [Save zuul inventory] 2025-10-13 07:10:28.191915 | controller | changed 2025-10-13 07:10:28.203100 | 2025-10-13 07:10:28.203264 | TASK [Save zuul vars without the change_message] 2025-10-13 07:10:29.130943 | controller | changed 2025-10-13 07:10:29.159068 | 2025-10-13 07:10:29.159150 | PLAY RECAP 2025-10-13 07:10:29.159210 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-13 07:10:29.159239 | 2025-10-13 07:10:29.288362 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-13 07:10:29.289150 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/pre.yml@main] 2025-10-13 07:10:29.820458 | 2025-10-13 07:10:29.820562 | PLAY [Get all repos on all hosts] 2025-10-13 07:10:29.840558 | 2025-10-13 07:10:29.840635 | TASK [Clone repos in the job workspace] 2025-10-13 07:10:29.859695 | controller | ok 2025-10-13 07:10:29.874601 | 2025-10-13 07:10:29.874677 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-13 07:10:30.312247 | controller | ok 2025-10-13 07:10:30.318411 | 2025-10-13 07:10:30.318500 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-13 07:10:32.042634 | controller | Output suppressed because no_log was given 2025-10-13 07:10:32.096614 | 2025-10-13 07:10:32.096715 | PLAY [Run ci/playbooks/content_provider/pre.yml] 2025-10-13 07:10:32.111946 | 2025-10-13 07:10:32.112080 | TASK [Filter out host if needed] 2025-10-13 07:10:32.122215 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-13 07:10:32.126929 | 2025-10-13 07:10:32.126988 | TASK [Install ansible-core] 2025-10-13 07:10:37.503497 | controller | changed 2025-10-13 07:10:37.516117 | 2025-10-13 07:10:37.516252 | TASK [Discover an IPv4 for provider job] 2025-10-13 07:10:37.582169 | controller | ok 2025-10-13 07:10:37.601382 | 2025-10-13 07:10:37.601489 | PLAY RECAP 2025-10-13 07:10:37.601532 | controller | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-13 07:10:37.601555 | 2025-10-13 07:10:37.722933 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/pre.yml@main] 2025-10-13 07:10:37.723748 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/run.yml@main] 2025-10-13 07:10:38.367618 | 2025-10-13 07:10:38.367737 | PLAY [Run ci/playbooks/content_provider/run.yml] 2025-10-13 07:10:38.389072 | 2025-10-13 07:10:38.389197 | TASK [Read group_vars] 2025-10-13 07:10:38.408720 | controller | ok 2025-10-13 07:10:38.427115 | 2025-10-13 07:10:38.427251 | TASK [cifmw_helpers : Check directory is available] 2025-10-13 07:10:38.792858 | controller | ok 2025-10-13 07:10:38.798354 | 2025-10-13 07:10:38.798424 | TASK [cifmw_helpers : Print var] 2025-10-13 07:10:38.827881 | controller | ok: provide_var is /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars 2025-10-13 07:10:38.833369 | 2025-10-13 07:10:38.833455 | TASK [cifmw_helpers : List dir in ansible user home] 2025-10-13 07:10:39.239599 | controller | all.yml 2025-10-13 07:10:39.241060 | controller | molecule 2025-10-13 07:10:39.241079 | controller | all.yml 2025-10-13 07:10:39.242612 | controller | molecule 2025-10-13 07:10:39.242638 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied 2025-10-13 07:10:39.244584 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory 2025-10-13 07:10:39.362726 | controller | ERROR 2025-10-13 07:10:39.362955 | controller | { 2025-10-13 07:10:39.363056 | controller | "delta": "0:00:00.012521", 2025-10-13 07:10:39.363114 | controller | "end": "2025-10-13 07:10:39.245114", 2025-10-13 07:10:39.363159 | controller | "msg": "non-zero return code", 2025-10-13 07:10:39.363208 | controller | "rc": 2, 2025-10-13 07:10:39.363250 | controller | "start": "2025-10-13 07:10:39.232593" 2025-10-13 07:10:39.363290 | controller | } 2025-10-13 07:10:39.363347 | controller | ERROR: Ignoring Errors 2025-10-13 07:10:39.377419 | 2025-10-13 07:10:39.377576 | TASK [cifmw_helpers : List available files] 2025-10-13 07:10:39.930723 | controller | skipping: Conditional result was False 2025-10-13 07:10:39.946425 | 2025-10-13 07:10:39.946702 | LOOP [cifmw_helpers : Read vars] 2025-10-13 07:10:39.990327 | 2025-10-13 07:10:39.990713 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-13 07:10:40.044101 | 2025-10-13 07:10:40.044471 | TASK [Filter out host if needed] 2025-10-13 07:10:40.064631 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-13 07:10:40.072596 | 2025-10-13 07:10:40.072771 | TASK [Deploy content provider] 2025-10-13 07:10:50.622545 | controller | ERROR 2025-10-13 07:10:50.622891 | controller | { 2025-10-13 07:10:50.622953 | controller | "msg": "The field 'environment' has an invalid value, which includes an undefined variable. The error was: 'cifmw_project_dir_absolute' is undefined. 'cifmw_project_dir_absolute' is undefined\n\nThe error appears to be in '/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/untrusted/project_0/github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/run.yml': line 25, column 7, but may\nbe elsewhere in the file depending on the exact syntax problem.\n\nThe offending line appears to be:\n\n\n - name: Deploy content provider\n ^ here\n" 2025-10-13 07:10:50.623000 | controller | } failure 2025-10-13 07:10:50.624884 | 2025-10-13 07:10:50.624977 | PLAY RECAP 2025-10-13 07:10:50.625086 | controller | ok: 3 changed: 1 unreachable: 0 failed: 1 skipped: 3 rescued: 0 ignored: 1 2025-10-13 07:10:50.625133 | 2025-10-13 07:10:50.739997 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/run.yml@main] 2025-10-13 07:10:50.741748 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-13 07:10:51.350538 | 2025-10-13 07:10:51.350649 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-13 07:10:51.370767 | 2025-10-13 07:10:51.370878 | TASK [Filter out host if needed] 2025-10-13 07:10:51.379568 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-13 07:10:51.384673 | 2025-10-13 07:10:51.384739 | TASK [Ensure file is present] 2025-10-13 07:10:51.828305 | controller | ok 2025-10-13 07:10:51.840433 | 2025-10-13 07:10:51.840578 | TASK [Manage molecule report file] 2025-10-13 07:10:52.390458 | controller | skipping: Conditional result was False 2025-10-13 07:10:52.396507 | 2025-10-13 07:10:52.396585 | TASK [Check if we get ci-framework-data basedir] 2025-10-13 07:10:52.653855 | controller | ok 2025-10-13 07:10:52.668745 | 2025-10-13 07:10:52.668990 | TASK [Create ci-framework-data log directory for zuul] 2025-10-13 07:10:53.055925 | controller | changed 2025-10-13 07:10:53.070799 | 2025-10-13 07:10:53.071232 | TASK [Copy ci-framework interesting files] 2025-10-13 07:10:53.491749 | controller | cp: cannot stat '/home/zuul/ci-framework-data/logs': No such file or directory 2025-10-13 07:10:53.498010 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-13 07:10:53.620818 | controller | changed 2025-10-13 07:10:53.632394 | 2025-10-13 07:10:53.632533 | TASK [Get SELinux listing] 2025-10-13 07:10:54.181343 | controller | changed 2025-10-13 07:10:54.189141 | 2025-10-13 07:10:54.189264 | TASK [Generate log index] 2025-10-13 07:10:55.167656 | controller | changed 2025-10-13 07:10:55.173354 | 2025-10-13 07:10:55.173426 | TASK [Get some env related data] 2025-10-13 07:10:55.869224 | controller | /home/zuul/.local/bin/ansible 2025-10-13 07:10:56.709415 | controller | changed 2025-10-13 07:10:56.722437 | 2025-10-13 07:10:56.722570 | TASK [Generate list of logs to collect in home directory] 2025-10-13 07:10:57.153483 | controller | ok: All paths examined 2025-10-13 07:10:57.161966 | 2025-10-13 07:10:57.162069 | LOOP [Copy logs from home directory] 2025-10-13 07:10:57.580298 | controller | changed: 2025-10-13 07:10:57.580763 | controller | { 2025-10-13 07:10:57.580802 | controller | "atime": 1760339404.8650165, 2025-10-13 07:10:57.580827 | controller | "ctime": 1760339423.5546334, 2025-10-13 07:10:57.580849 | controller | "dev": 64513, 2025-10-13 07:10:57.580869 | controller | "gid": 1000, 2025-10-13 07:10:57.580890 | controller | "gr_name": "zuul", 2025-10-13 07:10:57.580910 | controller | "inode": 4503875, 2025-10-13 07:10:57.580930 | controller | "isblk": false, 2025-10-13 07:10:57.580949 | controller | "ischr": false, 2025-10-13 07:10:57.580968 | controller | "isdir": false, 2025-10-13 07:10:57.580988 | controller | "isfifo": false, 2025-10-13 07:10:57.581009 | controller | "isgid": false, 2025-10-13 07:10:57.581050 | controller | "islnk": false, 2025-10-13 07:10:57.581072 | controller | "isreg": true, 2025-10-13 07:10:57.581091 | controller | "issock": false, 2025-10-13 07:10:57.581110 | controller | "isuid": false, 2025-10-13 07:10:57.581129 | controller | "mode": "0644", 2025-10-13 07:10:57.581148 | controller | "mtime": 1760339423.5546334, 2025-10-13 07:10:57.581168 | controller | "nlink": 1, 2025-10-13 07:10:57.581192 | controller | "path": "/home/zuul/ansible.log", 2025-10-13 07:10:57.581212 | controller | "pw_name": "zuul", 2025-10-13 07:10:57.581232 | controller | "rgrp": true, 2025-10-13 07:10:57.581252 | controller | "roth": true, 2025-10-13 07:10:57.581271 | controller | "rusr": true, 2025-10-13 07:10:57.581290 | controller | "size": 6749, 2025-10-13 07:10:57.581311 | controller | "uid": 1000, 2025-10-13 07:10:57.581332 | controller | "wgrp": false, 2025-10-13 07:10:57.581354 | controller | "woth": false, 2025-10-13 07:10:57.581375 | controller | "wusr": true, 2025-10-13 07:10:57.581395 | controller | "xgrp": false, 2025-10-13 07:10:57.581414 | controller | "xoth": false, 2025-10-13 07:10:57.581434 | controller | "xusr": false 2025-10-13 07:10:57.581453 | controller | } 2025-10-13 07:10:57.605100 | 2025-10-13 07:10:57.605289 | TASK [Copy crio stats log file] 2025-10-13 07:10:57.625714 | controller | skipping: Conditional result was False 2025-10-13 07:10:57.638860 | 2025-10-13 07:10:57.639002 | TASK [Get SELinux related data] 2025-10-13 07:10:57.929845 | controller | 2025-10-13 07:10:58.186743 | controller | ERROR 2025-10-13 07:10:58.187061 | controller | { 2025-10-13 07:10:58.187133 | controller | "delta": "0:00:00.018790", 2025-10-13 07:10:58.187189 | controller | "end": "2025-10-13 07:10:57.931026", 2025-10-13 07:10:58.187244 | controller | "msg": "non-zero return code", 2025-10-13 07:10:58.187298 | controller | "rc": 1, 2025-10-13 07:10:58.187338 | controller | "start": "2025-10-13 07:10:57.912236" 2025-10-13 07:10:58.187373 | controller | } 2025-10-13 07:10:58.187422 | controller | ERROR: Ignoring Errors 2025-10-13 07:10:58.199510 | 2025-10-13 07:10:58.199807 | TASK [Create system configuration directory] 2025-10-13 07:10:58.464390 | controller | changed 2025-10-13 07:10:58.477496 | 2025-10-13 07:10:58.477671 | TASK [Get some of the system configurations] 2025-10-13 07:10:59.028352 | controller | changed 2025-10-13 07:10:59.036240 | 2025-10-13 07:10:59.036339 | TASK [Copy generated documentation if available] 2025-10-13 07:10:59.062657 | controller | skipping: Conditional result was False 2025-10-13 07:10:59.076359 | 2025-10-13 07:10:59.076542 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-13 07:10:59.104132 | controller | skipping: Conditional result was False 2025-10-13 07:10:59.110577 | 2025-10-13 07:10:59.110643 | TASK [Compress logs bigger than 2MB] 2025-10-13 07:10:59.648136 | controller | changed 2025-10-13 07:10:59.655919 | 2025-10-13 07:10:59.656032 | TASK [Copy files from workspace on node] 2025-10-13 07:10:59.693899 | controller | ok 2025-10-13 07:10:59.748294 | 2025-10-13 07:10:59.748422 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-13 07:10:59.772760 | controller | skipping: Conditional result was False 2025-10-13 07:10:59.779249 | 2025-10-13 07:10:59.779330 | TASK [fetch-output : Set log path for single node] 2025-10-13 07:10:59.809425 | controller | ok 2025-10-13 07:10:59.815149 | 2025-10-13 07:10:59.815248 | LOOP [fetch-output : Ensure local output dirs] 2025-10-13 07:11:00.083877 | controller -> localhost | ok: "/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/logs" 2025-10-13 07:11:00.084395 | controller -> localhost | changed: All items complete 2025-10-13 07:11:00.084430 | 2025-10-13 07:11:00.353004 | controller -> localhost | changed: "/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/artifacts" 2025-10-13 07:11:00.581790 | controller -> localhost | changed: "/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/docs" 2025-10-13 07:11:00.598818 | 2025-10-13 07:11:00.598946 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-13 07:11:01.279432 | controller | changed: 2025-10-13 07:11:01.279810 | controller | .d..t...... ./ 2025-10-13 07:11:01.279886 | controller | >f+++++++++ README.html 2025-10-13 07:11:01.279978 | controller | >f+++++++++ ansible.log 2025-10-13 07:11:01.280103 | controller | >f+++++++++ dmesg.log 2025-10-13 07:11:01.280166 | controller | >f+++++++++ installed-pkgs.log 2025-10-13 07:11:01.280318 | controller | >f+++++++++ python.log 2025-10-13 07:11:01.280376 | controller | >f+++++++++ registries.conf 2025-10-13 07:11:01.280420 | controller | >f+++++++++ selinux-denials.log 2025-10-13 07:11:01.280467 | controller | >f+++++++++ selinux-listing.log 2025-10-13 07:11:01.280509 | controller | cd+++++++++ ci-framework-data/ 2025-10-13 07:11:01.280549 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-13 07:11:01.280589 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-13 07:11:01.280630 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-13 07:11:01.280669 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-13 07:11:01.280707 | controller | cd+++++++++ registries.conf.d/ 2025-10-13 07:11:01.280744 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-13 07:11:01.280781 | controller | cd+++++++++ system-config/ 2025-10-13 07:11:01.280818 | controller | cd+++++++++ system-config/libvirt/ 2025-10-13 07:11:01.280854 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-13 07:11:01.280891 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-13 07:11:01.818936 | controller | changed: .d..t...... ./ 2025-10-13 07:11:02.302266 | controller | changed: .d..t...... ./ 2025-10-13 07:11:02.326716 | 2025-10-13 07:11:02.326852 | TASK [Return artifact to Zuul] 2025-10-13 07:11:02.352373 | controller | skipping: Conditional result was False 2025-10-13 07:11:02.373625 | 2025-10-13 07:11:02.373705 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-13 07:11:02.373809 | 2025-10-13 07:11:02.373837 | PLAY RECAP 2025-10-13 07:11:02.373871 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-10-13 07:11:02.373892 | 2025-10-13 07:11:02.489235 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-13 07:11:02.489996 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-13 07:11:03.089691 | 2025-10-13 07:11:03.089815 | PLAY [all] 2025-10-13 07:11:03.110506 | 2025-10-13 07:11:03.110614 | TASK [include_role : fetch-output] 2025-10-13 07:11:03.139657 | controller | ok 2025-10-13 07:11:03.156384 | 2025-10-13 07:11:03.156488 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-13 07:11:03.221292 | controller | skipping: Conditional result was False 2025-10-13 07:11:03.227887 | 2025-10-13 07:11:03.227989 | TASK [fetch-output : Set log path for single node] 2025-10-13 07:11:03.260612 | controller | ok 2025-10-13 07:11:03.265792 | 2025-10-13 07:11:03.265859 | LOOP [fetch-output : Ensure local output dirs] 2025-10-13 07:11:03.685241 | controller -> localhost | ok: "/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/logs" 2025-10-13 07:11:03.929348 | controller -> localhost | ok: "/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/artifacts" 2025-10-13 07:11:04.189221 | controller -> localhost | ok: "/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/docs" 2025-10-13 07:11:04.214776 | 2025-10-13 07:11:04.214980 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-13 07:11:04.910376 | controller | ok 2025-10-13 07:11:04.910578 | controller | ok: All items complete 2025-10-13 07:11:04.910609 | 2025-10-13 07:11:05.446248 | controller | ok 2025-10-13 07:11:05.913981 | controller | ok 2025-10-13 07:11:05.949652 | 2025-10-13 07:11:05.949909 | TASK [include_role : fetch-output-openshift] 2025-10-13 07:11:05.980037 | controller | skipping: Conditional result was False 2025-10-13 07:11:05.993724 | 2025-10-13 07:11:05.993883 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-13 07:11:06.430927 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014143 2025-10-13 07:11:06.648740 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009250 2025-10-13 07:11:06.710995 | 2025-10-13 07:11:06.711151 | PLAY [all] 2025-10-13 07:11:06.733236 | 2025-10-13 07:11:06.733396 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-13 07:11:07.281364 | controller | changed 2025-10-13 07:11:07.320427 | 2025-10-13 07:11:07.320525 | PLAY RECAP 2025-10-13 07:11:07.320565 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-13 07:11:07.320585 | 2025-10-13 07:11:07.429913 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-13 07:11:07.430828 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-13 07:11:08.126085 | 2025-10-13 07:11:08.126217 | PLAY [localhost] 2025-10-13 07:11:08.144435 | 2025-10-13 07:11:08.144552 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-13 07:11:08.590679 | localhost | changed 2025-10-13 07:11:08.595949 | 2025-10-13 07:11:08.596066 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-13 07:11:08.641116 | localhost | ok 2025-10-13 07:11:08.651107 | 2025-10-13 07:11:08.651188 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-13 07:11:09.110854 | localhost | changed 2025-10-13 07:11:09.131392 | 2025-10-13 07:11:09.131574 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-13 07:11:09.874635 | localhost | changed 2025-10-13 07:11:09.880867 | 2025-10-13 07:11:09.880930 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-13 07:11:10.357216 | localhost | Identity added: /var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/tmp/ansible.16ntt5cl (/var/lib/zuul/builds/5df7fbee49684e7d90b5af3b3b3621ef/work/tmp/ansible.16ntt5cl) 2025-10-13 07:11:10.357418 | localhost | ok: Runtime: 0:00:00.007460 2025-10-13 07:11:10.361648 | 2025-10-13 07:11:10.361716 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-13 07:11:10.691688 | localhost | ok: Runtime: 0:00:00.005058 2025-10-13 07:11:10.701997 | 2025-10-13 07:11:10.702169 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-13 07:11:10.770687 | localhost | changed 2025-10-13 07:11:10.783891 | 2025-10-13 07:11:10.784140 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-13 07:11:11.243127 | localhost | changed 2025-10-13 07:11:11.288079 | 2025-10-13 07:11:11.288207 | PLAY [localhost] 2025-10-13 07:11:11.305566 | 2025-10-13 07:11:11.305682 | TASK [Generate bulk log download script] 2025-10-13 07:11:11.327301 | localhost | ok 2025-10-13 07:11:11.353104 | 2025-10-13 07:11:11.353285 | TASK [local-log-download : Check API endpoint is defined] 2025-10-13 07:11:11.399310 | localhost | ok: All assertions passed 2025-10-13 07:11:11.411930 | 2025-10-13 07:11:11.412138 | TASK [local-log-download : Create download script] 2025-10-13 07:11:11.920421 | localhost -> localhost | changed 2025-10-13 07:11:11.929247 | 2025-10-13 07:11:11.929316 | TASK [Register quick-download link] 2025-10-13 07:11:11.957404 | localhost | ok 2025-10-13 07:11:11.973309 | 2025-10-13 07:11:11.973366 | PLAY [logserver.rdoproject.org] 2025-10-13 07:11:11.983095 | 2025-10-13 07:11:11.983151 | TASK [Set zuul-log-path fact] 2025-10-13 07:11:11.998760 | logserver.rdoproject.org | ok 2025-10-13 07:11:12.007528 | 2025-10-13 07:11:12.007589 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-13 07:11:12.073728 | logserver.rdoproject.org | ok 2025-10-13 07:11:12.079329 | 2025-10-13 07:11:12.079415 | TASK [upload-logs : Create log directories] 2025-10-13 07:11:13.191588 | logserver.rdoproject.org | changed 2025-10-13 07:11:13.199091 | 2025-10-13 07:11:13.199252 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-13 07:11:13.554227 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.008216 2025-10-13 07:11:13.564383 | 2025-10-13 07:11:13.564526 | TASK [upload-logs : Upload logs to log server] 2025-10-13 07:11:14.274807 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-13 07:11:14.281859 | 2025-10-13 07:11:14.282071 | LOOP [upload-logs : Compress console log and json output] 2025-10-13 07:11:14.347640 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 07:11:14.356267 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 07:11:14.367451 | 2025-10-13 07:11:14.367589 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-13 07:11:14.412825 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 07:11:14.413266 | 2025-10-13 07:11:14.416719 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-13 07:11:14.433636 | 2025-10-13 07:11:14.433809 | LOOP [upload-logs : Upload console log and json output]