2025-10-10 08:40:54.485839 | Job console starting... 2025-10-10 08:40:54.725307 | Updating repositories 2025-10-10 08:40:55.489932 | Preparing job workspace 2025-10-10 08:41:02.830598 | Running Ansible setup... 2025-10-10 08:41:05.839890 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-10 08:41:06.384565 | 2025-10-10 08:41:06.384701 | PLAY [localhost] 2025-10-10 08:41:06.394182 | 2025-10-10 08:41:06.394265 | TASK [Gathering Facts] 2025-10-10 08:41:07.221172 | localhost | ok 2025-10-10 08:41:07.234419 | 2025-10-10 08:41:07.234498 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-10 08:41:07.552181 | localhost -> localhost | changed 2025-10-10 08:41:07.557868 | 2025-10-10 08:41:07.557975 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-10 08:41:08.330963 | localhost -> localhost | changed 2025-10-10 08:41:08.339555 | 2025-10-10 08:41:08.339630 | TASK [Setup log path fact] 2025-10-10 08:41:08.357550 | localhost | ok 2025-10-10 08:41:08.368773 | 2025-10-10 08:41:08.368844 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 08:41:08.396111 | localhost | ok 2025-10-10 08:41:08.403879 | 2025-10-10 08:41:08.403965 | TASK [emit-job-header : Print job information] 2025-10-10 08:41:08.431390 | # Job Information 2025-10-10 08:41:08.431696 | Ansible Version: 2.15.12 2025-10-10 08:41:08.431737 | Job: cifmw-molecule-pkg_build 2025-10-10 08:41:08.431763 | Pipeline: github-check 2025-10-10 08:41:08.431783 | Executor: ibm-bm4-ze.softwarefactory-project.io 2025-10-10 08:41:08.431802 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3368 2025-10-10 08:41:08.431820 | Log URL (when completed): https://logserver.rdoproject.org/c3a/rdoproject.org/c3a2293fdd2e43de8e42eca855a87099/ 2025-10-10 08:41:08.431839 | Event ID: dc051e10-a5b2-11f0-8a63-96c3b7c31c2e 2025-10-10 08:41:08.435452 | 2025-10-10 08:41:08.435520 | LOOP [emit-job-header : Print node information] 2025-10-10 08:41:08.523746 | localhost | ok: 2025-10-10 08:41:08.524010 | localhost | # Node Information 2025-10-10 08:41:08.524043 | localhost | Inventory Hostname: controller 2025-10-10 08:41:08.524070 | localhost | Hostname: np0005479760 2025-10-10 08:41:08.524091 | localhost | Username: zuul 2025-10-10 08:41:08.524110 | localhost | Distro: CentOS 9 2025-10-10 08:41:08.524127 | localhost | Provider: ibm-bm4-nodepool 2025-10-10 08:41:08.524143 | localhost | Region: regionOne 2025-10-10 08:41:08.524158 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2025-10-10 08:41:08.524177 | localhost | Product Name: OpenStack Compute 2025-10-10 08:41:08.524194 | localhost | Interface IP: 192.168.26.18 2025-10-10 08:41:08.550539 | 2025-10-10 08:41:08.550651 | PLAY [all] 2025-10-10 08:41:08.557273 | 2025-10-10 08:41:08.557343 | TASK [Gather network facts] 2025-10-10 08:41:08.931120 | controller | ok 2025-10-10 08:41:08.945365 | 2025-10-10 08:41:08.945431 | TASK [include_role : start-zuul-console] 2025-10-10 08:41:08.963179 | controller | ok 2025-10-10 08:41:08.975198 | 2025-10-10 08:41:08.975264 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-10 08:41:09.299756 | controller | ok 2025-10-10 08:41:09.307869 | 2025-10-10 08:41:09.307964 | TASK [include_role : add-build-sshkey] 2025-10-10 08:41:09.325201 | controller | ok 2025-10-10 08:41:09.337560 | 2025-10-10 08:41:09.337631 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-10 08:41:09.546557 | controller -> localhost | ok 2025-10-10 08:41:09.551677 | 2025-10-10 08:41:09.551747 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-10 08:41:09.569410 | controller | ok 2025-10-10 08:41:09.582231 | controller | included: /var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-10 08:41:09.587819 | 2025-10-10 08:41:09.587882 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-10 08:41:10.274828 | controller -> localhost | Generating public/private rsa key pair. 2025-10-10 08:41:10.275013 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/c3a2293fdd2e43de8e42eca855a87099_id_rsa. 2025-10-10 08:41:10.275050 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/c3a2293fdd2e43de8e42eca855a87099_id_rsa.pub. 2025-10-10 08:41:10.275076 | controller -> localhost | The key fingerprint is: 2025-10-10 08:41:10.275098 | controller -> localhost | SHA256:PI1AvM9HRfWL8Cm1+he5UYHVvSbH6DCJD1rtMnNFTHw zuul-build-sshkey 2025-10-10 08:41:10.275118 | controller -> localhost | The key's randomart image is: 2025-10-10 08:41:10.275136 | controller -> localhost | +---[RSA 3072]----+ 2025-10-10 08:41:10.275155 | controller -> localhost | | .. .=o+.o| 2025-10-10 08:41:10.275174 | controller -> localhost | | .. .= Eo| 2025-10-10 08:41:10.275204 | controller -> localhost | | .. ooo.+ +| 2025-10-10 08:41:10.275229 | controller -> localhost | | .o *.=+++=o| 2025-10-10 08:41:10.275249 | controller -> localhost | | oS.=.==+.o| 2025-10-10 08:41:10.275267 | controller -> localhost | | .o=.+o. + | 2025-10-10 08:41:10.275285 | controller -> localhost | | .=. +| 2025-10-10 08:41:10.275306 | controller -> localhost | | . o | 2025-10-10 08:41:10.275323 | controller -> localhost | | .. | 2025-10-10 08:41:10.275340 | controller -> localhost | +----[SHA256]-----+ 2025-10-10 08:41:10.275379 | controller -> localhost | ok: Runtime: 0:00:00.344123 2025-10-10 08:41:10.280809 | 2025-10-10 08:41:10.280877 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-10 08:41:10.297781 | controller | ok 2025-10-10 08:41:10.307194 | controller | included: /var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-10 08:41:10.315311 | 2025-10-10 08:41:10.315471 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-10 08:41:10.328505 | controller | skipping: Conditional result was False 2025-10-10 08:41:10.333535 | 2025-10-10 08:41:10.333599 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-10 08:41:10.716134 | controller | changed 2025-10-10 08:41:10.720759 | 2025-10-10 08:41:10.720823 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-10 08:41:10.912679 | controller | ok 2025-10-10 08:41:10.918306 | 2025-10-10 08:41:10.918378 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-10 08:41:11.529521 | controller | changed 2025-10-10 08:41:11.534699 | 2025-10-10 08:41:11.534764 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-10 08:41:12.120259 | controller | changed 2025-10-10 08:41:12.125745 | 2025-10-10 08:41:12.125810 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-10 08:41:12.150385 | controller | skipping: Conditional result was False 2025-10-10 08:41:12.155734 | 2025-10-10 08:41:12.155801 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-10 08:41:12.515238 | controller -> localhost | changed 2025-10-10 08:41:12.526721 | 2025-10-10 08:41:12.526811 | TASK [add-build-sshkey : Add back temp key] 2025-10-10 08:41:12.753885 | controller -> localhost | Identity added: /var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/c3a2293fdd2e43de8e42eca855a87099_id_rsa (zuul-build-sshkey) 2025-10-10 08:41:12.754158 | controller -> localhost | ok: Runtime: 0:00:00.008228 2025-10-10 08:41:12.760398 | 2025-10-10 08:41:12.760472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-10 08:41:13.062628 | controller | ok 2025-10-10 08:41:13.067675 | 2025-10-10 08:41:13.067748 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-10 08:41:13.091773 | controller | skipping: Conditional result was False 2025-10-10 08:41:13.101362 | 2025-10-10 08:41:13.101453 | TASK [include_role : validate-host] 2025-10-10 08:41:13.120159 | controller | ok 2025-10-10 08:41:13.139700 | 2025-10-10 08:41:13.139775 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-10 08:41:13.168210 | controller | ok 2025-10-10 08:41:13.172736 | 2025-10-10 08:41:13.172816 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-10 08:41:13.379046 | controller -> localhost | ok 2025-10-10 08:41:13.384999 | 2025-10-10 08:41:13.385082 | TASK [validate-host : Collect information about the host] 2025-10-10 08:41:13.992434 | controller | ok 2025-10-10 08:41:14.000367 | 2025-10-10 08:41:14.000432 | TASK [validate-host : Sanitize hostname] 2025-10-10 08:41:14.070341 | controller | ok 2025-10-10 08:41:14.095035 | 2025-10-10 08:41:14.095134 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-10 08:41:14.483721 | controller -> localhost | changed 2025-10-10 08:41:14.489460 | 2025-10-10 08:41:14.489534 | TASK [validate-host : Collect information about zuul worker] 2025-10-10 08:41:14.831996 | controller | ok 2025-10-10 08:41:14.836766 | 2025-10-10 08:41:14.836834 | TASK [validate-host : Write out all zuul information for each host] 2025-10-10 08:41:15.205990 | controller -> localhost | changed 2025-10-10 08:41:15.215368 | 2025-10-10 08:41:15.215435 | TASK [include_role : prepare-workspace-openshift] 2025-10-10 08:41:15.229276 | controller | skipping: Conditional result was False 2025-10-10 08:41:15.234564 | 2025-10-10 08:41:15.234630 | TASK [include_role : remove-zuul-sshkey] 2025-10-10 08:41:15.247864 | controller | skipping: Conditional result was False 2025-10-10 08:41:15.252929 | 2025-10-10 08:41:15.252998 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-10 08:41:15.453814 | controller | ok: "logs" 2025-10-10 08:41:15.454080 | controller | ok: All items complete 2025-10-10 08:41:15.454111 | 2025-10-10 08:41:15.634867 | controller | ok: "artifacts" 2025-10-10 08:41:15.816473 | controller | ok: "docs" 2025-10-10 08:41:15.832333 | 2025-10-10 08:41:15.832443 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-10 08:41:16.042303 | controller | changed: "logs" 2025-10-10 08:41:16.232818 | controller | changed: "artifacts" 2025-10-10 08:41:16.410656 | controller | changed: "docs" 2025-10-10 08:41:16.436469 | 2025-10-10 08:41:16.436555 | PLAY RECAP 2025-10-10 08:41:16.436599 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-10 08:41:16.436627 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-10 08:41:16.436669 | 2025-10-10 08:41:16.519681 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-10 08:41:16.520925 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-10 08:41:17.089807 | 2025-10-10 08:41:17.089926 | PLAY [all] 2025-10-10 08:41:17.111997 | 2025-10-10 08:41:17.112095 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-10 08:41:17.171221 | controller | ok 2025-10-10 08:41:17.176279 | 2025-10-10 08:41:17.176358 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-10 08:41:17.548846 | controller | changed 2025-10-10 08:41:17.554340 | 2025-10-10 08:41:17.554414 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-10 08:41:18.382775 | controller | changed 2025-10-10 08:41:18.392783 | 2025-10-10 08:41:18.392854 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-10 08:41:18.745854 | controller | changed: 2025-10-10 08:41:18.746054 | controller | { 2025-10-10 08:41:18.746085 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-10 08:41:18.746117 | controller | } 2025-10-10 08:41:18.953080 | controller | changed: 2025-10-10 08:41:18.953253 | controller | { 2025-10-10 08:41:18.953297 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-10 08:41:18.953323 | controller | } 2025-10-10 08:41:19.154817 | controller | changed: 2025-10-10 08:41:19.154904 | controller | { 2025-10-10 08:41:19.154963 | 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-10 08:41:19.154987 | controller | } 2025-10-10 08:41:19.368395 | controller | changed: 2025-10-10 08:41:19.368483 | controller | { 2025-10-10 08:41:19.368513 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-10 08:41:19.368536 | controller | } 2025-10-10 08:41:19.593272 | controller | changed: 2025-10-10 08:41:19.593367 | controller | { 2025-10-10 08:41:19.593397 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-10 08:41:19.593421 | controller | } 2025-10-10 08:41:19.800497 | controller | changed: 2025-10-10 08:41:19.800586 | controller | { 2025-10-10 08:41:19.800618 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-10 08:41:19.800654 | controller | } 2025-10-10 08:41:20.028045 | controller | changed: 2025-10-10 08:41:20.028142 | controller | { 2025-10-10 08:41:20.028172 | 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-10 08:41:20.028195 | controller | } 2025-10-10 08:41:20.236945 | controller | changed: 2025-10-10 08:41:20.237032 | controller | { 2025-10-10 08:41:20.237064 | 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-10 08:41:20.237089 | controller | } 2025-10-10 08:41:20.454488 | controller | changed: 2025-10-10 08:41:20.454576 | controller | { 2025-10-10 08:41:20.454605 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-10 08:41:20.454626 | controller | } 2025-10-10 08:41:20.669468 | controller | changed: 2025-10-10 08:41:20.669548 | controller | { 2025-10-10 08:41:20.669575 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-10 08:41:20.669596 | controller | } 2025-10-10 08:41:20.880572 | controller | changed: 2025-10-10 08:41:20.880680 | controller | { 2025-10-10 08:41:20.880710 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-10 08:41:20.880732 | controller | } 2025-10-10 08:41:21.104201 | controller | changed: 2025-10-10 08:41:21.104279 | controller | { 2025-10-10 08:41:21.104307 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-10 08:41:21.104327 | controller | } 2025-10-10 08:41:21.302134 | controller | changed: 2025-10-10 08:41:21.302281 | controller | { 2025-10-10 08:41:21.302315 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-10 08:41:21.302338 | controller | } 2025-10-10 08:41:21.529511 | controller | changed: 2025-10-10 08:41:21.529597 | controller | { 2025-10-10 08:41:21.529623 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-10 08:41:21.529653 | controller | } 2025-10-10 08:41:21.744755 | controller | changed: 2025-10-10 08:41:21.744835 | controller | { 2025-10-10 08:41:21.744861 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-10 08:41:21.744881 | controller | } 2025-10-10 08:41:21.965978 | controller | changed: 2025-10-10 08:41:21.966066 | controller | { 2025-10-10 08:41:21.966094 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-10 08:41:21.966114 | controller | } 2025-10-10 08:41:22.197777 | controller | changed: 2025-10-10 08:41:22.197865 | controller | { 2025-10-10 08:41:22.197891 | 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-10 08:41:22.197933 | controller | } 2025-10-10 08:41:22.429017 | controller | changed: 2025-10-10 08:41:22.429146 | controller | { 2025-10-10 08:41:22.429178 | 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-10 08:41:22.429209 | controller | } 2025-10-10 08:41:22.655905 | controller | changed: 2025-10-10 08:41:22.656000 | controller | { 2025-10-10 08:41:22.656030 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-10 08:41:22.656052 | controller | } 2025-10-10 08:41:22.878479 | controller | changed: 2025-10-10 08:41:22.878676 | controller | { 2025-10-10 08:41:22.878714 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-10 08:41:22.878741 | controller | } 2025-10-10 08:41:23.098039 | controller | changed: 2025-10-10 08:41:23.098132 | controller | { 2025-10-10 08:41:23.098159 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-10 08:41:23.098180 | controller | } 2025-10-10 08:41:23.316717 | controller | changed: 2025-10-10 08:41:23.316794 | controller | { 2025-10-10 08:41:23.316822 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-10 08:41:23.316843 | controller | } 2025-10-10 08:41:23.523076 | controller | changed: 2025-10-10 08:41:23.523177 | controller | { 2025-10-10 08:41:23.523219 | 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-10 08:41:23.523242 | controller | } 2025-10-10 08:41:23.740348 | controller | changed: 2025-10-10 08:41:23.740439 | controller | { 2025-10-10 08:41:23.740468 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-10 08:41:23.740489 | controller | } 2025-10-10 08:41:23.975171 | controller | changed: 2025-10-10 08:41:23.975266 | controller | { 2025-10-10 08:41:23.975296 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-10 08:41:23.975318 | controller | } 2025-10-10 08:41:24.180032 | controller | changed: 2025-10-10 08:41:24.180126 | controller | { 2025-10-10 08:41:24.180153 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-10 08:41:24.180174 | controller | } 2025-10-10 08:41:24.199176 | 2025-10-10 08:41:24.199270 | TASK [Set timezone to UTC] 2025-10-10 08:41:24.642511 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-10 08:41:24.648231 | 2025-10-10 08:41:24.648296 | TASK [Create nodepool directory] 2025-10-10 08:41:24.890410 | controller | changed 2025-10-10 08:41:24.896791 | 2025-10-10 08:41:24.896857 | TASK [Create nodepool sub_nodes file] 2025-10-10 08:41:25.441887 | controller | changed 2025-10-10 08:41:25.446740 | 2025-10-10 08:41:25.446807 | TASK [Create nodepool sub_nodes_private file] 2025-10-10 08:41:26.012932 | controller | changed 2025-10-10 08:41:26.017789 | 2025-10-10 08:41:26.017862 | LOOP [Populate nodepool sub_nodes file] 2025-10-10 08:41:26.046758 | 2025-10-10 08:41:26.046875 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-10 08:41:26.075024 | 2025-10-10 08:41:26.075148 | TASK [Create nodepool primary file] 2025-10-10 08:41:26.098399 | controller | skipping: Conditional result was False 2025-10-10 08:41:26.103990 | 2025-10-10 08:41:26.104095 | TASK [Create nodepool node_private for this node] 2025-10-10 08:41:26.680397 | controller | changed 2025-10-10 08:41:26.687274 | 2025-10-10 08:41:26.687357 | LOOP [Copy ssh keys to nodepool directory] 2025-10-10 08:41:27.026447 | controller | ok: Item: id_rsa Runtime: 0:00:00.006425 2025-10-10 08:41:27.026612 | 2025-10-10 08:41:27.193103 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.005534 2025-10-10 08:41:27.202825 | 2025-10-10 08:41:27.202948 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-10 08:41:27.769613 | controller | changed 2025-10-10 08:41:27.775681 | 2025-10-10 08:41:27.775759 | TASK [Validate sudoers config after edits] 2025-10-10 08:41:28.009740 | controller | /etc/sudoers: parsed OK 2025-10-10 08:41:28.009827 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-10 08:41:28.009839 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-10 08:41:28.009845 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-10 08:41:28.304208 | controller | ok: Runtime: 0:00:00.006154 2025-10-10 08:41:28.310151 | 2025-10-10 08:41:28.310216 | TASK [Show the environment passed in to job shell scripts] 2025-10-10 08:41:28.534975 | controller | SHELL=/bin/bash 2025-10-10 08:41:28.535029 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-10 08:41:28.535039 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-10 08:41:28.535046 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/68/3368/c2b06211d634b2d96a02011714110041916012e4 2025-10-10 08:41:28.535052 | controller | PWD=/home/zuul 2025-10-10 08:41:28.535058 | controller | ZUUL_PIPELINE=github-check 2025-10-10 08:41:28.535118 | controller | LOGNAME=zuul 2025-10-10 08:41:28.535137 | controller | XDG_SESSION_TYPE=tty 2025-10-10 08:41:28.535144 | controller | _=/usr/bin/env 2025-10-10 08:41:28.535149 | controller | MOTD_SHOWN=pam 2025-10-10 08:41:28.535155 | controller | HOME=/home/zuul 2025-10-10 08:41:28.535160 | controller | LANG=en_US.UTF-8 2025-10-10 08:41:28.535165 | controller | SSH_CONNECTION=192.168.26.12 41808 192.168.26.18 22 2025-10-10 08:41:28.535171 | 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-10 08:41:28.535181 | controller | ZUUL_CHANGE_IDS=3368,c2b06211d634b2d96a02011714110041916012e4 2025-10-10 08:41:28.535187 | controller | WORKSPACE=/home/zuul/workspace 2025-10-10 08:41:28.535192 | controller | XDG_SESSION_CLASS=user 2025-10-10 08:41:28.535198 | controller | SELINUX_ROLE_REQUESTED= 2025-10-10 08:41:28.535203 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-10 08:41:28.535209 | controller | USER=zuul 2025-10-10 08:41:28.535214 | controller | ZUUL_VOTING=True 2025-10-10 08:41:28.535220 | controller | BUILD_TIMEOUT=1800000 2025-10-10 08:41:28.535225 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-10 08:41:28.535230 | controller | SHLVL=1 2025-10-10 08:41:28.535235 | controller | ZUUL_PATCHSET=c2b06211d634b2d96a02011714110041916012e4 2025-10-10 08:41:28.535241 | controller | XDG_SESSION_ID=1 2025-10-10 08:41:28.535246 | controller | ZUUL_BRANCH=main 2025-10-10 08:41:28.535251 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-10 08:41:28.535256 | controller | SSH_CLIENT=192.168.26.12 41808 22 2025-10-10 08:41:28.535262 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-10 08:41:28.535267 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-10 08:41:28.535273 | controller | which_declare=declare -f 2025-10-10 08:41:28.535280 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-10 08:41:28.535285 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-10 08:41:28.535291 | controller | ZUUL_CHANGE=3368 2025-10-10 08:41:28.535296 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-10 08:41:28.535301 | controller | ZUUL_UUID=c3a2293fdd2e43de8e42eca855a87099 2025-10-10 08:41:28.535307 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-10 08:41:28.535312 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-10 08:41:28.535318 | controller | } 2025-10-10 08:41:28.837284 | controller | ok: Runtime: 0:00:00.006637 2025-10-10 08:41:28.842795 | 2025-10-10 08:41:28.842856 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-10 08:41:28.856398 | controller | skipping: Conditional result was False 2025-10-10 08:41:28.862678 | 2025-10-10 08:41:28.862746 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-10 08:41:29.385607 | controller | skipping: Conditional result was False 2025-10-10 08:41:29.392191 | 2025-10-10 08:41:29.392271 | TASK [Ensure legacy workspace directory] 2025-10-10 08:41:29.595256 | controller | changed 2025-10-10 08:41:29.613837 | 2025-10-10 08:41:29.613932 | PLAY RECAP 2025-10-10 08:41:29.613992 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-10 08:41:29.614023 | 2025-10-10 08:41:29.712084 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-10 08:41:29.712872 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-10 08:41:30.258025 | 2025-10-10 08:41:30.258127 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-10 08:41:30.290163 | 2025-10-10 08:41:30.290249 | TASK [Create zuul-output directory] 2025-10-10 08:41:30.603228 | controller | changed 2025-10-10 08:41:30.608206 | 2025-10-10 08:41:30.608289 | TASK [Slurp Zuul inventory test] 2025-10-10 08:41:30.896330 | controller -> localhost | ok 2025-10-10 08:41:30.906327 | 2025-10-10 08:41:30.906526 | TASK [Save zuul inventory] 2025-10-10 08:41:31.764739 | controller | changed 2025-10-10 08:41:31.770012 | 2025-10-10 08:41:31.770083 | TASK [Save zuul vars without the change_message] 2025-10-10 08:41:32.430638 | controller | changed 2025-10-10 08:41:32.457248 | 2025-10-10 08:41:32.457336 | PLAY RECAP 2025-10-10 08:41:32.457386 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-10 08:41:32.457410 | 2025-10-10 08:41:32.534466 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-10 08:41:32.535621 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-10 08:41:33.432579 | 2025-10-10 08:41:33.432754 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-10-10 08:41:33.462272 | 2025-10-10 08:41:33.462425 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-10-10 08:41:33.493523 | controller | ok 2025-10-10 08:41:33.516684 | 2025-10-10 08:41:33.516855 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-10 08:41:33.541537 | controller | skipping: Conditional result was False 2025-10-10 08:41:33.548898 | 2025-10-10 08:41:33.549018 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-10 08:41:33.918117 | controller | ok 2025-10-10 08:41:33.925380 | 2025-10-10 08:41:33.925548 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-10 08:41:34.600283 | controller | ok 2025-10-10 08:41:34.611251 | 2025-10-10 08:41:34.611317 | TASK [Prepare workspace] 2025-10-10 08:41:34.630490 | controller | ok 2025-10-10 08:41:34.648171 | 2025-10-10 08:41:34.648248 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-10 08:41:34.971812 | controller | ok 2025-10-10 08:41:34.978888 | 2025-10-10 08:41:34.979015 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-10 08:41:37.837402 | controller | Output suppressed because no_log was given 2025-10-10 08:41:37.848026 | 2025-10-10 08:41:37.848112 | LOOP [Create zuul-output directory] 2025-10-10 08:41:38.041329 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-10-10 08:41:38.209230 | controller | ok: "/home/zuul/zuul-output/logs" 2025-10-10 08:41:38.221470 | 2025-10-10 08:41:38.221554 | TASK [Install required packages] 2025-10-10 08:42:32.876168 | controller | changed 2025-10-10 08:42:32.881670 | 2025-10-10 08:42:32.881746 | TASK [Install venv] 2025-10-10 08:43:33.461172 | controller | changed 2025-10-10 08:43:33.488547 | 2025-10-10 08:43:33.488644 | PLAY RECAP 2025-10-10 08:43:33.488690 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-10 08:43:33.488730 | 2025-10-10 08:43:33.580825 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-10 08:43:33.581817 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-10-10 08:43:34.097890 | 2025-10-10 08:43:34.098011 | PLAY [Run ci/playbooks/molecule-test.yml] 2025-10-10 08:43:34.117960 | 2025-10-10 08:43:34.118065 | TASK [Gather required facts] 2025-10-10 08:43:34.623645 | controller | ok 2025-10-10 08:43:34.629137 | 2025-10-10 08:43:34.629233 | TASK [Load environment var if instructed to] 2025-10-10 08:43:34.653321 | controller | skipping: Conditional result was False 2025-10-10 08:43:34.659311 | 2025-10-10 08:43:34.659398 | TASK [Ensure group_vars dir exists] 2025-10-10 08:43:35.012680 | controller | ok 2025-10-10 08:43:35.019122 | 2025-10-10 08:43:35.019211 | TASK [Run molecule] 2025-10-10 08:43:35.968043 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2025-10-10 08:43:36.036684 | controller | INFO Performing prerun with role_name_check=0... 2025-10-10 08:43:53.760614 | controller | WARNING Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.760839 | controller | WARNING Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.761310 | controller | WARNING Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.761755 | controller | WARNING Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.762240 | controller | WARNING Another version of 'cifmw.general' 1.0.0+1103f848 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 1.0.0+1103f848 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.762711 | controller | WARNING Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.763188 | controller | WARNING Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.763646 | controller | WARNING Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.764097 | controller | WARNING Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.764532 | controller | WARNING Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.765015 | controller | WARNING Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.765454 | controller | WARNING Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.765920 | controller | WARNING Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.766358 | controller | WARNING Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.766827 | controller | WARNING Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/a8a9aa/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections). 2025-10-10 08:43:53.776050 | controller | INFO Running default > prepare 2025-10-10 08:43:54.512797 | controller | 2025-10-10 08:43:54.512894 | controller | PLAY [Prepare] ***************************************************************** 2025-10-10 08:43:54.512906 | controller | 2025-10-10 08:43:54.513023 | controller | TASK [Gathering Facts] ********************************************************* 2025-10-10 08:43:54.513034 | controller | Friday 10 October 2025 08:43:54 +0000 (0:00:00.029) 0:00:00.029 ******** 2025-10-10 08:43:55.354575 | controller | ok: [instance] 2025-10-10 08:43:55.354643 | controller | 2025-10-10 08:43:55.354761 | controller | TASK [test_deps : Gather facts if they don't exist] **************************** 2025-10-10 08:43:55.354893 | controller | Friday 10 October 2025 08:43:55 +0000 (0:00:00.842) 0:00:00.872 ******** 2025-10-10 08:43:55.372662 | controller | skipping: [instance] 2025-10-10 08:43:55.372745 | controller | 2025-10-10 08:43:55.372876 | controller | TASK [test_deps : Gather variables for each operating system] ****************** 2025-10-10 08:43:55.372986 | controller | Friday 10 October 2025 08:43:55 +0000 (0:00:00.018) 0:00:00.890 ******** 2025-10-10 08:43:55.414889 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml) 2025-10-10 08:43:55.414973 | controller | 2025-10-10 08:43:55.415083 | controller | TASK [test_deps : Detect mirrors file] ***************************************** 2025-10-10 08:43:55.415188 | controller | Friday 10 October 2025 08:43:55 +0000 (0:00:00.042) 0:00:00.932 ******** 2025-10-10 08:43:55.696404 | controller | ok: [instance] 2025-10-10 08:43:55.696478 | controller | 2025-10-10 08:43:55.696585 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] *********** 2025-10-10 08:43:55.696688 | controller | Friday 10 October 2025 08:43:55 +0000 (0:00:00.281) 0:00:01.214 ******** 2025-10-10 08:43:56.011602 | controller | ok: [instance] 2025-10-10 08:43:56.011659 | controller | 2025-10-10 08:43:56.011795 | controller | TASK [test_deps : Disable ubi 9 repos] ***************************************** 2025-10-10 08:43:56.011931 | controller | Friday 10 October 2025 08:43:56 +0000 (0:00:00.315) 0:00:01.529 ******** 2025-10-10 08:43:56.708643 | controller | ok: [instance] => (item=ubi-9-appstream) 2025-10-10 08:43:56.708736 | controller | ok: [instance] => (item=ubi-9-baseos) 2025-10-10 08:43:56.708879 | controller | ok: [instance] => (item=ubi-9-codeready-builder) 2025-10-10 08:43:56.708977 | controller | 2025-10-10 08:43:56.709079 | controller | TASK [Deploy repo-setup] ******************************************************* 2025-10-10 08:43:56.709192 | controller | Friday 10 October 2025 08:43:56 +0000 (0:00:00.697) 0:00:02.226 ******** 2025-10-10 08:43:56.760644 | controller | 2025-10-10 08:43:56.760794 | controller | TASK [repo_setup : Ensure directories are present] ***************************** 2025-10-10 08:43:56.760936 | controller | Friday 10 October 2025 08:43:56 +0000 (0:00:00.052) 0:00:02.278 ******** 2025-10-10 08:43:57.311075 | controller | changed: [instance] => (item=tmp) 2025-10-10 08:43:57.311178 | controller | changed: [instance] => (item=artifacts/repositories) 2025-10-10 08:43:57.311289 | controller | changed: [instance] => (item=venv/repo_setup) 2025-10-10 08:43:57.311389 | controller | 2025-10-10 08:43:57.311496 | controller | TASK [repo_setup : Make sure git-core package is installed] ******************** 2025-10-10 08:43:57.311593 | controller | Friday 10 October 2025 08:43:57 +0000 (0:00:00.550) 0:00:02.829 ******** 2025-10-10 08:43:58.079389 | controller | ok: [instance] 2025-10-10 08:43:58.079436 | controller | 2025-10-10 08:43:58.079652 | controller | TASK [repo_setup : Get repo-setup repository] ********************************** 2025-10-10 08:43:59.241802 | controller | Friday 10 October 2025 08:43:58 +0000 (0:00:00.768) 0:00:03.597 ******** 2025-10-10 08:43:59.241835 | controller | changed: [instance] 2025-10-10 08:44:07.177941 | controller | 2025-10-10 08:44:07.177979 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************ 2025-10-10 08:44:07.177990 | controller | Friday 10 October 2025 08:43:59 +0000 (0:00:01.162) 0:00:04.759 ******** 2025-10-10 08:44:07.178000 | controller | changed: [instance] 2025-10-10 08:44:07.873685 | controller | 2025-10-10 08:44:07.873722 | controller | TASK [repo_setup : Install repo-setup package] ********************************* 2025-10-10 08:44:07.873730 | controller | Friday 10 October 2025 08:44:07 +0000 (0:00:07.936) 0:00:12.695 ******** 2025-10-10 08:44:07.873740 | controller | changed: [instance] 2025-10-10 08:44:07.895335 | controller | 2025-10-10 08:44:07.895366 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] *** 2025-10-10 08:44:07.895383 | controller | Friday 10 October 2025 08:44:07 +0000 (0:00:00.695) 0:00:13.391 ******** 2025-10-10 08:44:07.895393 | controller | skipping: [instance] 2025-10-10 08:44:08.725827 | controller | 2025-10-10 08:44:08.725863 | controller | TASK [repo_setup : Run repo-setup] ********************************************* 2025-10-10 08:44:08.725872 | controller | Friday 10 October 2025 08:44:07 +0000 (0:00:00.021) 0:00:13.413 ******** 2025-10-10 08:44:08.725884 | controller | changed: [instance] 2025-10-10 08:44:08.761025 | controller | 2025-10-10 08:44:08.761056 | controller | TASK [repo_setup : Get component repo] ***************************************** 2025-10-10 08:44:08.761063 | controller | Friday 10 October 2025 08:44:08 +0000 (0:00:00.830) 0:00:14.243 ******** 2025-10-10 08:44:08.761073 | controller | skipping: [instance] 2025-10-10 08:44:08.796400 | controller | 2025-10-10 08:44:08.796428 | controller | TASK [repo_setup : Rename component repo] ************************************** 2025-10-10 08:44:08.796435 | controller | Friday 10 October 2025 08:44:08 +0000 (0:00:00.035) 0:00:14.278 ******** 2025-10-10 08:44:08.796445 | controller | skipping: [instance] 2025-10-10 08:44:08.830619 | controller | 2025-10-10 08:44:08.830644 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] ******* 2025-10-10 08:44:08.830653 | controller | Friday 10 October 2025 08:44:08 +0000 (0:00:00.035) 0:00:14.313 ******** 2025-10-10 08:44:08.830664 | controller | skipping: [instance] 2025-10-10 08:44:09.405848 | controller | 2025-10-10 08:44:09.405881 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************ 2025-10-10 08:44:09.405889 | controller | Friday 10 October 2025 08:44:08 +0000 (0:00:00.034) 0:00:14.348 ******** 2025-10-10 08:44:09.405900 | controller | changed: [instance] 2025-10-10 08:44:09.406241 | controller | 2025-10-10 08:44:09.853854 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] ******************* 2025-10-10 08:44:09.853885 | controller | Friday 10 October 2025 08:44:09 +0000 (0:00:00.575) 0:00:14.923 ******** 2025-10-10 08:44:09.853897 | controller | changed: [instance] 2025-10-10 08:44:09.882756 | controller | 2025-10-10 08:44:09.882802 | controller | TASK [repo_setup : Dump current-podified hash] ********************************* 2025-10-10 08:44:09.882810 | controller | Friday 10 October 2025 08:44:09 +0000 (0:00:00.447) 0:00:15.371 ******** 2025-10-10 08:44:09.882820 | controller | skipping: [instance] 2025-10-10 08:44:09.911371 | controller | 2025-10-10 08:44:09.911397 | controller | TASK [repo_setup : Slurp current podified hash] ******************************** 2025-10-10 08:44:09.911404 | controller | Friday 10 October 2025 08:44:09 +0000 (0:00:00.028) 0:00:15.400 ******** 2025-10-10 08:44:09.911414 | controller | skipping: [instance] 2025-10-10 08:44:09.938806 | controller | 2025-10-10 08:44:09.938835 | controller | TASK [repo_setup : Update the value of full_hash] ****************************** 2025-10-10 08:44:09.938843 | controller | Friday 10 October 2025 08:44:09 +0000 (0:00:00.028) 0:00:15.429 ******** 2025-10-10 08:44:09.938856 | controller | skipping: [instance] 2025-10-10 08:44:09.976425 | controller | 2025-10-10 08:44:09.976456 | controller | TASK [repo_setup : Export hashes facts for further use] ************************ 2025-10-10 08:44:09.976464 | controller | Friday 10 October 2025 08:44:09 +0000 (0:00:00.027) 0:00:15.456 ******** 2025-10-10 08:44:09.976474 | controller | ok: [instance] 2025-10-10 08:44:10.003181 | controller | 2025-10-10 08:44:10.003210 | controller | TASK [repo_setup : Create download directory] ********************************** 2025-10-10 08:44:10.003217 | controller | Friday 10 October 2025 08:44:09 +0000 (0:00:00.037) 0:00:15.494 ******** 2025-10-10 08:44:10.003227 | controller | skipping: [instance] 2025-10-10 08:44:10.030889 | controller | 2025-10-10 08:44:10.030923 | controller | TASK [repo_setup : Print the URL to request] *********************************** 2025-10-10 08:44:10.030939 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.026) 0:00:15.520 ******** 2025-10-10 08:44:10.030959 | controller | skipping: [instance] 2025-10-10 08:44:10.030978 | controller | 2025-10-10 08:44:10.030984 | controller | TASK [Download the RPM] ******************************************************** 2025-10-10 08:44:10.030991 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.027) 0:00:15.548 ******** 2025-10-10 08:44:10.058070 | controller | skipping: [instance] 2025-10-10 08:44:10.058156 | controller | 2025-10-10 08:44:10.058277 | controller | TASK [repo_setup : Install RHOS Release tool] ********************************** 2025-10-10 08:44:10.058417 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.027) 0:00:15.576 ******** 2025-10-10 08:44:10.085696 | controller | skipping: [instance] 2025-10-10 08:44:10.085794 | controller | 2025-10-10 08:44:10.086465 | controller | TASK [repo_setup : Get rhos-release tool version] ****************************** 2025-10-10 08:44:10.087064 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.027) 0:00:15.603 ******** 2025-10-10 08:44:10.116729 | controller | skipping: [instance] 2025-10-10 08:44:10.151197 | controller | 2025-10-10 08:44:10.151238 | controller | TASK [repo_setup : Print rhos-release tool version] **************************** 2025-10-10 08:44:10.151247 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.030) 0:00:15.634 ******** 2025-10-10 08:44:10.151257 | controller | skipping: [instance] 2025-10-10 08:44:10.176827 | controller | 2025-10-10 08:44:10.176856 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] *** 2025-10-10 08:44:10.176863 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.034) 0:00:15.668 ******** 2025-10-10 08:44:10.176877 | controller | skipping: [instance] 2025-10-10 08:44:10.177027 | controller | 2025-10-10 08:44:10.177038 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] *************************** 2025-10-10 08:44:10.177047 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.026) 0:00:15.694 ******** 2025-10-10 08:44:10.363860 | controller | ok: [instance] 2025-10-10 08:44:10.364229 | controller | 2025-10-10 08:44:10.580692 | controller | TASK [repo_setup : Use RDO proxy mirrors] ************************************** 2025-10-10 08:44:10.580725 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.186) 0:00:15.881 ******** 2025-10-10 08:44:10.580737 | controller | changed: [instance] 2025-10-10 08:44:10.817798 | controller | 2025-10-10 08:44:10.817831 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] *** 2025-10-10 08:44:10.817840 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.216) 0:00:16.098 ******** 2025-10-10 08:44:10.817850 | controller | changed: [instance] 2025-10-10 08:44:10.837876 | controller | 2025-10-10 08:44:10.837906 | controller | TASK [repo_setup : Check for gating.repo file on content provider] ************* 2025-10-10 08:44:10.837914 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.236) 0:00:16.335 ******** 2025-10-10 08:44:10.837923 | controller | skipping: [instance] 2025-10-10 08:44:10.858296 | controller | 2025-10-10 08:44:10.858332 | controller | TASK [repo_setup : Populate gating repo from content provider ip] ************** 2025-10-10 08:44:10.858340 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.020) 0:00:16.355 ******** 2025-10-10 08:44:10.858350 | controller | skipping: [instance] 2025-10-10 08:44:10.878822 | controller | 2025-10-10 08:44:10.878846 | controller | TASK [repo_setup : Check for DLRN repo at the destination] ********************* 2025-10-10 08:44:10.878853 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.020) 0:00:16.376 ******** 2025-10-10 08:44:10.878862 | controller | skipping: [instance] 2025-10-10 08:44:10.879126 | controller | 2025-10-10 08:44:10.879141 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] *** 2025-10-10 08:44:10.901388 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.020) 0:00:16.396 ******** 2025-10-10 08:44:10.901408 | controller | skipping: [instance] 2025-10-10 08:44:10.923558 | controller | 2025-10-10 08:44:10.923577 | controller | TASK [repo_setup : Check for DLRN component repo] ****************************** 2025-10-10 08:44:10.923585 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.022) 0:00:16.419 ******** 2025-10-10 08:44:10.923599 | controller | skipping: [instance] 2025-10-10 08:44:10.945201 | controller | 2025-10-10 08:44:10.945220 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] *** 2025-10-10 08:44:10.945234 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.022) 0:00:16.441 ******** 2025-10-10 08:44:10.945244 | controller | skipping: [instance] 2025-10-10 08:44:10.961614 | controller | 2025-10-10 08:44:10.961632 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ******** 2025-10-10 08:44:10.961639 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.021) 0:00:16.463 ******** 2025-10-10 08:44:10.961647 | controller | skipping: [instance] 2025-10-10 08:44:10.990163 | controller | 2025-10-10 08:44:10.990183 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ****** 2025-10-10 08:44:10.990191 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.016) 0:00:16.479 ******** 2025-10-10 08:44:10.990200 | controller | skipping: [instance] 2025-10-10 08:44:11.006873 | controller | 2025-10-10 08:44:11.006896 | controller | TASK [repo_setup : Cleanup existing metadata] ********************************** 2025-10-10 08:44:11.006905 | controller | Friday 10 October 2025 08:44:10 +0000 (0:00:00.028) 0:00:16.508 ******** 2025-10-10 08:44:11.006916 | controller | skipping: [instance] 2025-10-10 08:44:11.026833 | controller | 2025-10-10 08:44:11.026853 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] ********* 2025-10-10 08:44:11.026861 | controller | Friday 10 October 2025 08:44:11 +0000 (0:00:00.016) 0:00:16.524 ******** 2025-10-10 08:44:11.026870 | controller | skipping: [instance] 2025-10-10 08:44:11.026891 | controller | 2025-10-10 08:44:11.026900 | controller | TASK [test_deps : Look for redhat-release rpm] ********************************* 2025-10-10 08:44:11.027006 | controller | Friday 10 October 2025 08:44:11 +0000 (0:00:00.020) 0:00:16.545 ******** 2025-10-10 08:44:11.057255 | controller | skipping: [instance] 2025-10-10 08:44:11.086835 | controller | 2025-10-10 08:44:11.086859 | controller | TASK [test_deps : Remove redhat-release] *************************************** 2025-10-10 08:44:11.086867 | controller | Friday 10 October 2025 08:44:11 +0000 (0:00:00.030) 0:00:16.575 ******** 2025-10-10 08:44:11.086878 | controller | skipping: [instance] 2025-10-10 08:44:11.086904 | controller | 2025-10-10 08:44:11.086913 | controller | TASK [test_deps : Install centos-stream-release] ******************************* 2025-10-10 08:44:11.087009 | controller | Friday 10 October 2025 08:44:11 +0000 (0:00:00.029) 0:00:16.605 ******** 2025-10-10 08:44:11.116734 | controller | skipping: [instance] 2025-10-10 08:44:11.146665 | controller | 2025-10-10 08:44:11.146700 | controller | TASK [test_deps : Install additional packages] ********************************* 2025-10-10 08:44:11.146709 | controller | Friday 10 October 2025 08:44:11 +0000 (0:00:00.029) 0:00:16.634 ******** 2025-10-10 08:44:11.146719 | controller | skipping: [instance] 2025-10-10 08:45:08.011161 | controller | 2025-10-10 08:45:08.011195 | controller | TASK [test_deps : Install selinux python libs] ********************************* 2025-10-10 08:45:08.011203 | controller | Friday 10 October 2025 08:44:11 +0000 (0:00:00.029) 0:00:16.664 ******** 2025-10-10 08:45:08.011213 | controller | ok: [instance] 2025-10-10 08:45:09.155393 | controller | 2025-10-10 08:45:09.155423 | controller | TASK [test_deps : Install python yaml libs] ************************************ 2025-10-10 08:45:09.155432 | controller | Friday 10 October 2025 08:45:08 +0000 (0:00:56.864) 0:01:13.528 ******** 2025-10-10 08:45:09.155442 | controller | ok: [instance] 2025-10-10 08:45:09.187319 | controller | 2025-10-10 08:45:09.187341 | controller | TASK [test_deps : Install extra packages] ************************************** 2025-10-10 08:45:09.187348 | controller | Friday 10 October 2025 08:45:09 +0000 (0:00:01.144) 0:01:14.673 ******** 2025-10-10 08:45:09.187357 | controller | skipping: [instance] 2025-10-10 08:45:09.230158 | controller | 2025-10-10 08:45:09.230181 | controller | TASK [ci_setup : Gather variables for each operating system] ******************* 2025-10-10 08:45:09.230189 | controller | Friday 10 October 2025 08:45:09 +0000 (0:00:00.032) 0:01:14.705 ******** 2025-10-10 08:45:09.230198 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml) 2025-10-10 08:45:09.249894 | controller | 2025-10-10 08:45:09.249934 | controller | TASK [ci_setup : List packages to install] ************************************* 2025-10-10 08:45:09.249944 | controller | Friday 10 October 2025 08:45:09 +0000 (0:00:00.042) 0:01:14.748 ******** 2025-10-10 08:45:09.249969 | controller | ok: [instance] => 2025-10-10 08:45:09.250003 | controller | cifmw_ci_setup_packages: 2025-10-10 08:45:09.250012 | controller | - bash-completion 2025-10-10 08:45:09.250036 | controller | - ca-certificates 2025-10-10 08:45:09.250043 | controller | - git-core 2025-10-10 08:45:09.250051 | controller | - make 2025-10-10 08:45:09.250057 | controller | - tar 2025-10-10 08:45:09.250064 | controller | - tmux 2025-10-10 08:45:09.250076 | controller | - python3-pip 2025-10-10 08:45:09.250082 | controller | 2025-10-10 08:45:09.250092 | controller | TASK [ci_setup : Install needed packages] ************************************** 2025-10-10 08:45:12.073886 | controller | Friday 10 October 2025 08:45:09 +0000 (0:00:00.019) 0:01:14.767 ******** 2025-10-10 08:45:12.073921 | controller | changed: [instance] 2025-10-10 08:45:12.253860 | controller | 2025-10-10 08:45:12.253896 | controller | TASK [ci_setup : Gather version of openshift client] *************************** 2025-10-10 08:45:12.253904 | controller | Friday 10 October 2025 08:45:12 +0000 (0:00:02.824) 0:01:17.591 ******** 2025-10-10 08:45:12.253920 | controller | ok: [instance] 2025-10-10 08:45:12.253939 | controller | 2025-10-10 08:45:12.254151 | controller | TASK [ci_setup : Ensure openshift client install path is present] ************** 2025-10-10 08:45:12.447288 | controller | Friday 10 October 2025 08:45:12 +0000 (0:00:00.180) 0:01:17.771 ******** 2025-10-10 08:45:12.447333 | controller | changed: [instance] 2025-10-10 08:45:18.403703 | controller | 2025-10-10 08:45:18.403735 | controller | TASK [ci_setup : Install openshift client] ************************************* 2025-10-10 08:45:18.403743 | controller | Friday 10 October 2025 08:45:12 +0000 (0:00:00.193) 0:01:17.965 ******** 2025-10-10 08:45:18.403753 | controller | changed: [instance] 2025-10-10 08:45:18.440911 | controller | 2025-10-10 08:45:18.440948 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] ********************** 2025-10-10 08:45:18.440958 | controller | Friday 10 October 2025 08:45:18 +0000 (0:00:05.956) 0:01:23.921 ******** 2025-10-10 08:45:18.440971 | controller | ok: [instance] 2025-10-10 08:45:18.440979 | controller | 2025-10-10 08:45:18.440986 | controller | TASK [ci_setup : Create completion file] *************************************** 2025-10-10 08:45:18.440995 | controller | Friday 10 October 2025 08:45:18 +0000 (0:00:00.037) 0:01:23.958 ******** 2025-10-10 08:45:18.715736 | controller | changed: [instance] 2025-10-10 08:45:19.002902 | controller | 2025-10-10 08:45:19.002949 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************ 2025-10-10 08:45:19.002958 | controller | Friday 10 October 2025 08:45:18 +0000 (0:00:00.274) 0:01:24.233 ******** 2025-10-10 08:45:19.002969 | controller | changed: [instance] 2025-10-10 08:45:19.020286 | controller | 2025-10-10 08:45:19.020315 | controller | TASK [ci_setup : Check rhsm status] ******************************************** 2025-10-10 08:45:19.020323 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.287) 0:01:24.520 ******** 2025-10-10 08:45:19.020333 | controller | skipping: [instance] 2025-10-10 08:45:19.036829 | controller | 2025-10-10 08:45:19.036852 | controller | TASK [ci_setup : Gather the repos to be enabled] ******************************* 2025-10-10 08:45:19.036860 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.017) 0:01:24.537 ******** 2025-10-10 08:45:19.036869 | controller | skipping: [instance] 2025-10-10 08:45:19.037249 | controller | 2025-10-10 08:45:19.054883 | controller | TASK [ci_setup : Enabling the required repositories.] ************************** 2025-10-10 08:45:19.054920 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.017) 0:01:24.555 ******** 2025-10-10 08:45:19.054951 | controller | skipping: [instance] 2025-10-10 08:45:19.055003 | controller | 2025-10-10 08:45:19.055029 | controller | TASK [ci_setup : Get current /etc/redhat-release] ****************************** 2025-10-10 08:45:19.055040 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.017) 0:01:24.572 ******** 2025-10-10 08:45:19.071841 | controller | skipping: [instance] 2025-10-10 08:45:19.072204 | controller | 2025-10-10 08:45:19.089315 | controller | TASK [ci_setup : Print current /etc/redhat-release] **************************** 2025-10-10 08:45:19.089341 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.017) 0:01:24.589 ******** 2025-10-10 08:45:19.089352 | controller | skipping: [instance] 2025-10-10 08:45:19.111281 | controller | 2025-10-10 08:45:19.111308 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] ********* 2025-10-10 08:45:19.111323 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.017) 0:01:24.607 ******** 2025-10-10 08:45:19.111334 | controller | skipping: [instance] 2025-10-10 08:45:20.086437 | controller | 2025-10-10 08:45:20.086468 | controller | TASK [ci_setup : Manage directories] ******************************************* 2025-10-10 08:45:20.086476 | controller | Friday 10 October 2025 08:45:19 +0000 (0:00:00.021) 0:01:24.629 ******** 2025-10-10 08:45:20.086486 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr) 2025-10-10 08:45:20.616585 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs) 2025-10-10 08:45:20.616615 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp) 2025-10-10 08:45:20.616623 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes) 2025-10-10 08:45:20.616629 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters) 2025-10-10 08:45:20.616635 | controller | 2025-10-10 08:45:20.616641 | controller | TASK [repo_setup : Ensure directories are present] ***************************** 2025-10-10 08:45:20.616646 | controller | Friday 10 October 2025 08:45:20 +0000 (0:00:00.974) 0:01:25.603 ******** 2025-10-10 08:45:20.616655 | controller | ok: [instance] => (item=tmp) 2025-10-10 08:45:21.752095 | controller | ok: [instance] => (item=artifacts/repositories) 2025-10-10 08:45:21.752124 | controller | ok: [instance] => (item=venv/repo_setup) 2025-10-10 08:45:21.752133 | controller | 2025-10-10 08:45:21.752139 | controller | TASK [repo_setup : Make sure git-core package is installed] ******************** 2025-10-10 08:45:21.752145 | controller | Friday 10 October 2025 08:45:20 +0000 (0:00:00.530) 0:01:26.134 ******** 2025-10-10 08:45:21.752155 | controller | ok: [instance] 2025-10-10 08:45:22.235262 | controller | 2025-10-10 08:45:22.235294 | controller | TASK [repo_setup : Get repo-setup repository] ********************************** 2025-10-10 08:45:22.235307 | controller | Friday 10 October 2025 08:45:21 +0000 (0:00:01.135) 0:01:27.269 ******** 2025-10-10 08:45:22.235318 | controller | ok: [instance] 2025-10-10 08:45:23.429002 | controller | 2025-10-10 08:45:23.429047 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************ 2025-10-10 08:45:23.429056 | controller | Friday 10 October 2025 08:45:22 +0000 (0:00:00.482) 0:01:27.752 ******** 2025-10-10 08:45:23.429067 | controller | ok: [instance] 2025-10-10 08:45:23.623014 | controller | 2025-10-10 08:45:23.623045 | controller | TASK [repo_setup : Install repo-setup package] ********************************* 2025-10-10 08:45:23.623053 | controller | Friday 10 October 2025 08:45:23 +0000 (0:00:01.193) 0:01:28.946 ******** 2025-10-10 08:45:23.623063 | controller | ok: [instance] 2025-10-10 08:45:23.644854 | controller | 2025-10-10 08:45:23.644884 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] *** 2025-10-10 08:45:23.644893 | controller | Friday 10 October 2025 08:45:23 +0000 (0:00:00.194) 0:01:29.140 ******** 2025-10-10 08:45:23.644905 | controller | skipping: [instance] 2025-10-10 08:45:23.644936 | controller | 2025-10-10 08:45:23.644953 | controller | TASK [repo_setup : Run repo-setup] ********************************************* 2025-10-10 08:45:23.644963 | controller | Friday 10 October 2025 08:45:23 +0000 (0:00:00.022) 0:01:29.162 ******** 2025-10-10 08:45:24.460820 | controller | changed: [instance] 2025-10-10 08:45:24.497946 | controller | 2025-10-10 08:45:24.497976 | controller | TASK [repo_setup : Get component repo] ***************************************** 2025-10-10 08:45:24.497984 | controller | Friday 10 October 2025 08:45:24 +0000 (0:00:00.815) 0:01:29.978 ******** 2025-10-10 08:45:24.497994 | controller | skipping: [instance] 2025-10-10 08:45:24.534469 | controller | 2025-10-10 08:45:24.534495 | controller | TASK [repo_setup : Rename component repo] ************************************** 2025-10-10 08:45:24.534503 | controller | Friday 10 October 2025 08:45:24 +0000 (0:00:00.037) 0:01:30.015 ******** 2025-10-10 08:45:24.534513 | controller | skipping: [instance] 2025-10-10 08:45:24.570316 | controller | 2025-10-10 08:45:24.570344 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] ******* 2025-10-10 08:45:24.570352 | controller | Friday 10 October 2025 08:45:24 +0000 (0:00:00.036) 0:01:30.052 ******** 2025-10-10 08:45:24.570361 | controller | skipping: [instance] 2025-10-10 08:45:25.126042 | controller | 2025-10-10 08:45:25.126074 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************ 2025-10-10 08:45:25.126083 | controller | Friday 10 October 2025 08:45:24 +0000 (0:00:00.035) 0:01:30.088 ******** 2025-10-10 08:45:25.126092 | controller | changed: [instance] 2025-10-10 08:45:25.480962 | controller | 2025-10-10 08:45:25.480992 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] ******************* 2025-10-10 08:45:25.481000 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.555) 0:01:30.643 ******** 2025-10-10 08:45:25.481010 | controller | changed: [instance] 2025-10-10 08:45:25.510876 | controller | 2025-10-10 08:45:25.510906 | controller | TASK [repo_setup : Dump current-podified hash] ********************************* 2025-10-10 08:45:25.510914 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.354) 0:01:30.998 ******** 2025-10-10 08:45:25.510924 | controller | skipping: [instance] 2025-10-10 08:45:25.540975 | controller | 2025-10-10 08:45:25.540998 | controller | TASK [repo_setup : Slurp current podified hash] ******************************** 2025-10-10 08:45:25.541006 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.029) 0:01:31.028 ******** 2025-10-10 08:45:25.541016 | controller | skipping: [instance] 2025-10-10 08:45:25.569429 | controller | 2025-10-10 08:45:25.569449 | controller | TASK [repo_setup : Update the value of full_hash] ****************************** 2025-10-10 08:45:25.569458 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.029) 0:01:31.058 ******** 2025-10-10 08:45:25.569469 | controller | skipping: [instance] 2025-10-10 08:45:25.608931 | controller | 2025-10-10 08:45:25.608973 | controller | TASK [repo_setup : Export hashes facts for further use] ************************ 2025-10-10 08:45:25.608982 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.028) 0:01:31.087 ******** 2025-10-10 08:45:25.608994 | controller | ok: [instance] 2025-10-10 08:45:25.609024 | controller | 2025-10-10 08:45:25.609050 | controller | TASK [repo_setup : Create download directory] ********************************** 2025-10-10 08:45:25.609210 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.039) 0:01:31.126 ******** 2025-10-10 08:45:25.636161 | controller | skipping: [instance] 2025-10-10 08:45:25.662499 | controller | 2025-10-10 08:45:25.662531 | controller | TASK [repo_setup : Print the URL to request] *********************************** 2025-10-10 08:45:25.662541 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.027) 0:01:31.153 ******** 2025-10-10 08:45:25.662570 | controller | skipping: [instance] 2025-10-10 08:45:25.688934 | controller | 2025-10-10 08:45:25.688979 | controller | TASK [Download the RPM] ******************************************************** 2025-10-10 08:45:25.688988 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.026) 0:01:31.180 ******** 2025-10-10 08:45:25.688998 | controller | skipping: [instance] 2025-10-10 08:45:25.715106 | controller | 2025-10-10 08:45:25.715134 | controller | TASK [repo_setup : Install RHOS Release tool] ********************************** 2025-10-10 08:45:25.715143 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.026) 0:01:31.206 ******** 2025-10-10 08:45:25.715154 | controller | skipping: [instance] 2025-10-10 08:45:25.715337 | controller | 2025-10-10 08:45:25.715536 | controller | TASK [repo_setup : Get rhos-release tool version] ****************************** 2025-10-10 08:45:25.715727 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.026) 0:01:31.233 ******** 2025-10-10 08:45:25.741302 | controller | skipping: [instance] 2025-10-10 08:45:25.741508 | controller | 2025-10-10 08:45:25.741706 | controller | TASK [repo_setup : Print rhos-release tool version] **************************** 2025-10-10 08:45:25.741911 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.026) 0:01:31.259 ******** 2025-10-10 08:45:25.768405 | controller | skipping: [instance] 2025-10-10 08:45:25.768622 | controller | 2025-10-10 08:45:25.768864 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] *** 2025-10-10 08:45:25.769040 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.027) 0:01:31.286 ******** 2025-10-10 08:45:25.794715 | controller | skipping: [instance] 2025-10-10 08:45:25.794943 | controller | 2025-10-10 08:45:25.795132 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] *************************** 2025-10-10 08:45:25.795286 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.026) 0:01:31.312 ******** 2025-10-10 08:45:25.981190 | controller | ok: [instance] 2025-10-10 08:45:26.184840 | controller | 2025-10-10 08:45:26.184872 | controller | TASK [repo_setup : Use RDO proxy mirrors] ************************************** 2025-10-10 08:45:26.184880 | controller | Friday 10 October 2025 08:45:25 +0000 (0:00:00.186) 0:01:31.498 ******** 2025-10-10 08:45:26.184890 | controller | changed: [instance] 2025-10-10 08:45:26.185277 | controller | 2025-10-10 08:45:26.404884 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] *** 2025-10-10 08:45:26.404917 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.203) 0:01:31.702 ******** 2025-10-10 08:45:26.404929 | controller | changed: [instance] 2025-10-10 08:45:26.425531 | controller | 2025-10-10 08:45:26.425564 | controller | TASK [repo_setup : Check for gating.repo file on content provider] ************* 2025-10-10 08:45:26.425572 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.219) 0:01:31.922 ******** 2025-10-10 08:45:26.425581 | controller | skipping: [instance] 2025-10-10 08:45:26.457716 | controller | 2025-10-10 08:45:26.457739 | controller | TASK [repo_setup : Populate gating repo from content provider ip] ************** 2025-10-10 08:45:26.457747 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.020) 0:01:31.943 ******** 2025-10-10 08:45:26.457756 | controller | skipping: [instance] 2025-10-10 08:45:26.490592 | controller | 2025-10-10 08:45:26.490619 | controller | TASK [repo_setup : Check for DLRN repo at the destination] ********************* 2025-10-10 08:45:26.490627 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.032) 0:01:31.975 ******** 2025-10-10 08:45:26.490659 | controller | skipping: [instance] 2025-10-10 08:45:26.523938 | controller | 2025-10-10 08:45:26.523972 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] *** 2025-10-10 08:45:26.523980 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.032) 0:01:32.008 ******** 2025-10-10 08:45:26.523989 | controller | skipping: [instance] 2025-10-10 08:45:26.558724 | controller | 2025-10-10 08:45:26.558754 | controller | TASK [repo_setup : Check for DLRN component repo] ****************************** 2025-10-10 08:45:26.558779 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.033) 0:01:32.041 ******** 2025-10-10 08:45:26.558793 | controller | skipping: [instance] 2025-10-10 08:45:26.592136 | controller | 2025-10-10 08:45:26.592162 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] *** 2025-10-10 08:45:26.592171 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.034) 0:01:32.076 ******** 2025-10-10 08:45:26.592182 | controller | skipping: [instance] 2025-10-10 08:45:26.592355 | controller | 2025-10-10 08:45:26.592531 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ******** 2025-10-10 08:45:26.592722 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.033) 0:01:32.110 ******** 2025-10-10 08:45:26.890379 | controller | ok: [instance] 2025-10-10 08:45:28.404849 | controller | 2025-10-10 08:45:28.404880 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ****** 2025-10-10 08:45:28.404888 | controller | Friday 10 October 2025 08:45:26 +0000 (0:00:00.297) 0:01:32.408 ******** 2025-10-10 08:45:28.404899 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos-addons.repo) 2025-10-10 08:45:28.405251 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos.repo) 2025-10-10 08:45:28.405264 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean.repo) 2025-10-10 08:45:28.405270 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean-master-testing.repo) 2025-10-10 08:45:28.405276 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-highavailability.repo) 2025-10-10 08:45:28.405282 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-powertools.repo) 2025-10-10 08:45:28.405287 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-appstream.repo) 2025-10-10 08:45:28.405292 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-baseos.repo) 2025-10-10 08:45:28.405300 | controller | 2025-10-10 08:45:28.840859 | controller | TASK [repo_setup : Cleanup existing metadata] ********************************** 2025-10-10 08:45:28.840890 | controller | Friday 10 October 2025 08:45:28 +0000 (0:00:01.513) 0:01:33.922 ******** 2025-10-10 08:45:28.840908 | controller | changed: [instance] 2025-10-10 08:45:28.840935 | controller | 2025-10-10 08:45:28.840943 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] ********* 2025-10-10 08:45:28.841054 | controller | Friday 10 October 2025 08:45:28 +0000 (0:00:00.436) 0:01:34.358 ******** 2025-10-10 08:45:29.090169 | controller | changed: [instance] 2025-10-10 08:45:29.151177 | controller | 2025-10-10 08:45:29.151208 | controller | PLAY RECAP ********************************************************************* 2025-10-10 08:45:29.151217 | controller | instance : ok=45 changed=23 unreachable=0 failed=0 skipped=56 rescued=0 ignored=0 2025-10-10 08:45:29.151223 | controller | 2025-10-10 08:45:29.151229 | controller | Friday 10 October 2025 08:45:29 +0000 (0:00:00.246) 0:01:34.605 ******** 2025-10-10 08:45:29.151234 | controller | =============================================================================== 2025-10-10 08:45:29.151240 | controller | test_deps : Install selinux python libs -------------------------------- 56.86s 2025-10-10 08:45:29.151245 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.94s 2025-10-10 08:45:29.151250 | controller | ci_setup : Install openshift client ------------------------------------- 5.96s 2025-10-10 08:45:29.151255 | controller | ci_setup : Install needed packages -------------------------------------- 2.82s 2025-10-10 08:45:29.151261 | controller | repo_setup : Remove existing repos from /etc/yum.repos.d directory ------ 1.51s 2025-10-10 08:45:29.151266 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.19s 2025-10-10 08:45:29.151271 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.16s 2025-10-10 08:45:29.151277 | controller | test_deps : Install python yaml libs ------------------------------------ 1.14s 2025-10-10 08:45:29.151282 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.14s 2025-10-10 08:45:29.151287 | controller | ci_setup : Manage directories ------------------------------------------- 0.97s 2025-10-10 08:45:29.151292 | controller | Gathering Facts --------------------------------------------------------- 0.84s 2025-10-10 08:45:29.151297 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.83s 2025-10-10 08:45:29.151303 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.82s 2025-10-10 08:45:29.151308 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.77s 2025-10-10 08:45:29.151313 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.70s 2025-10-10 08:45:29.151318 | controller | repo_setup : Install repo-setup package --------------------------------- 0.70s 2025-10-10 08:45:29.151324 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.58s 2025-10-10 08:45:29.151329 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s 2025-10-10 08:45:29.151334 | controller | repo_setup : Ensure directories are present ----------------------------- 0.55s 2025-10-10 08:45:29.151339 | controller | repo_setup : Ensure directories are present ----------------------------- 0.53s 2025-10-10 08:45:29.151349 | controller | INFO Running default > converge 2025-10-10 08:45:29.568562 | controller | 2025-10-10 08:45:30.360625 | controller | PLAY [Converge] **************************************************************** 2025-10-10 08:45:30.360659 | controller | 2025-10-10 08:45:30.360666 | controller | TASK [Gathering Facts] ********************************************************* 2025-10-10 08:45:30.360672 | controller | Friday 10 October 2025 08:45:29 +0000 (0:00:00.013) 0:00:00.013 ******** 2025-10-10 08:45:30.360682 | controller | ok: [instance] 2025-10-10 08:45:30.837582 | controller | 2025-10-10 08:45:30.837612 | controller | TASK [pkg_build : Ensure directories exist] ************************************ 2025-10-10 08:45:30.837625 | controller | Friday 10 October 2025 08:45:30 +0000 (0:00:00.792) 0:00:00.806 ******** 2025-10-10 08:45:30.837636 | controller | changed: [instance] => (item=volumes/packages/gating_repo) 2025-10-10 08:45:31.045938 | controller | ok: [instance] => (item=artifacts) 2025-10-10 08:45:31.045968 | controller | 2025-10-10 08:45:31.045976 | controller | TASK [pkg_build : Ensure per-package build directories exist] ****************** 2025-10-10 08:45:31.045989 | controller | Friday 10 October 2025 08:45:30 +0000 (0:00:00.477) 0:00:01.283 ******** 2025-10-10 08:45:31.045999 | controller | changed: [instance] => (item=neutron-tempest-plugin) 2025-10-10 08:45:31.257842 | controller | 2025-10-10 08:45:31.257874 | controller | TASK [pkg_build : Ensure per-package log directories exist] ******************** 2025-10-10 08:45:31.257883 | controller | Friday 10 October 2025 08:45:31 +0000 (0:00:00.208) 0:00:01.491 ******** 2025-10-10 08:45:31.257893 | controller | changed: [instance] => (item=neutron-tempest-plugin) 2025-10-10 08:45:31.257979 | controller | 2025-10-10 08:45:31.258008 | controller | TASK [pkg_build : Generate Containerfile.buildpkg] ***************************** 2025-10-10 08:45:31.258020 | controller | Friday 10 October 2025 08:45:31 +0000 (0:00:00.211) 0:00:01.703 ******** 2025-10-10 08:45:31.800805 | controller | changed: [instance] 2025-10-10 08:46:45.868338 | controller | 2025-10-10 08:46:45.868370 | controller | TASK [pkg_build : Build container image] *************************************** 2025-10-10 08:46:45.868378 | controller | Friday 10 October 2025 08:45:31 +0000 (0:00:00.542) 0:00:02.246 ******** 2025-10-10 08:46:45.868388 | controller | changed: [instance] 2025-10-10 08:46:46.218536 | controller | 2025-10-10 08:46:46.218566 | controller | TASK [pkg_build : Generate playbooks for package build] ************************ 2025-10-10 08:46:46.218574 | controller | Friday 10 October 2025 08:46:45 +0000 (0:01:14.067) 0:01:16.314 ******** 2025-10-10 08:46:46.218584 | controller | changed: [instance] 2025-10-10 08:46:47.735662 | controller | 2025-10-10 08:46:47.735691 | controller | TASK [Get repository to build from] ******************************************** 2025-10-10 08:46:47.735699 | controller | Friday 10 October 2025 08:46:46 +0000 (0:00:00.349) 0:01:16.664 ******** 2025-10-10 08:46:47.735709 | controller | changed: [instance] 2025-10-10 08:46:47.760397 | controller | 2025-10-10 08:46:47.760425 | controller | TASK [Build package] *********************************************************** 2025-10-10 08:46:47.760432 | controller | Friday 10 October 2025 08:46:47 +0000 (0:00:01.517) 0:01:18.181 ******** 2025-10-10 08:46:47.760441 | controller | 2025-10-10 08:46:47.794884 | controller | TASK [pkg_build : Generate volume list] **************************************** 2025-10-10 08:46:47.794921 | controller | Friday 10 October 2025 08:46:47 +0000 (0:00:00.024) 0:01:18.206 ******** 2025-10-10 08:46:47.794942 | controller | ok: [instance] 2025-10-10 08:46:47.795153 | controller | 2025-10-10 08:46:47.795185 | controller | TASK [pkg_build : Build package using container] ******************************* 2025-10-10 08:48:36.885467 | controller | Friday 10 October 2025 08:46:47 +0000 (0:00:00.034) 0:01:18.240 ******** 2025-10-10 08:48:36.885504 | controller | failed: [instance] (item=neutron-tempest-plugin) => changed=false 2025-10-10 08:48:36.885529 | controller | ansible_loop_var: pkg 2025-10-10 08:48:36.885536 | controller | msg: Container neutron-tempest-plugin-builder exited with code 2 when runed 2025-10-10 08:48:36.885542 | controller | pkg: 2025-10-10 08:48:36.885547 | controller | name: neutron-tempest-plugin 2025-10-10 08:48:36.885553 | controller | src: /home/zuul/src/neutron-tempest-plugin 2025-10-10 08:48:36.885570 | controller | stderr: |- 2025-10-10 08:48:36.885577 | controller | time="2025-10-10T08:46:48Z" level=info msg="podman filtering at log level info" 2025-10-10 08:48:36.885583 | controller | time="2025-10-10T08:46:48Z" level=info msg="Setting parallel job count to 13" 2025-10-10 08:48:36.885588 | controller | time="2025-10-10T08:46:48Z" level=info msg="Using sqlite as database backend" 2025-10-10 08:48:36.885594 | controller | time="2025-10-10T08:46:48Z" level=info msg="Received shutdown.Stop(), terminating!" PID=29604 2025-10-10 08:48:36.885599 | controller | time="2025-10-10T08:46:48Z" level=info msg="Running conmon under slice user.slice and unitName libpod-conmon-228a413674d5a6cc0c28052bc14d88598a7aa51532041fa40030c4d3d69431cc.scope" 2025-10-10 08:48:36.885605 | controller | time="2025-10-10T08:46:48Z" level=info msg="Got Conmon PID as 29626" 2025-10-10 08:48:36.885610 | controller | [WARNING]: Collection community.general does not support Ansible version 2025-10-10 08:48:36.885615 | controller | 2.14.18 2025-10-10 08:48:36.885621 | controller | [WARNING]: Collection ansible.posix does not support Ansible version 2.14.18 2025-10-10 08:48:36.885626 | controller | stderr_lines: 2025-10-10 08:48:36.885640 | controller | stdout: |2- 2025-10-10 08:48:36.885817 | controller | 2025-10-10 08:48:36.885851 | controller | PLAY [Build packages] ********************************************************** 2025-10-10 08:48:36.885860 | controller | 2025-10-10 08:48:36.885867 | controller | TASK [Gathering Facts] ********************************************************* 2025-10-10 08:48:36.886808 | controller | ok: [localhost] 2025-10-10 08:48:36.886911 | controller | 2025-10-10 08:48:36.886919 | controller | TASK [Gather parameters] ******************************************************* 2025-10-10 08:48:36.886925 | controller | ok: [localhost] 2025-10-10 08:48:36.886930 | controller | 2025-10-10 08:48:36.886935 | controller | TASK [Output params into a file] *********************************************** 2025-10-10 08:48:36.886941 | controller | changed: [localhost] 2025-10-10 08:48:36.886946 | controller | 2025-10-10 08:48:36.886951 | controller | TASK [Build package] *********************************************************** 2025-10-10 08:48:36.886957 | controller | 2025-10-10 08:48:36.886964 | controller | TASK [build_openstack_packages : Install Mock from DLRN repos] ***************** 2025-10-10 08:48:36.887069 | controller | fatal: [localhost]: FAILED! => {"changed": false, "failures": ["No package mock available."], "msg": "Failed to install some of the specified packages", "rc": 1, "results": []} 2025-10-10 08:48:36.887179 | controller | 2025-10-10 08:48:36.887300 | controller | TASK [ci_setup : Check rhsm status] ******************************************** 2025-10-10 08:48:36.887404 | controller | skipping: [localhost] 2025-10-10 08:48:36.887508 | controller | 2025-10-10 08:48:36.887627 | controller | TASK [ci_setup : Gather the repos to be enabled] ******************************* 2025-10-10 08:48:36.887752 | controller | skipping: [localhost] 2025-10-10 08:48:36.888751 | controller | 2025-10-10 08:48:36.888879 | controller | TASK [ci_setup : Enabling the required repositories.] ************************** 2025-10-10 08:48:36.888890 | controller | skipping: [localhost] 2025-10-10 08:48:36.888895 | controller | 2025-10-10 08:48:36.888901 | controller | TASK [ci_setup : Get current /etc/redhat-release] ****************************** 2025-10-10 08:48:36.888906 | controller | skipping: [localhost] 2025-10-10 08:48:36.888911 | controller | 2025-10-10 08:48:36.888916 | controller | TASK [ci_setup : Print current /etc/redhat-release] **************************** 2025-10-10 08:48:36.888922 | controller | skipping: [localhost] 2025-10-10 08:48:36.888929 | controller | 2025-10-10 08:48:36.889018 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] ********* 2025-10-10 08:48:36.889143 | controller | skipping: [localhost] 2025-10-10 08:48:36.889256 | controller | 2025-10-10 08:48:36.889419 | controller | TASK [ci_setup : Ensure EPEL is not already installed] ************************* 2025-10-10 08:48:36.889523 | controller | ok: [localhost] 2025-10-10 08:48:36.889640 | controller | 2025-10-10 08:48:36.889742 | controller | TASK [ci_setup : Install EPEL] ************************************************* 2025-10-10 08:48:36.889896 | controller | changed: [localhost] 2025-10-10 08:48:36.890019 | controller | 2025-10-10 08:48:36.890134 | controller | TASK [ci_setup : Deactivate all of EPEL repositories] ************************** 2025-10-10 08:48:36.890243 | controller | changed: [localhost] 2025-10-10 08:48:36.890346 | controller | 2025-10-10 08:48:36.890460 | controller | TASK [ci_setup : Install packages from EPEL] *********************************** 2025-10-10 08:48:36.890568 | controller | changed: [localhost] 2025-10-10 08:48:36.890674 | controller | 2025-10-10 08:48:36.890801 | controller | TASK [build_openstack_packages : Ensure DLRN package dependencies] ************* 2025-10-10 08:48:36.890918 | controller | ok: [localhost] 2025-10-10 08:48:36.891466 | controller | 2025-10-10 08:48:36.891594 | controller | TASK [build_openstack_packages : Create mock group] **************************** 2025-10-10 08:48:36.891707 | controller | ok: [localhost] 2025-10-10 08:48:36.891830 | controller | 2025-10-10 08:48:36.891968 | controller | TASK [build_openstack_packages : Add user to mock group] *********************** 2025-10-10 08:48:36.892089 | controller | ok: [localhost] 2025-10-10 08:48:36.892192 | controller | 2025-10-10 08:48:36.892322 | controller | TASK [build_openstack_packages : Ensure DLRN dir is present] ******************* 2025-10-10 08:48:36.892419 | controller | changed: [localhost] 2025-10-10 08:48:36.892527 | controller | 2025-10-10 08:48:36.892649 | controller | TASK [build_openstack_packages : Remove data files from previous runs] ********* 2025-10-10 08:48:36.892775 | controller | ok: [localhost] 2025-10-10 08:48:36.892891 | controller | 2025-10-10 08:48:36.893087 | controller | TASK [build_openstack_packages : Create dlrn-venv] ***************************** 2025-10-10 08:48:36.893196 | controller | changed: [localhost] 2025-10-10 08:48:36.893307 | controller | 2025-10-10 08:48:36.893421 | controller | TASK [build_openstack_packages : Fetch DLRN from source] *********************** 2025-10-10 08:48:36.893532 | controller | skipping: [localhost] 2025-10-10 08:48:36.893658 | controller | 2025-10-10 08:48:36.893774 | controller | TASK [build_openstack_packages : Install DLRN requirements] ******************** 2025-10-10 08:48:36.893911 | controller | skipping: [localhost] 2025-10-10 08:48:36.894038 | controller | 2025-10-10 08:48:36.894155 | controller | TASK [build_openstack_packages : Install DLRN from source] ********************* 2025-10-10 08:48:36.894262 | controller | skipping: [localhost] 2025-10-10 08:48:36.894363 | controller | 2025-10-10 08:48:36.894483 | controller | TASK [build_openstack_packages : Install DLRN and rdopkg from pip] ************* 2025-10-10 08:48:36.894593 | controller | changed: [localhost] 2025-10-10 08:48:36.894700 | controller | 2025-10-10 08:48:36.894847 | controller | TASK [build_openstack_packages : Drop in the templated version of projects.ini] *** 2025-10-10 08:48:36.894964 | controller | changed: [localhost] 2025-10-10 08:48:36.895090 | controller | 2025-10-10 08:48:36.895206 | controller | TASK [build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir] *** 2025-10-10 08:48:36.895322 | controller | changed: [localhost] 2025-10-10 08:48:36.895422 | controller | 2025-10-10 08:48:36.895535 | controller | TASK [build_openstack_packages : Fetch local rdoinfo copy] ********************* 2025-10-10 08:48:36.895641 | controller | changed: [localhost] 2025-10-10 08:48:36.895743 | controller | 2025-10-10 08:48:36.895876 | controller | TASK [build_openstack_packages : Downstream related tasks] ********************* 2025-10-10 08:48:36.896008 | controller | skipping: [localhost] 2025-10-10 08:48:36.896113 | controller | 2025-10-10 08:48:36.896226 | controller | TASK [build_openstack_packages : Find all the repos files] ********************* 2025-10-10 08:48:36.896335 | controller | ok: [localhost] 2025-10-10 08:48:36.896436 | controller | 2025-10-10 08:48:36.896548 | controller | TASK [build_openstack_packages : Create local mock config] ********************* 2025-10-10 08:48:36.896656 | controller | changed: [localhost] 2025-10-10 08:48:36.896757 | controller | 2025-10-10 08:48:36.896901 | controller | TASK [build_openstack_packages : Remove last """ from local mock config] ******* 2025-10-10 08:48:36.897044 | controller | changed: [localhost] 2025-10-10 08:48:36.897149 | controller | 2025-10-10 08:48:36.897265 | controller | TASK [build_openstack_packages : Append repos into mock local config] ********** 2025-10-10 08:48:36.897382 | controller | included: /root/roles/build_openstack_packages/tasks/append_repos.yml for localhost => (item=/root/yum.repos.d/delorean.repo) 2025-10-10 08:48:36.897495 | controller | included: /root/roles/build_openstack_packages/tasks/append_repos.yml for localhost => (item=/root/yum.repos.d/delorean-antelope-testing.repo) 2025-10-10 08:48:36.897610 | controller | included: /root/roles/build_openstack_packages/tasks/append_repos.yml for localhost => (item=/root/yum.repos.d/repo-setup-centos-highavailability.repo) 2025-10-10 08:48:36.897725 | controller | included: /root/roles/build_openstack_packages/tasks/append_repos.yml for localhost => (item=/root/yum.repos.d/repo-setup-centos-powertools.repo) 2025-10-10 08:48:36.897863 | controller | included: /root/roles/build_openstack_packages/tasks/append_repos.yml for localhost => (item=/root/yum.repos.d/repo-setup-centos-appstream.repo) 2025-10-10 08:48:36.897993 | controller | included: /root/roles/build_openstack_packages/tasks/append_repos.yml for localhost => (item=/root/yum.repos.d/repo-setup-centos-baseos.repo) 2025-10-10 08:48:36.898099 | controller | 2025-10-10 08:48:36.898213 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2025-10-10 08:48:36.898322 | controller | ok: [localhost] 2025-10-10 08:48:36.898423 | controller | 2025-10-10 08:48:36.898534 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2025-10-10 08:48:36.898641 | controller | ok: [localhost] 2025-10-10 08:48:36.898741 | controller | 2025-10-10 08:48:36.898870 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2025-10-10 08:48:36.898993 | controller | ok: [localhost] 2025-10-10 08:48:36.899097 | controller | 2025-10-10 08:48:36.899210 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2025-10-10 08:48:36.899326 | controller | ok: [localhost] 2025-10-10 08:48:36.899427 | controller | 2025-10-10 08:48:36.899538 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2025-10-10 08:48:36.899643 | controller | ok: [localhost] 2025-10-10 08:48:36.899741 | controller | 2025-10-10 08:48:36.899868 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2025-10-10 08:48:36.899994 | controller | ok: [localhost] 2025-10-10 08:48:36.900095 | controller | 2025-10-10 08:48:36.900207 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2025-10-10 08:48:36.900318 | controller | ok: [localhost] 2025-10-10 08:48:36.900423 | controller | 2025-10-10 08:48:36.900541 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2025-10-10 08:48:36.900650 | controller | ok: [localhost] 2025-10-10 08:48:36.900753 | controller | 2025-10-10 08:48:36.900890 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2025-10-10 08:48:36.901019 | controller | ok: [localhost] 2025-10-10 08:48:36.901123 | controller | 2025-10-10 08:48:36.901235 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2025-10-10 08:48:36.901392 | controller | ok: [localhost] 2025-10-10 08:48:36.901498 | controller | 2025-10-10 08:48:36.901634 | controller | TASK [build_openstack_packages : Slurp the repo files and append] ************** 2025-10-10 08:48:36.901730 | controller | ok: [localhost] 2025-10-10 08:48:36.901862 | controller | 2025-10-10 08:48:36.901994 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] ***** 2025-10-10 08:48:36.902102 | controller | ok: [localhost] 2025-10-10 08:48:36.902222 | controller | 2025-10-10 08:48:36.902332 | controller | TASK [build_openstack_packages : Append repo_content ending with """ in mock local config at last] *** 2025-10-10 08:48:36.902449 | controller | changed: [localhost] 2025-10-10 08:48:36.902548 | controller | 2025-10-10 08:48:36.902681 | controller | TASK [build_openstack_packages : Check loop devices stat] ********************** 2025-10-10 08:48:36.902799 | controller | ok: [localhost] => (item=0) 2025-10-10 08:48:36.902915 | controller | ok: [localhost] => (item=1) 2025-10-10 08:48:36.903038 | controller | ok: [localhost] => (item=2) 2025-10-10 08:48:36.903143 | controller | ok: [localhost] => (item=3) 2025-10-10 08:48:36.903247 | controller | ok: [localhost] => (item=4) 2025-10-10 08:48:36.903353 | controller | ok: [localhost] => (item=5) 2025-10-10 08:48:36.903649 | controller | ok: [localhost] => (item=6) 2025-10-10 08:48:36.903781 | controller | ok: [localhost] => (item=7) 2025-10-10 08:48:36.903905 | controller | ok: [localhost] => (item=8) 2025-10-10 08:48:36.904048 | controller | ok: [localhost] => (item=9) 2025-10-10 08:48:36.904160 | controller | ok: [localhost] => (item=10) 2025-10-10 08:48:36.904261 | controller | ok: [localhost] => (item=11) 2025-10-10 08:48:36.904363 | controller | 2025-10-10 08:48:36.904489 | controller | TASK [build_openstack_packages : Set loop_devices_absent fact] ***************** 2025-10-10 08:48:36.904595 | controller | ok: [localhost] 2025-10-10 08:48:36.904698 | controller | 2025-10-10 08:48:36.904834 | controller | TASK [build_openstack_packages : Parse Zuul changes] *************************** 2025-10-10 08:48:36.904950 | controller | skipping: [localhost] 2025-10-10 08:48:36.905120 | controller | 2025-10-10 08:48:36.905238 | controller | TASK [build_openstack_packages : Print Zuul change list] *********************** 2025-10-10 08:48:36.905349 | controller | ok: [localhost] => { 2025-10-10 08:48:36.905461 | controller | "cifmw_bop_change_list": [] 2025-10-10 08:48:36.905570 | controller | } 2025-10-10 08:48:36.905673 | controller | 2025-10-10 08:48:36.905813 | controller | TASK [build_openstack_packages : Build DLRN packages from zuul changes] ******** 2025-10-10 08:48:36.905936 | controller | skipping: [localhost] 2025-10-10 08:48:36.906056 | controller | 2025-10-10 08:48:36.906178 | controller | TASK [build_openstack_packages : Build DLRN packages from Local change] ******** 2025-10-10 08:48:36.906291 | controller | included: /root/roles/build_openstack_packages/tasks/run_dlrn.yml for localhost 2025-10-10 08:48:36.906394 | controller | 2025-10-10 08:48:36.906507 | controller | TASK [build_openstack_packages : Set proper branch name for stable opendev branches] *** 2025-10-10 08:48:36.906626 | controller | skipping: [localhost] 2025-10-10 08:48:36.906728 | controller | 2025-10-10 08:48:36.906873 | controller | TASK [build_openstack_packages : Set proper branch name for non-stable branches] *** 2025-10-10 08:48:36.907009 | controller | ok: [localhost] 2025-10-10 08:48:36.907122 | controller | 2025-10-10 08:48:36.907239 | controller | TASK [build_openstack_packages : Set RDO release for master openstack release] *** 2025-10-10 08:48:36.907348 | controller | ok: [localhost] 2025-10-10 08:48:36.907451 | controller | 2025-10-10 08:48:36.907568 | controller | TASK [build_openstack_packages : Set RDO release for non-master openstack release] *** 2025-10-10 08:48:36.907689 | controller | skipping: [localhost] 2025-10-10 08:48:36.907813 | controller | 2025-10-10 08:48:36.907940 | controller | TASK [build_openstack_packages : Make sure /usr/share/rhn/RHN-ORG-TRUSTED-SSL-CERT exists (RHEL)] *** 2025-10-10 08:48:36.908067 | controller | skipping: [localhost] 2025-10-10 08:48:36.908172 | controller | 2025-10-10 08:48:36.908291 | controller | TASK [build_openstack_packages : Override projects.ini settings] *************** 2025-10-10 08:48:36.908406 | controller | ok: [localhost] => (item={'regexp': 'baseurl=.*', 'line': 'baseurl=https://trunk.rdoproject.org/centos9-master'}) 2025-10-10 08:48:36.908527 | controller | ok: [localhost] => (item={'regexp': 'distro=.*', 'line': 'distro=rpm-master'}) 2025-10-10 08:48:36.908641 | controller | ok: [localhost] => (item={'regexp': 'source=.*', 'line': 'source=master'}) 2025-10-10 08:48:36.908745 | controller | 2025-10-10 08:48:36.908876 | controller | TASK [build_openstack_packages : Map project name to DLRN project name] ******** 2025-10-10 08:48:36.909012 | controller | ok: [localhost] 2025-10-10 08:48:36.909118 | controller | 2025-10-10 08:48:36.909233 | controller | TASK [build_openstack_packages : Create data directory if doesn't exist yet] *** 2025-10-10 08:48:36.909340 | controller | changed: [localhost] 2025-10-10 08:48:36.909445 | controller | 2025-10-10 08:48:36.909570 | controller | TASK [build_openstack_packages : Check for existing python-neutron-tests-tempest] *** 2025-10-10 08:48:36.909681 | controller | ok: [localhost] 2025-10-10 08:48:36.909800 | controller | 2025-10-10 08:48:36.909923 | controller | TASK [build_openstack_packages : Sync python-neutron-tests-tempest from local repo] *** 2025-10-10 08:48:36.910050 | controller | changed: [localhost] 2025-10-10 08:48:36.910161 | controller | 2025-10-10 08:48:36.910275 | controller | TASK [build_openstack_packages : Symlink python-neutron-tests-tempest from Zuul clonned repos for upstream] *** 2025-10-10 08:48:36.910383 | controller | skipping: [localhost] 2025-10-10 08:48:36.910484 | controller | 2025-10-10 08:48:36.910601 | controller | TASK [build_openstack_packages : Update packages.yml to use zuul repo for python-neutron-tests-tempest] *** 2025-10-10 08:48:36.910714 | controller | skipping: [localhost] 2025-10-10 08:48:36.910843 | controller | 2025-10-10 08:48:36.910966 | controller | TASK [build_openstack_packages : Find the last commit from the clonned repo] *** 2025-10-10 08:48:36.911092 | controller | changed: [localhost] 2025-10-10 08:48:36.911204 | controller | 2025-10-10 08:48:36.911319 | controller | TASK [build_openstack_packages : Print the last commit of the git repo] ******** 2025-10-10 08:48:36.911427 | controller | ok: [localhost] => { 2025-10-10 08:48:36.911536 | controller | "_commit.stdout": "27c0c5ba5abc21aa340e27a7d5e8981ab3249d33" 2025-10-10 08:48:36.911645 | controller | } 2025-10-10 08:48:36.911748 | controller | 2025-10-10 08:48:36.911892 | controller | TASK [build_openstack_packages : Ensure distgit repo is absent, DLRN takes care of cloning based on config] *** 2025-10-10 08:48:36.912026 | controller | ok: [localhost] 2025-10-10 08:48:36.912129 | controller | 2025-10-10 08:48:36.912240 | controller | TASK [build_openstack_packages : Generate DLRN Script] ************************* 2025-10-10 08:48:36.912349 | controller | changed: [localhost] 2025-10-10 08:48:36.912450 | controller | 2025-10-10 08:48:36.912563 | controller | TASK [build_openstack_packages : Print info about building] ******************** 2025-10-10 08:48:36.912670 | controller | ok: [localhost] => { 2025-10-10 08:48:36.912792 | controller | "msg": "Building change for python-neutron-tests-tempest" 2025-10-10 08:48:36.912910 | controller | } 2025-10-10 08:48:36.913039 | controller | 2025-10-10 08:48:36.913155 | controller | TASK [build_openstack_packages : Ensure logs dir exists] *********************** 2025-10-10 08:48:36.913263 | controller | changed: [localhost] 2025-10-10 08:48:36.913365 | controller | 2025-10-10 08:48:36.913478 | controller | TASK [build_openstack_packages : Run DLRN] ************************************* 2025-10-10 08:48:36.913619 | controller | fatal: [localhost]: FAILED! => {"changed": true, "cmd": "set -o pipefail && /root/neutron-tempest-plugin/run_dlrn.sh 2>&1 | awk '{ print strftime(\"%Y-%m-%d %H:%M:%S |\"), $0; fflush(); }' >> /root/ci-framework-data/logs/dlrn.log\n", "delta": "0:00:45.523776", "end": "2025-10-10 08:48:35.374204", "msg": "non-zero return code", "rc": 1, "start": "2025-10-10 08:47:49.850428", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []} 2025-10-10 08:48:36.913720 | controller | 2025-10-10 08:48:36.913850 | controller | PLAY RECAP ********************************************************************* 2025-10-10 08:48:36.913984 | controller | localhost : ok=56 changed=18 unreachable=0 failed=1 skipped=17 rescued=1 ignored=0 2025-10-10 08:48:36.914140 | controller | stdout_lines: 2025-10-10 08:48:36.914371 | controller | 2025-10-10 08:48:36.914485 | controller | PLAY RECAP ********************************************************************* 2025-10-10 08:48:36.914613 | controller | instance : ok=9 changed=7 unreachable=0 failed=1 skipped=0 rescued=0 ignored=0 2025-10-10 08:48:36.914708 | controller | 2025-10-10 08:48:36.914840 | controller | Friday 10 October 2025 08:48:36 +0000 (0:01:49.094) 0:03:07.334 ******** 2025-10-10 08:48:36.914960 | controller | =============================================================================== 2025-10-10 08:48:36.915085 | controller | pkg_build : Build package using container ----------------------------- 109.09s 2025-10-10 08:48:36.915197 | controller | pkg_build : Build container image -------------------------------------- 74.07s 2025-10-10 08:48:36.915306 | controller | Get repository to build from -------------------------------------------- 1.52s 2025-10-10 08:48:36.915417 | controller | Gathering Facts --------------------------------------------------------- 0.79s 2025-10-10 08:48:36.915526 | controller | pkg_build : Generate Containerfile.buildpkg ----------------------------- 0.54s 2025-10-10 08:48:36.915637 | controller | pkg_build : Ensure directories exist ------------------------------------ 0.48s 2025-10-10 08:48:36.915758 | controller | pkg_build : Generate playbooks for package build ------------------------ 0.35s 2025-10-10 08:48:36.915899 | controller | pkg_build : Ensure per-package log directories exist -------------------- 0.21s 2025-10-10 08:48:36.916046 | controller | pkg_build : Ensure per-package build directories exist ------------------ 0.21s 2025-10-10 08:48:36.916159 | controller | pkg_build : Generate volume list ---------------------------------------- 0.03s 2025-10-10 08:48:36.916267 | controller | Build package ----------------------------------------------------------- 0.02s 2025-10-10 08:48:36.934213 | controller | CRITICAL Ansible return code was 2, command was: ['ansible-playbook', '--inventory', '/home/zuul/.cache/molecule/pkg_build/default/inventory', '--skip-tags', 'molecule-notest,notest', '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/pkg_build/molecule/default/converge.yml'] 2025-10-10 08:48:36.934586 | controller | WARNING An error occurred during the test sequence action: 'converge'. Cleaning up. 2025-10-10 08:48:36.943225 | controller | INFO Running default > cleanup 2025-10-10 08:48:36.943722 | controller | WARNING Skipping, cleanup playbook not configured. 2025-10-10 08:48:36.951524 | controller | INFO Running default > destroy 2025-10-10 08:48:36.951845 | controller | WARNING Skipping, instances are delegated. 2025-10-10 08:48:36.952184 | controller | INFO Pruning extra files from scenario ephemeral directory 2025-10-10 08:48:36.953588 | controller | INFO Writing /tmp/report.html report. 2025-10-10 08:48:37.391027 | controller | ERROR 2025-10-10 08:48:37.391169 | controller | { 2025-10-10 08:48:37.391204 | controller | "delta": "0:05:01.659853", 2025-10-10 08:48:37.391228 | controller | "end": "2025-10-10 08:48:37.004512", 2025-10-10 08:48:37.391248 | controller | "msg": "non-zero return code", 2025-10-10 08:48:37.391272 | controller | "rc": 1, 2025-10-10 08:48:37.391293 | controller | "start": "2025-10-10 08:43:35.344659" 2025-10-10 08:48:37.391313 | controller | } failure 2025-10-10 08:48:37.442612 | 2025-10-10 08:48:37.442829 | PLAY RECAP 2025-10-10 08:48:37.442890 | controller | ok: 2 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2025-10-10 08:48:37.442945 | 2025-10-10 08:48:37.591430 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-10-10 08:48:37.592519 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-10 08:48:38.197376 | 2025-10-10 08:48:38.197505 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-10 08:48:38.218762 | 2025-10-10 08:48:38.218869 | TASK [Filter out host if needed] 2025-10-10 08:48:38.228096 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-10 08:48:38.232740 | 2025-10-10 08:48:38.232822 | TASK [Ensure file is present] 2025-10-10 08:48:38.554325 | controller | ok 2025-10-10 08:48:38.577705 | 2025-10-10 08:48:38.577826 | TASK [Manage molecule report file] 2025-10-10 08:48:39.108709 | controller | changed 2025-10-10 08:48:39.114635 | 2025-10-10 08:48:39.114706 | TASK [Check if we get ci-framework-data basedir] 2025-10-10 08:48:39.306142 | controller | ok 2025-10-10 08:48:39.312517 | 2025-10-10 08:48:39.312585 | TASK [Create ci-framework-data log directory for zuul] 2025-10-10 08:48:39.627802 | controller | changed 2025-10-10 08:48:39.633841 | 2025-10-10 08:48:39.633938 | TASK [Copy ci-framework interesting files] 2025-10-10 08:48:39.839857 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-10 08:48:40.163634 | controller | changed 2025-10-10 08:48:40.169650 | 2025-10-10 08:48:40.169740 | TASK [Get SELinux listing] 2025-10-10 08:48:40.724694 | controller | changed 2025-10-10 08:48:40.731323 | 2025-10-10 08:48:40.731404 | TASK [Generate log index] 2025-10-10 08:48:41.384701 | controller | changed 2025-10-10 08:48:41.390524 | 2025-10-10 08:48:41.390606 | TASK [Get some env related data] 2025-10-10 08:48:41.931670 | controller | /home/zuul/.local/bin/ansible 2025-10-10 08:48:42.917413 | controller | changed 2025-10-10 08:48:42.923430 | 2025-10-10 08:48:42.923545 | TASK [Generate list of logs to collect in home directory] 2025-10-10 08:48:43.227151 | controller | ok: All paths examined 2025-10-10 08:48:43.232860 | 2025-10-10 08:48:43.232955 | LOOP [Copy logs from home directory] 2025-10-10 08:48:43.575161 | controller | changed: 2025-10-10 08:48:43.575303 | controller | { 2025-10-10 08:48:43.575332 | controller | "atime": 1760085796.972045, 2025-10-10 08:48:43.575352 | controller | "ctime": 1760085813.0353744, 2025-10-10 08:48:43.575388 | controller | "dev": 64513, 2025-10-10 08:48:43.575408 | controller | "gid": 1000, 2025-10-10 08:48:43.575424 | controller | "gr_name": "zuul", 2025-10-10 08:48:43.575440 | controller | "inode": 4481433, 2025-10-10 08:48:43.575456 | controller | "isblk": false, 2025-10-10 08:48:43.575472 | controller | "ischr": false, 2025-10-10 08:48:43.575488 | controller | "isdir": false, 2025-10-10 08:48:43.575503 | controller | "isfifo": false, 2025-10-10 08:48:43.575518 | controller | "isgid": false, 2025-10-10 08:48:43.575532 | controller | "islnk": false, 2025-10-10 08:48:43.575559 | controller | "isreg": true, 2025-10-10 08:48:43.575579 | controller | "issock": false, 2025-10-10 08:48:43.575594 | controller | "isuid": false, 2025-10-10 08:48:43.575609 | controller | "mode": "0644", 2025-10-10 08:48:43.575625 | controller | "mtime": 1760085813.0353744, 2025-10-10 08:48:43.575640 | controller | "nlink": 1, 2025-10-10 08:48:43.575656 | controller | "path": "/home/zuul/ansible.log", 2025-10-10 08:48:43.575688 | controller | "pw_name": "zuul", 2025-10-10 08:48:43.575708 | controller | "rgrp": true, 2025-10-10 08:48:43.575724 | controller | "roth": true, 2025-10-10 08:48:43.575739 | controller | "rusr": true, 2025-10-10 08:48:43.575753 | controller | "size": 6749, 2025-10-10 08:48:43.575767 | controller | "uid": 1000, 2025-10-10 08:48:43.575782 | controller | "wgrp": false, 2025-10-10 08:48:43.575796 | controller | "woth": false, 2025-10-10 08:48:43.575826 | controller | "wusr": true, 2025-10-10 08:48:43.575844 | controller | "xgrp": false, 2025-10-10 08:48:43.575865 | controller | "xoth": false, 2025-10-10 08:48:43.575880 | controller | "xusr": false 2025-10-10 08:48:43.575894 | controller | } 2025-10-10 08:48:43.588400 | 2025-10-10 08:48:43.588471 | TASK [Copy crio stats log file] 2025-10-10 08:48:43.602958 | controller | skipping: Conditional result was False 2025-10-10 08:48:43.609433 | 2025-10-10 08:48:43.609508 | TASK [Get SELinux related data] 2025-10-10 08:48:43.821221 | controller | 2025-10-10 08:48:44.138752 | controller | ERROR 2025-10-10 08:48:44.138949 | controller | { 2025-10-10 08:48:44.138994 | controller | "delta": "0:00:00.007889", 2025-10-10 08:48:44.139018 | controller | "end": "2025-10-10 08:48:43.821718", 2025-10-10 08:48:44.139037 | controller | "msg": "non-zero return code", 2025-10-10 08:48:44.139055 | controller | "rc": 1, 2025-10-10 08:48:44.139073 | controller | "start": "2025-10-10 08:48:43.813829" 2025-10-10 08:48:44.139088 | controller | } 2025-10-10 08:48:44.139112 | controller | ERROR: Ignoring Errors 2025-10-10 08:48:44.144645 | 2025-10-10 08:48:44.144713 | TASK [Create system configuration directory] 2025-10-10 08:48:44.337091 | controller | changed 2025-10-10 08:48:44.342351 | 2025-10-10 08:48:44.342426 | TASK [Get some of the system configurations] 2025-10-10 08:48:44.872292 | controller | changed 2025-10-10 08:48:44.877624 | 2025-10-10 08:48:44.877696 | TASK [Copy generated documentation if available] 2025-10-10 08:48:44.892108 | controller | skipping: Conditional result was False 2025-10-10 08:48:44.897657 | 2025-10-10 08:48:44.897729 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-10 08:48:44.921885 | controller | skipping: Conditional result was False 2025-10-10 08:48:44.928156 | 2025-10-10 08:48:44.928234 | TASK [Compress logs bigger than 2MB] 2025-10-10 08:48:45.453161 | controller | changed 2025-10-10 08:48:45.459451 | 2025-10-10 08:48:45.459542 | TASK [Copy files from workspace on node] 2025-10-10 08:48:45.478006 | controller | ok 2025-10-10 08:48:45.502954 | 2025-10-10 08:48:45.503054 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-10 08:48:45.526733 | controller | skipping: Conditional result was False 2025-10-10 08:48:45.532765 | 2025-10-10 08:48:45.532858 | TASK [fetch-output : Set log path for single node] 2025-10-10 08:48:45.564027 | controller | ok 2025-10-10 08:48:45.569342 | 2025-10-10 08:48:45.569439 | LOOP [fetch-output : Ensure local output dirs] 2025-10-10 08:48:45.783270 | controller -> localhost | ok: "/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/logs" 2025-10-10 08:48:45.783521 | controller -> localhost | changed: All items complete 2025-10-10 08:48:45.783551 | 2025-10-10 08:48:45.987744 | controller -> localhost | changed: "/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/artifacts" 2025-10-10 08:48:46.182524 | controller -> localhost | changed: "/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/docs" 2025-10-10 08:48:46.191942 | 2025-10-10 08:48:46.192060 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-10 08:48:46.764158 | controller | changed: 2025-10-10 08:48:46.764359 | controller | .d..t...... ./ 2025-10-10 08:48:46.764391 | controller | >f+++++++++ README.html 2025-10-10 08:48:46.764415 | controller | >f+++++++++ ansible-execution.log 2025-10-10 08:48:46.764438 | controller | >f+++++++++ ansible.log 2025-10-10 08:48:46.764461 | controller | >f+++++++++ dmesg.log 2025-10-10 08:48:46.764480 | controller | >f+++++++++ installed-pkgs.log 2025-10-10 08:48:46.764501 | controller | >f+++++++++ python.log 2025-10-10 08:48:46.764522 | controller | >f+++++++++ registries.conf 2025-10-10 08:48:46.764539 | controller | >f+++++++++ report.html 2025-10-10 08:48:46.764560 | controller | >f+++++++++ selinux-denials.log 2025-10-10 08:48:46.764579 | controller | >f+++++++++ selinux-listing.log 2025-10-10 08:48:46.764597 | controller | cd+++++++++ ci-framework-data/ 2025-10-10 08:48:46.764614 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-10 08:48:46.764631 | controller | >f+++++++++ ci-framework-data/artifacts/Containerfile.buildpkg 2025-10-10 08:48:46.764656 | controller | >f+++++++++ ci-framework-data/artifacts/build-packages.yml 2025-10-10 08:48:46.764676 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-10 08:48:46.764693 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/ 2025-10-10 08:48:46.764711 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/ 2025-10-10 08:48:46.764727 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/ 2025-10-10 08:48:46.764744 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-10 08:48:46.764761 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-10 08:48:46.764778 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/ 2025-10-10 08:48:46.764794 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean-antelope-testing.repo 2025-10-10 08:48:46.764833 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo 2025-10-10 08:48:46.764855 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5 2025-10-10 08:48:46.764874 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-appstream.repo 2025-10-10 08:48:46.764892 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-baseos.repo 2025-10-10 08:48:46.764931 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-highavailability.repo 2025-10-10 08:48:46.764960 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-powertools.repo 2025-10-10 08:48:46.764982 | controller | cd+++++++++ ci-framework-data/logs/ 2025-10-10 08:48:46.765000 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2025-10-10 08:48:46.765018 | controller | >f+++++++++ ci-framework-data/logs/neutron-tempest-plugin-builder.log 2025-10-10 08:48:46.765034 | controller | cd+++++++++ ci-framework-data/logs/build_neutron-tempest-plugin/ 2025-10-10 08:48:46.765051 | controller | cd+++++++++ registries.conf.d/ 2025-10-10 08:48:46.765067 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-10 08:48:46.765083 | controller | cd+++++++++ system-config/ 2025-10-10 08:48:46.765099 | controller | cd+++++++++ system-config/libvirt/ 2025-10-10 08:48:46.765115 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-10 08:48:46.765130 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-10 08:48:47.167379 | controller | changed: .d..t...... ./ 2025-10-10 08:48:47.551359 | controller | changed: .d..t...... ./ 2025-10-10 08:48:47.566446 | 2025-10-10 08:48:47.566561 | TASK [Return artifact to Zuul] 2025-10-10 08:48:47.596410 | controller | ok 2025-10-10 08:48:47.616171 | 2025-10-10 08:48:47.616250 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-10 08:48:47.616354 | 2025-10-10 08:48:47.616380 | PLAY RECAP 2025-10-10 08:48:47.616422 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2025-10-10 08:48:47.616445 | 2025-10-10 08:48:47.702489 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-10 08:48:47.703394 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-10 08:48:48.245135 | 2025-10-10 08:48:48.245267 | PLAY [all] 2025-10-10 08:48:48.266100 | 2025-10-10 08:48:48.266229 | TASK [include_role : fetch-output] 2025-10-10 08:48:48.315688 | controller | ok 2025-10-10 08:48:48.334632 | 2025-10-10 08:48:48.334764 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-10 08:48:48.379661 | controller | skipping: Conditional result was False 2025-10-10 08:48:48.385236 | 2025-10-10 08:48:48.385310 | TASK [fetch-output : Set log path for single node] 2025-10-10 08:48:48.413987 | controller | ok 2025-10-10 08:48:48.419971 | 2025-10-10 08:48:48.420065 | LOOP [fetch-output : Ensure local output dirs] 2025-10-10 08:48:48.781769 | controller -> localhost | ok: "/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/logs" 2025-10-10 08:48:48.994005 | controller -> localhost | ok: "/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/artifacts" 2025-10-10 08:48:49.189906 | controller -> localhost | ok: "/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/docs" 2025-10-10 08:48:49.204027 | 2025-10-10 08:48:49.204114 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-10 08:48:49.761032 | controller | ok 2025-10-10 08:48:49.761219 | controller | ok: All items complete 2025-10-10 08:48:49.761247 | 2025-10-10 08:48:50.178068 | controller | ok 2025-10-10 08:48:50.550141 | controller | ok 2025-10-10 08:48:50.568803 | 2025-10-10 08:48:50.568942 | TASK [include_role : fetch-output-openshift] 2025-10-10 08:48:50.583278 | controller | skipping: Conditional result was False 2025-10-10 08:48:50.589043 | 2025-10-10 08:48:50.589122 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-10 08:48:50.939401 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006857 2025-10-10 08:48:51.146327 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008019 2025-10-10 08:48:51.176495 | 2025-10-10 08:48:51.176588 | PLAY [all] 2025-10-10 08:48:51.190903 | 2025-10-10 08:48:51.191002 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-10 08:48:51.585568 | controller | changed 2025-10-10 08:48:51.608875 | 2025-10-10 08:48:51.608975 | PLAY RECAP 2025-10-10 08:48:51.609021 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-10 08:48:51.609043 | 2025-10-10 08:48:51.689025 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-10 08:48:51.689898 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-10 08:48:52.285037 | 2025-10-10 08:48:52.285151 | PLAY [localhost] 2025-10-10 08:48:52.304352 | 2025-10-10 08:48:52.304458 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-10 08:48:52.637347 | localhost | changed 2025-10-10 08:48:52.642251 | 2025-10-10 08:48:52.642367 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-10 08:48:52.670192 | localhost | ok 2025-10-10 08:48:52.678412 | 2025-10-10 08:48:52.678501 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-10 08:48:53.010442 | localhost | changed 2025-10-10 08:48:53.016140 | 2025-10-10 08:48:53.016235 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-10 08:48:53.642115 | localhost | changed 2025-10-10 08:48:53.647327 | 2025-10-10 08:48:53.647398 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-10 08:48:53.989542 | localhost | Identity added: /var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/tmp/ansible.02f6w_9s (/var/lib/zuul/builds/c3a2293fdd2e43de8e42eca855a87099/work/tmp/ansible.02f6w_9s) 2025-10-10 08:48:53.989730 | localhost | ok: Runtime: 0:00:00.006737 2025-10-10 08:48:53.994064 | 2025-10-10 08:48:53.994145 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-10 08:48:54.247775 | localhost | ok: Runtime: 0:00:00.005054 2025-10-10 08:48:54.253438 | 2025-10-10 08:48:54.253511 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-10 08:48:54.302540 | localhost | changed 2025-10-10 08:48:54.307100 | 2025-10-10 08:48:54.307173 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-10 08:48:54.628894 | localhost | changed 2025-10-10 08:48:54.648640 | 2025-10-10 08:48:54.648709 | PLAY [localhost] 2025-10-10 08:48:54.659956 | 2025-10-10 08:48:54.660029 | TASK [Generate bulk log download script] 2025-10-10 08:48:54.678100 | localhost | ok 2025-10-10 08:48:54.690075 | 2025-10-10 08:48:54.690145 | TASK [local-log-download : Check API endpoint is defined] 2025-10-10 08:48:54.717446 | localhost | ok: All assertions passed 2025-10-10 08:48:54.721858 | 2025-10-10 08:48:54.721942 | TASK [local-log-download : Create download script] 2025-10-10 08:48:55.100094 | localhost -> localhost | changed 2025-10-10 08:48:55.109598 | 2025-10-10 08:48:55.109701 | TASK [Register quick-download link] 2025-10-10 08:48:55.127511 | localhost | ok 2025-10-10 08:48:55.163522 | 2025-10-10 08:48:55.163619 | PLAY [logserver.rdoproject.org] 2025-10-10 08:48:55.173771 | 2025-10-10 08:48:55.173853 | TASK [Set zuul-log-path fact] 2025-10-10 08:48:55.189798 | logserver.rdoproject.org | ok 2025-10-10 08:48:55.199480 | 2025-10-10 08:48:55.199582 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 08:48:55.227717 | logserver.rdoproject.org | ok 2025-10-10 08:48:55.233288 | 2025-10-10 08:48:55.233415 | TASK [upload-logs : Create log directories] 2025-10-10 08:48:56.958725 | logserver.rdoproject.org | changed 2025-10-10 08:48:56.962611 | 2025-10-10 08:48:56.962688 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-10 08:48:57.209534 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006259 2025-10-10 08:48:57.214691 | 2025-10-10 08:48:57.214760 | TASK [upload-logs : Upload logs to log server] 2025-10-10 08:48:58.853662 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-10 08:48:58.857220 | 2025-10-10 08:48:58.857350 | LOOP [upload-logs : Compress console log and json output] 2025-10-10 08:48:58.902040 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 08:48:58.910315 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 08:48:58.918402 | 2025-10-10 08:48:58.918568 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-10 08:48:58.961767 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 08:48:58.962107 | 2025-10-10 08:48:58.965300 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 08:48:58.977987 | 2025-10-10 08:48:58.978160 | LOOP [upload-logs : Upload console log and json output]