2025-10-10 06:07:43.110972 | Job console starting... 2025-10-10 06:07:43.124120 | Updating repositories 2025-10-10 06:07:43.168656 | Preparing job workspace 2025-10-10 06:07:49.231741 | Running Ansible setup... 2025-10-10 06:07:53.034080 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-10 06:07:53.605639 | 2025-10-10 06:07:53.605783 | PLAY [localhost] 2025-10-10 06:07:53.614852 | 2025-10-10 06:07:53.614920 | TASK [Gathering Facts] 2025-10-10 06:07:54.687080 | localhost | ok 2025-10-10 06:07:54.701631 | 2025-10-10 06:07:54.701745 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-10 06:07:55.173574 | localhost -> localhost | changed 2025-10-10 06:07:55.187121 | 2025-10-10 06:07:55.187338 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-10 06:07:56.168520 | localhost -> localhost | changed 2025-10-10 06:07:56.178126 | 2025-10-10 06:07:56.178206 | TASK [Setup log path fact] 2025-10-10 06:07:56.201961 | localhost | ok 2025-10-10 06:07:56.217589 | 2025-10-10 06:07:56.217697 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 06:07:56.258127 | localhost | ok 2025-10-10 06:07:56.268597 | 2025-10-10 06:07:56.268708 | TASK [emit-job-header : Print job information] 2025-10-10 06:07:56.326644 | # Job Information 2025-10-10 06:07:56.326965 | Ansible Version: 2.15.12 2025-10-10 06:07:56.327021 | Job: periodic-edpm-build-push-images-centos-9-antelope 2025-10-10 06:07:56.327064 | Pipeline: openstack-periodic-container-antelope-centos9 2025-10-10 06:07:56.327103 | Executor: ze02.softwarefactory-project.io 2025-10-10 06:07:56.327140 | Triggered by: https://review.rdoproject.org/r/plugins/gitiles/rdo-jobs/+/None^!/ 2025-10-10 06:07:56.327179 | Log URL (when completed): https://logserver.rdoproject.org/be0/rdoproject.org/be058301cb644d2b92ffdd4d638a6a0e/ 2025-10-10 06:07:56.327218 | Event ID: c8026dc604be4663858e2ec70e5d25e4 2025-10-10 06:07:56.335176 | 2025-10-10 06:07:56.335317 | LOOP [emit-job-header : Print node information] 2025-10-10 06:07:56.458802 | localhost | ok: 2025-10-10 06:07:56.459094 | localhost | # Node Information 2025-10-10 06:07:56.459148 | localhost | Inventory Hostname: controller 2025-10-10 06:07:56.459198 | localhost | Hostname: np0005479369 2025-10-10 06:07:56.459239 | localhost | Username: zuul 2025-10-10 06:07:56.459281 | localhost | Distro: CentOS 9 2025-10-10 06:07:56.459319 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-10 06:07:56.459357 | localhost | Region: RegionOne 2025-10-10 06:07:56.459487 | localhost | Label: cloud-centos-9-stream-tripleo 2025-10-10 06:07:56.459540 | localhost | Product Name: OpenStack Nova 2025-10-10 06:07:56.459576 | localhost | Interface IP: 38.102.83.148 2025-10-10 06:07:56.486388 | 2025-10-10 06:07:56.486540 | PLAY [all] 2025-10-10 06:07:56.493417 | 2025-10-10 06:07:56.493484 | TASK [Gather network facts] 2025-10-10 06:07:57.001530 | controller | ok 2025-10-10 06:07:57.034961 | 2025-10-10 06:07:57.035100 | TASK [include_role : start-zuul-console] 2025-10-10 06:07:57.068328 | controller | ok 2025-10-10 06:07:57.084474 | 2025-10-10 06:07:57.084563 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-10 06:07:57.538817 | controller | ok 2025-10-10 06:07:57.558980 | 2025-10-10 06:07:57.559120 | TASK [include_role : add-build-sshkey] 2025-10-10 06:07:57.599171 | controller | ok 2025-10-10 06:07:57.625767 | 2025-10-10 06:07:57.625867 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-10 06:07:57.980886 | controller -> localhost | ok 2025-10-10 06:07:57.993247 | 2025-10-10 06:07:57.993378 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-10 06:07:58.033560 | controller | ok 2025-10-10 06:07:58.062067 | controller | included: /var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-10 06:07:58.070037 | 2025-10-10 06:07:58.070118 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-10 06:07:58.960276 | controller -> localhost | Generating public/private rsa key pair. 2025-10-10 06:07:58.960568 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/be058301cb644d2b92ffdd4d638a6a0e_id_rsa. 2025-10-10 06:07:58.960599 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/be058301cb644d2b92ffdd4d638a6a0e_id_rsa.pub. 2025-10-10 06:07:58.960620 | controller -> localhost | The key fingerprint is: 2025-10-10 06:07:58.960639 | controller -> localhost | SHA256:Euq88XHkK3SuSp5nQ5HDpFi37hbyZQvHqCINmdovgms zuul-build-sshkey 2025-10-10 06:07:58.960659 | controller -> localhost | The key's randomart image is: 2025-10-10 06:07:58.960696 | controller -> localhost | +---[RSA 3072]----+ 2025-10-10 06:07:58.960714 | controller -> localhost | | | 2025-10-10 06:07:58.960733 | controller -> localhost | | . o | 2025-10-10 06:07:58.960751 | controller -> localhost | | o =.o | 2025-10-10 06:07:58.960768 | controller -> localhost | | . ..*. | 2025-10-10 06:07:58.960785 | controller -> localhost | | o ...=S | 2025-10-10 06:07:58.960802 | controller -> localhost | |+ o. B+* | 2025-10-10 06:07:58.960819 | controller -> localhost | |o+ =B.Oo. | 2025-10-10 06:07:58.960836 | controller -> localhost | |=E=o.=Ooo. | 2025-10-10 06:07:58.960852 | controller -> localhost | |o+ +*=o+. | 2025-10-10 06:07:58.960869 | controller -> localhost | +----[SHA256]-----+ 2025-10-10 06:07:58.960922 | controller -> localhost | ok: Runtime: 0:00:00.351922 2025-10-10 06:07:58.967386 | 2025-10-10 06:07:58.967457 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-10 06:07:58.997745 | controller | ok 2025-10-10 06:07:59.008938 | controller | included: /var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-10 06:07:59.016613 | 2025-10-10 06:07:59.016700 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-10 06:07:59.051828 | controller | skipping: Conditional result was False 2025-10-10 06:07:59.057700 | 2025-10-10 06:07:59.057770 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-10 06:07:59.563230 | controller | changed 2025-10-10 06:07:59.574459 | 2025-10-10 06:07:59.574592 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-10 06:07:59.850912 | controller | ok 2025-10-10 06:07:59.862094 | 2025-10-10 06:07:59.862229 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-10 06:08:00.766004 | controller | changed 2025-10-10 06:08:00.777127 | 2025-10-10 06:08:00.777263 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-10 06:08:01.632910 | controller | changed 2025-10-10 06:08:01.644104 | 2025-10-10 06:08:01.644252 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-10 06:08:01.672519 | controller | skipping: Conditional result was False 2025-10-10 06:08:01.685765 | 2025-10-10 06:08:01.685957 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-10 06:08:02.143892 | controller -> localhost | changed 2025-10-10 06:08:02.167955 | 2025-10-10 06:08:02.168094 | TASK [add-build-sshkey : Add back temp key] 2025-10-10 06:08:02.478254 | controller -> localhost | Identity added: /var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/be058301cb644d2b92ffdd4d638a6a0e_id_rsa (zuul-build-sshkey) 2025-10-10 06:08:02.478809 | controller -> localhost | ok: Runtime: 0:00:00.016745 2025-10-10 06:08:02.491066 | 2025-10-10 06:08:02.491196 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-10 06:08:02.865000 | controller | ok 2025-10-10 06:08:02.875525 | 2025-10-10 06:08:02.875655 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-10 06:08:02.928179 | controller | skipping: Conditional result was False 2025-10-10 06:08:02.950918 | 2025-10-10 06:08:02.951072 | TASK [include_role : validate-host] 2025-10-10 06:08:02.991161 | controller | ok 2025-10-10 06:08:03.026909 | 2025-10-10 06:08:03.026997 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-10 06:08:03.074539 | controller | ok 2025-10-10 06:08:03.087914 | 2025-10-10 06:08:03.088046 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-10 06:08:03.441501 | controller -> localhost | ok 2025-10-10 06:08:03.455507 | 2025-10-10 06:08:03.455762 | TASK [validate-host : Collect information about the host] 2025-10-10 06:08:04.269617 | controller | ok 2025-10-10 06:08:04.289203 | 2025-10-10 06:08:04.289354 | TASK [validate-host : Sanitize hostname] 2025-10-10 06:08:04.351435 | controller | ok 2025-10-10 06:08:04.363466 | 2025-10-10 06:08:04.363568 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-10 06:08:04.829990 | controller -> localhost | changed 2025-10-10 06:08:04.843954 | 2025-10-10 06:08:04.844101 | TASK [validate-host : Collect information about zuul worker] 2025-10-10 06:08:05.293775 | controller | ok 2025-10-10 06:08:05.304317 | 2025-10-10 06:08:05.304441 | TASK [validate-host : Write out all zuul information for each host] 2025-10-10 06:08:05.773964 | controller -> localhost | changed 2025-10-10 06:08:05.796024 | 2025-10-10 06:08:05.796169 | TASK [include_role : prepare-workspace-openshift] 2025-10-10 06:08:05.824456 | controller | skipping: Conditional result was False 2025-10-10 06:08:05.837833 | 2025-10-10 06:08:05.837973 | TASK [include_role : remove-zuul-sshkey] 2025-10-10 06:08:05.865649 | controller | skipping: Conditional result was False 2025-10-10 06:08:05.877830 | 2025-10-10 06:08:05.877993 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-10 06:08:06.148816 | controller | ok: "logs" 2025-10-10 06:08:06.149307 | controller | ok: All items complete 2025-10-10 06:08:06.149366 | 2025-10-10 06:08:06.368617 | controller | ok: "artifacts" 2025-10-10 06:08:06.587199 | controller | ok: "docs" 2025-10-10 06:08:06.604036 | 2025-10-10 06:08:06.604300 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-10 06:08:06.900772 | controller | changed: "logs" 2025-10-10 06:08:07.144397 | controller | changed: "artifacts" 2025-10-10 06:08:07.371992 | controller | changed: "docs" 2025-10-10 06:08:07.431153 | 2025-10-10 06:08:07.431330 | PLAY RECAP 2025-10-10 06:08:07.431606 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-10 06:08:07.431661 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-10 06:08:07.431714 | 2025-10-10 06:08:07.571361 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-10 06:08:07.576220 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-10 06:08:08.232557 | 2025-10-10 06:08:08.232755 | PLAY [all] 2025-10-10 06:08:08.253317 | 2025-10-10 06:08:08.253391 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-10 06:08:08.306922 | controller | ok 2025-10-10 06:08:08.313997 | 2025-10-10 06:08:08.314105 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-10 06:08:08.851923 | controller | changed 2025-10-10 06:08:08.866756 | 2025-10-10 06:08:08.866918 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-10 06:08:10.042203 | controller | changed 2025-10-10 06:08:10.064852 | 2025-10-10 06:08:10.064998 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-10 06:08:10.658249 | controller | changed: 2025-10-10 06:08:10.658590 | controller | { 2025-10-10 06:08:10.658648 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-10 06:08:10.658863 | controller | } 2025-10-10 06:08:10.923823 | controller | changed: 2025-10-10 06:08:10.924009 | controller | { 2025-10-10 06:08:10.924063 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-10 06:08:10.924105 | controller | } 2025-10-10 06:08:11.212101 | controller | changed: 2025-10-10 06:08:11.212282 | controller | { 2025-10-10 06:08:11.212340 | 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 06:08:11.212387 | controller | } 2025-10-10 06:08:11.482386 | controller | changed: 2025-10-10 06:08:11.482557 | controller | { 2025-10-10 06:08:11.482607 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-10 06:08:11.482646 | controller | } 2025-10-10 06:08:11.799864 | controller | changed: 2025-10-10 06:08:11.800032 | controller | { 2025-10-10 06:08:11.800081 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-10 06:08:11.800120 | controller | } 2025-10-10 06:08:12.143159 | controller | changed: 2025-10-10 06:08:12.143341 | controller | { 2025-10-10 06:08:12.143406 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-10 06:08:12.143546 | controller | } 2025-10-10 06:08:12.406643 | controller | changed: 2025-10-10 06:08:12.406844 | controller | { 2025-10-10 06:08:12.406898 | 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 06:08:12.406942 | controller | } 2025-10-10 06:08:12.666302 | controller | changed: 2025-10-10 06:08:12.666481 | controller | { 2025-10-10 06:08:12.666533 | 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 06:08:12.666574 | controller | } 2025-10-10 06:08:12.939099 | controller | changed: 2025-10-10 06:08:12.939396 | controller | { 2025-10-10 06:08:12.939454 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-10 06:08:12.939495 | controller | } 2025-10-10 06:08:13.245723 | controller | changed: 2025-10-10 06:08:13.245911 | controller | { 2025-10-10 06:08:13.245960 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-10 06:08:13.245999 | controller | } 2025-10-10 06:08:13.491554 | controller | changed: 2025-10-10 06:08:13.491811 | controller | { 2025-10-10 06:08:13.491862 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-10 06:08:13.491900 | controller | } 2025-10-10 06:08:13.765801 | controller | changed: 2025-10-10 06:08:13.766155 | controller | { 2025-10-10 06:08:13.766220 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-10 06:08:13.766261 | controller | } 2025-10-10 06:08:14.065064 | controller | changed: 2025-10-10 06:08:14.065231 | controller | { 2025-10-10 06:08:14.065279 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-10 06:08:14.065318 | controller | } 2025-10-10 06:08:14.338758 | controller | changed: 2025-10-10 06:08:14.339093 | controller | { 2025-10-10 06:08:14.339157 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-10 06:08:14.339198 | controller | } 2025-10-10 06:08:14.684875 | controller | changed: 2025-10-10 06:08:14.685053 | controller | { 2025-10-10 06:08:14.685102 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-10 06:08:14.685142 | controller | } 2025-10-10 06:08:14.990899 | controller | changed: 2025-10-10 06:08:14.991082 | controller | { 2025-10-10 06:08:14.991148 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-10 06:08:14.991190 | controller | } 2025-10-10 06:08:15.278032 | controller | changed: 2025-10-10 06:08:15.278202 | controller | { 2025-10-10 06:08:15.278251 | 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 06:08:15.278291 | controller | } 2025-10-10 06:08:15.528507 | controller | changed: 2025-10-10 06:08:15.528645 | controller | { 2025-10-10 06:08:15.528724 | 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 06:08:15.528757 | controller | } 2025-10-10 06:08:15.804686 | controller | changed: 2025-10-10 06:08:15.804806 | controller | { 2025-10-10 06:08:15.804828 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-10 06:08:15.804846 | controller | } 2025-10-10 06:08:16.133082 | controller | changed: 2025-10-10 06:08:16.133267 | controller | { 2025-10-10 06:08:16.133388 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-10 06:08:16.133429 | controller | } 2025-10-10 06:08:16.393510 | controller | changed: 2025-10-10 06:08:16.393710 | controller | { 2025-10-10 06:08:16.393777 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-10 06:08:16.393833 | controller | } 2025-10-10 06:08:16.676401 | controller | changed: 2025-10-10 06:08:16.676546 | controller | { 2025-10-10 06:08:16.676576 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-10 06:08:16.676602 | controller | } 2025-10-10 06:08:16.981284 | controller | changed: 2025-10-10 06:08:16.981428 | controller | { 2025-10-10 06:08:16.981460 | 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 06:08:16.981487 | controller | } 2025-10-10 06:08:17.258941 | controller | changed: 2025-10-10 06:08:17.259077 | controller | { 2025-10-10 06:08:17.259124 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-10 06:08:17.259162 | controller | } 2025-10-10 06:08:17.547838 | controller | changed: 2025-10-10 06:08:17.547985 | controller | { 2025-10-10 06:08:17.548035 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-10 06:08:17.548074 | controller | } 2025-10-10 06:08:17.852559 | controller | changed: 2025-10-10 06:08:17.852750 | controller | { 2025-10-10 06:08:17.852801 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-10 06:08:17.852839 | controller | } 2025-10-10 06:08:17.890552 | 2025-10-10 06:08:17.890801 | TASK [Set timezone to UTC] 2025-10-10 06:08:18.585627 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-10 06:08:18.596752 | 2025-10-10 06:08:18.596909 | TASK [Create nodepool directory] 2025-10-10 06:08:18.892040 | controller | changed 2025-10-10 06:08:18.905933 | 2025-10-10 06:08:18.906066 | TASK [Create nodepool sub_nodes file] 2025-10-10 06:08:19.689440 | controller | changed 2025-10-10 06:08:19.701431 | 2025-10-10 06:08:19.701573 | TASK [Create nodepool sub_nodes_private file] 2025-10-10 06:08:20.493214 | controller | changed 2025-10-10 06:08:20.505399 | 2025-10-10 06:08:20.505529 | LOOP [Populate nodepool sub_nodes file] 2025-10-10 06:08:20.556804 | 2025-10-10 06:08:20.557053 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-10 06:08:20.607168 | 2025-10-10 06:08:20.607456 | TASK [Create nodepool primary file] 2025-10-10 06:08:20.635250 | controller | skipping: Conditional result was False 2025-10-10 06:08:20.647896 | 2025-10-10 06:08:20.648031 | TASK [Create nodepool node_private for this node] 2025-10-10 06:08:21.564313 | controller | changed 2025-10-10 06:08:21.578839 | 2025-10-10 06:08:21.578976 | LOOP [Copy ssh keys to nodepool directory] 2025-10-10 06:08:22.026738 | controller | ok: Item: id_rsa Runtime: 0:00:00.011621 2025-10-10 06:08:22.027141 | 2025-10-10 06:08:22.290904 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.007545 2025-10-10 06:08:22.305862 | 2025-10-10 06:08:22.306078 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-10 06:08:23.165805 | controller | changed 2025-10-10 06:08:23.176936 | 2025-10-10 06:08:23.177103 | TASK [Validate sudoers config after edits] 2025-10-10 06:08:23.503662 | controller | /etc/sudoers: parsed OK 2025-10-10 06:08:23.503767 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-10 06:08:23.503779 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-10 06:08:23.503788 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-10 06:08:23.726720 | controller | ok: Runtime: 0:00:00.010075 2025-10-10 06:08:23.739277 | 2025-10-10 06:08:23.739406 | TASK [Show the environment passed in to job shell scripts] 2025-10-10 06:08:24.045831 | controller | SHELL=/bin/bash 2025-10-10 06:08:24.045942 | controller | ZUUL_PROJECT=rdo-jobs 2025-10-10 06:08:24.046054 | controller | ZUUL_SHORT_PROJECT_NAME=rdo-jobs 2025-10-10 06:08:24.046088 | controller | PWD=/home/zuul 2025-10-10 06:08:24.046104 | controller | ZUUL_PIPELINE=openstack-periodic-container-antelope-centos9 2025-10-10 06:08:24.046119 | controller | LOGNAME=zuul 2025-10-10 06:08:24.046133 | controller | XDG_SESSION_TYPE=tty 2025-10-10 06:08:24.046148 | controller | _=/usr/bin/env 2025-10-10 06:08:24.046162 | controller | MOTD_SHOWN=pam 2025-10-10 06:08:24.046177 | controller | HOME=/home/zuul 2025-10-10 06:08:24.046191 | controller | LANG=en_US.UTF-8 2025-10-10 06:08:24.046205 | controller | SSH_CONNECTION=38.102.83.114 51770 38.102.83.148 22 2025-10-10 06:08:24.046220 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH 2025-10-10 06:08:24.046235 | controller | WORKSPACE=/home/zuul/workspace 2025-10-10 06:08:24.046249 | controller | XDG_SESSION_CLASS=user 2025-10-10 06:08:24.046263 | controller | SELINUX_ROLE_REQUESTED= 2025-10-10 06:08:24.046278 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-10 06:08:24.046293 | controller | USER=zuul 2025-10-10 06:08:24.046307 | controller | ZUUL_VOTING=True 2025-10-10 06:08:24.046321 | controller | BUILD_TIMEOUT=5400000 2025-10-10 06:08:24.046335 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-10 06:08:24.046350 | controller | SHLVL=1 2025-10-10 06:08:24.046364 | controller | XDG_SESSION_ID=1 2025-10-10 06:08:24.046378 | controller | ZUUL_BRANCH=master 2025-10-10 06:08:24.046398 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-10 06:08:24.046412 | controller | SSH_CLIENT=38.102.83.114 51770 22 2025-10-10 06:08:24.046427 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-10 06:08:24.046441 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-10 06:08:24.046456 | controller | which_declare=declare -f 2025-10-10 06:08:24.046470 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-10 06:08:24.046485 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-10 06:08:24.046499 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-10 06:08:24.046514 | controller | ZUUL_UUID=be058301cb644d2b92ffdd4d638a6a0e 2025-10-10 06:08:24.046529 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-10 06:08:24.046547 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-10 06:08:24.046561 | controller | } 2025-10-10 06:08:24.293378 | controller | ok: Runtime: 0:00:00.009699 2025-10-10 06:08:24.305837 | 2025-10-10 06:08:24.305973 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-10 06:08:24.334717 | controller | skipping: Conditional result was False 2025-10-10 06:08:24.347283 | 2025-10-10 06:08:24.347416 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-10 06:08:24.894733 | controller | skipping: Conditional result was False 2025-10-10 06:08:24.948775 | 2025-10-10 06:08:24.949001 | TASK [Ensure legacy workspace directory] 2025-10-10 06:08:25.232938 | controller | changed 2025-10-10 06:08:25.275209 | 2025-10-10 06:08:25.275298 | PLAY RECAP 2025-10-10 06:08:25.275355 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-10 06:08:25.275384 | 2025-10-10 06:08:25.403025 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-10 06:08:25.405310 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-10 06:08:26.020031 | 2025-10-10 06:08:26.020156 | PLAY [all,!compute] 2025-10-10 06:08:26.039794 | 2025-10-10 06:08:26.039917 | TASK [Enable container-tools rhel-modules for c8/crc node] 2025-10-10 06:08:26.571237 | controller | skipping: Conditional result was False 2025-10-10 06:08:26.583616 | 2025-10-10 06:08:26.583832 | TASK [Install podman] 2025-10-10 06:09:34.985022 | controller | changed 2025-10-10 06:09:34.992843 | 2025-10-10 06:09:34.992929 | TASK [Set var name for quay login zuul secret] 2025-10-10 06:09:35.102815 | controller | ok 2025-10-10 06:09:35.109329 | 2025-10-10 06:09:35.109393 | TASK [Print the username] 2025-10-10 06:09:35.519234 | controller | podified-antelope-centos9+cirobot 2025-10-10 06:09:35.642406 | controller | ok: Runtime: 0:00:00.006459 2025-10-10 06:09:35.655063 | 2025-10-10 06:09:35.655221 | TASK [Fail when user or password is not set] 2025-10-10 06:09:35.733959 | controller | skipping: Conditional result was False 2025-10-10 06:09:35.746870 | 2025-10-10 06:09:35.747019 | TASK [Set vars for quay login] 2025-10-10 06:09:35.827266 | controller | Output suppressed because no_log was given 2025-10-10 06:09:35.838630 | 2025-10-10 06:09:35.838796 | LOOP [Perform container registry login(s) with podman] 2025-10-10 06:09:36.565560 | controller | Output suppressed because no_log was given 2025-10-10 06:09:36.577013 | 2025-10-10 06:09:36.577146 | LOOP [Perform container registry login(s) with buildah] 2025-10-10 06:09:36.656308 | controller | Output suppressed because no_log was given 2025-10-10 06:09:36.676508 | 2025-10-10 06:09:36.676694 | TASK [Set Insecure registry for content provider] 2025-10-10 06:09:36.755765 | controller | skipping: Conditional result was False 2025-10-10 06:09:36.799324 | 2025-10-10 06:09:36.799442 | PLAY RECAP 2025-10-10 06:09:36.799537 | controller | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-10 06:09:36.799582 | 2025-10-10 06:09:36.950003 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-10 06:09:36.952349 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-10 06:09:37.618554 | 2025-10-10 06:09:37.618723 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-10-10 06:09:37.640410 | 2025-10-10 06:09:37.640484 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-10-10 06:09:37.671782 | controller | ok 2025-10-10 06:09:37.690604 | 2025-10-10 06:09:37.690711 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-10 06:09:37.736494 | controller | skipping: Conditional result was False 2025-10-10 06:09:37.742644 | 2025-10-10 06:09:37.742726 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-10 06:09:38.168498 | controller | ok 2025-10-10 06:09:38.174705 | 2025-10-10 06:09:38.174781 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-10 06:09:39.096576 | controller | ok 2025-10-10 06:09:39.120939 | 2025-10-10 06:09:39.121078 | TASK [Prepare workspace] 2025-10-10 06:09:39.153992 | controller | ok 2025-10-10 06:09:39.184608 | 2025-10-10 06:09:39.184735 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-10 06:09:39.596276 | controller | ok 2025-10-10 06:09:39.605005 | 2025-10-10 06:09:39.605092 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-10 06:09:42.581797 | controller | Output suppressed because no_log was given 2025-10-10 06:09:42.602970 | 2025-10-10 06:09:42.603100 | LOOP [Create zuul-output directory] 2025-10-10 06:09:42.859910 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-10-10 06:09:43.074508 | controller | ok: "/home/zuul/zuul-output/logs" 2025-10-10 06:09:43.085477 | 2025-10-10 06:09:43.085632 | TASK [Install required packages] 2025-10-10 06:09:44.318441 | controller | ok: Nothing to do 2025-10-10 06:09:44.325919 | 2025-10-10 06:09:44.326002 | TASK [Install venv] 2025-10-10 06:10:51.737898 | controller | changed 2025-10-10 06:10:51.837317 | 2025-10-10 06:10:51.837484 | PLAY RECAP 2025-10-10 06:10:51.837545 | controller | ok: 7 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-10 06:10:51.837573 | 2025-10-10 06:10:51.960421 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-10-10 06:10:51.962788 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-10 06:10:52.561429 | 2025-10-10 06:10:52.561556 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-10 06:10:52.581995 | 2025-10-10 06:10:52.582078 | TASK [Create zuul-output directory] 2025-10-10 06:10:53.034966 | controller | changed 2025-10-10 06:10:53.049965 | 2025-10-10 06:10:53.050181 | TASK [Slurp Zuul inventory test] 2025-10-10 06:10:53.469728 | controller -> localhost | ok 2025-10-10 06:10:53.483793 | 2025-10-10 06:10:53.483939 | TASK [Save zuul inventory] 2025-10-10 06:10:54.584363 | controller | changed 2025-10-10 06:10:54.597122 | 2025-10-10 06:10:54.597262 | TASK [Save zuul vars without the change_message] 2025-10-10 06:10:55.518524 | controller | changed 2025-10-10 06:10:55.544243 | 2025-10-10 06:10:55.544422 | PLAY RECAP 2025-10-10 06:10:55.544488 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-10 06:10:55.544517 | 2025-10-10 06:10:55.651356 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-10 06:10:55.652511 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/edpm_build_images/run.yml@main] 2025-10-10 06:10:56.244001 | 2025-10-10 06:10:56.244127 | PLAY [Run ci/playbooks/edpm_build_images/run.yml] 2025-10-10 06:10:56.264532 | 2025-10-10 06:10:56.264613 | TASK [Filter out host if needed] 2025-10-10 06:10:56.275157 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-10 06:10:56.280007 | 2025-10-10 06:10:56.280070 | TASK [Run EDPM build image] 2025-10-10 06:10:57.454564 | controller | 2025-10-10 06:10:58.463852 | controller | PLAY [Bootstrap playbook] ****************************************************** 2025-10-10 06:10:58.463976 | controller | 2025-10-10 06:10:58.463986 | controller | TASK [Gathering Facts ] ******************************************************** 2025-10-10 06:10:58.463993 | controller | Friday 10 October 2025 06:10:57 +0000 (0:00:00.044) 0:00:00.044 ******** 2025-10-10 06:10:58.464019 | controller | ok: [localhost] 2025-10-10 06:10:58.501521 | controller | 2025-10-10 06:10:58.501616 | controller | TASK [cifmw_setup : Set custom cifmw PATH reusable fact cifmw_path={{ ansible_user_dir }}/.crc/bin:{{ ansible_user_dir }}/.crc/bin/oc:{{ ansible_user_dir }}/bin:{{ ansible_env.PATH }}, cacheable=True] *** 2025-10-10 06:10:58.501630 | controller | Friday 10 October 2025 06:10:58 +0000 (0:00:01.010) 0:00:01.055 ******** 2025-10-10 06:10:58.501651 | controller | ok: [localhost] 2025-10-10 06:10:58.584366 | controller | 2025-10-10 06:10:58.584427 | controller | TASK [cifmw_setup : Get customized parameters ci_framework_params={{ 2025-10-10 06:10:58.584438 | controller | hostvars[inventory_hostname] | 2025-10-10 06:10:58.584495 | controller | dict2items | 2025-10-10 06:10:58.584504 | controller | selectattr("key", "match", 2025-10-10 06:10:58.584512 | controller | "^(cifmw|pre|post)_(?!install_yamls|openshift_token|openshift_login|openshift_kubeconfig).*") | 2025-10-10 06:10:58.584519 | controller | list | items2dict 2025-10-10 06:10:58.584525 | controller | }}] *** 2025-10-10 06:10:58.584532 | controller | Friday 10 October 2025 06:10:58 +0000 (0:00:00.038) 0:00:01.094 ******** 2025-10-10 06:10:58.584548 | controller | ok: [localhost] 2025-10-10 06:10:58.956545 | controller | 2025-10-10 06:10:58.956630 | controller | TASK [install_ca : Ensure target directory exists path={{ cifmw_install_ca_trust_dir }}, state=directory, mode=0755] *** 2025-10-10 06:10:58.956651 | controller | Friday 10 October 2025 06:10:58 +0000 (0:00:00.082) 0:00:01.176 ******** 2025-10-10 06:10:58.956719 | controller | ok: [localhost] 2025-10-10 06:10:58.991611 | controller | 2025-10-10 06:10:58.991670 | controller | TASK [install_ca : Install internal CA from url url={{ cifmw_install_ca_url }}, dest={{ cifmw_install_ca_trust_dir }}, validate_certs={{ cifmw_install_ca_url_validate_certs | default(omit) }}, mode=0644] *** 2025-10-10 06:10:58.991699 | controller | Friday 10 October 2025 06:10:58 +0000 (0:00:00.371) 0:00:01.548 ******** 2025-10-10 06:10:58.991720 | controller | skipping: [localhost] 2025-10-10 06:10:59.085056 | controller | 2025-10-10 06:10:59.085142 | controller | TASK [install_ca : Install custom CA bundle from inline dest={{ cifmw_install_ca_trust_dir }}/cifmw_inline_ca_bundle.crt, content={{ cifmw_install_ca_bundle_inline }}, mode=0644] *** 2025-10-10 06:10:59.085150 | controller | Friday 10 October 2025 06:10:58 +0000 (0:00:00.035) 0:00:01.583 ******** 2025-10-10 06:10:59.085171 | controller | skipping: [localhost] 2025-10-10 06:10:59.119118 | controller | 2025-10-10 06:10:59.119218 | controller | TASK [install_ca : Install custom CA bundle from file dest={{ cifmw_install_ca_trust_dir }}/{{ cifmw_install_ca_bundle_src | basename }}, src={{ cifmw_install_ca_bundle_src }}, mode=0644] *** 2025-10-10 06:10:59.119229 | controller | Friday 10 October 2025 06:10:59 +0000 (0:00:00.094) 0:00:01.677 ******** 2025-10-10 06:10:59.119251 | controller | skipping: [localhost] 2025-10-10 06:11:00.596577 | controller | 2025-10-10 06:11:00.596676 | controller | TASK [install_ca : Update ca bundle _raw_params=update-ca-trust] *************** 2025-10-10 06:11:00.596709 | controller | Friday 10 October 2025 06:10:59 +0000 (0:00:00.034) 0:00:01.711 ******** 2025-10-10 06:11:00.596729 | controller | changed: [localhost] 2025-10-10 06:11:01.151696 | controller | 2025-10-10 06:11:01.151773 | controller | TASK [repo_setup : Ensure directories are present path={{ cifmw_repo_setup_basedir }}/{{ item }}, state=directory, mode=0755] *** 2025-10-10 06:11:01.151782 | controller | Friday 10 October 2025 06:11:00 +0000 (0:00:01.477) 0:00:03.189 ******** 2025-10-10 06:11:01.151800 | controller | changed: [localhost] => (item=tmp) 2025-10-10 06:11:02.184339 | controller | changed: [localhost] => (item=artifacts/repositories) 2025-10-10 06:11:02.184418 | controller | changed: [localhost] => (item=venv/repo_setup) 2025-10-10 06:11:02.184426 | controller | 2025-10-10 06:11:02.184432 | controller | TASK [repo_setup : Make sure git-core package is installed name=git-core, state=present] *** 2025-10-10 06:11:02.184439 | controller | Friday 10 October 2025 06:11:01 +0000 (0:00:00.554) 0:00:03.743 ******** 2025-10-10 06:11:02.184481 | controller | ok: [localhost] 2025-10-10 06:11:02.749164 | controller | 2025-10-10 06:11:02.749318 | controller | TASK [repo_setup : Get repo-setup repository accept_hostkey=True, dest={{ cifmw_repo_setup_basedir }}/tmp/repo-setup, repo={{ cifmw_repo_setup_src }}] *** 2025-10-10 06:11:02.749336 | controller | Friday 10 October 2025 06:11:02 +0000 (0:00:01.032) 0:00:04.776 ******** 2025-10-10 06:11:02.749357 | controller | changed: [localhost] 2025-10-10 06:11:11.636773 | controller | 2025-10-10 06:11:11.636831 | controller | TASK [repo_setup : Initialize python venv and install requirements virtualenv={{ cifmw_repo_setup_venv }}, requirements={{ cifmw_repo_setup_basedir }}/tmp/repo-setup/requirements.txt, virtualenv_command=python3 -m venv --system-site-packages --upgrade-deps] *** 2025-10-10 06:11:11.636847 | controller | Friday 10 October 2025 06:11:02 +0000 (0:00:00.564) 0:00:05.341 ******** 2025-10-10 06:11:11.636864 | controller | changed: [localhost] 2025-10-10 06:11:12.434312 | controller | 2025-10-10 06:11:12.434438 | controller | TASK [repo_setup : Install repo-setup package chdir={{ cifmw_repo_setup_basedir }}/tmp/repo-setup, creates={{ cifmw_repo_setup_venv }}/bin/repo-setup, _raw_params={{ cifmw_repo_setup_venv }}/bin/python setup.py install] *** 2025-10-10 06:11:12.434466 | controller | Friday 10 October 2025 06:11:11 +0000 (0:00:08.887) 0:00:14.229 ******** 2025-10-10 06:11:12.434498 | controller | changed: [localhost] 2025-10-10 06:11:12.466549 | controller | 2025-10-10 06:11:12.466629 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider cifmw_repo_setup_dlrn_hash_tag={{ content_provider_dlrn_md5_hash }}] *** 2025-10-10 06:11:12.466650 | controller | Friday 10 October 2025 06:11:12 +0000 (0:00:00.796) 0:00:15.026 ******** 2025-10-10 06:11:12.466669 | controller | skipping: [localhost] 2025-10-10 06:11:13.180990 | controller | 2025-10-10 06:11:13.181043 | controller | TASK [repo_setup : Run repo-setup _raw_params={{ cifmw_repo_setup_venv }}/bin/repo-setup {{ cifmw_repo_setup_promotion }} {{ cifmw_repo_setup_additional_repos }} -d {{ cifmw_repo_setup_os_release }}{{ cifmw_repo_setup_dist_major_version }} -b {{ cifmw_repo_setup_branch }} --rdo-mirror {{ cifmw_repo_setup_rdo_mirror }} {% if cifmw_repo_setup_dlrn_hash_tag | length > 0 %} --dlrn-hash-tag {{ cifmw_repo_setup_dlrn_hash_tag }} {% endif %} -o {{ cifmw_repo_setup_output }}] *** 2025-10-10 06:11:13.181053 | controller | Friday 10 October 2025 06:11:12 +0000 (0:00:00.033) 0:00:15.059 ******** 2025-10-10 06:11:13.181072 | controller | changed: [localhost] 2025-10-10 06:11:13.217323 | controller | 2025-10-10 06:11:13.217405 | controller | TASK [repo_setup : Get component repo url={{ cifmw_repo_setup_dlrn_uri }}/{{ cifmw_repo_setup_os_release }}{{ cifmw_repo_setup_dist_major_version }}-{{ cifmw_repo_setup_branch }}/component/{{ cifmw_repo_setup_component_name }}/{{ cifmw_repo_setup_component_promotion_tag }}/delorean.repo, dest={{ cifmw_repo_setup_output }}/{{ cifmw_repo_setup_component_name }}_{{ cifmw_repo_setup_component_promotion_tag }}_delorean.repo, mode=0644] *** 2025-10-10 06:11:13.217415 | controller | Friday 10 October 2025 06:11:13 +0000 (0:00:00.714) 0:00:15.773 ******** 2025-10-10 06:11:13.217429 | controller | skipping: [localhost] 2025-10-10 06:11:13.249395 | controller | 2025-10-10 06:11:13.249450 | controller | TASK [repo_setup : Rename component repo path={{ cifmw_repo_setup_output }}/{{ cifmw_repo_setup_component_name }}_{{ cifmw_repo_setup_component_promotion_tag }}_delorean.repo, regexp=delorean-component-{{ cifmw_repo_setup_component_name }}, replace={{ cifmw_repo_setup_component_name }}-{{ cifmw_repo_setup_component_promotion_tag }}] *** 2025-10-10 06:11:13.249460 | controller | Friday 10 October 2025 06:11:13 +0000 (0:00:00.036) 0:00:15.810 ******** 2025-10-10 06:11:13.249473 | controller | skipping: [localhost] 2025-10-10 06:11:13.283597 | controller | 2025-10-10 06:11:13.283642 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo path={{ cifmw_repo_setup_output }}/delorean.repo, section=delorean-component-{{ cifmw_repo_setup_component_name }}, option=enabled, value=0, mode=0644] *** 2025-10-10 06:11:13.283651 | controller | Friday 10 October 2025 06:11:13 +0000 (0:00:00.032) 0:00:15.842 ******** 2025-10-10 06:11:13.283672 | controller | skipping: [localhost] 2025-10-10 06:11:13.810855 | controller | 2025-10-10 06:11:13.810901 | controller | TASK [repo_setup : Run repo-setup-get-hash _raw_params={{ cifmw_repo_setup_venv }}/bin/repo-setup-get-hash --dlrn-url {{ cifmw_repo_setup_dlrn_uri[:-1] }} --os-version {{ cifmw_repo_setup_os_release }}{{ cifmw_repo_setup_dist_major_version }} --release {{ cifmw_repo_setup_branch }} {% if cifmw_repo_setup_component_name | length > 0 -%} --component {{ cifmw_repo_setup_component_name }} --tag {{ cifmw_repo_setup_component_promotion_tag }} {% else -%} --tag {{cifmw_repo_setup_promotion }} {% endif -%} {% if (cifmw_repo_setup_dlrn_hash_tag | length > 0) and (cifmw_repo_setup_component_name | length <= 0) -%} --dlrn-hash-tag {{ cifmw_repo_setup_dlrn_hash_tag }} {% endif -%} --json] *** 2025-10-10 06:11:13.810910 | controller | Friday 10 October 2025 06:11:13 +0000 (0:00:00.034) 0:00:15.876 ******** 2025-10-10 06:11:13.810924 | controller | changed: [localhost] 2025-10-10 06:11:14.551737 | controller | 2025-10-10 06:11:14.551843 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file content={{ _repo_setup_json['full_hash'] }} 2025-10-10 06:11:14.551855 | controller | , dest={{ cifmw_repo_setup_basedir }}/artifacts/repositories/delorean.repo.md5, mode=0644] *** 2025-10-10 06:11:14.551865 | controller | Friday 10 October 2025 06:11:13 +0000 (0:00:00.527) 0:00:16.403 ******** 2025-10-10 06:11:14.551889 | controller | changed: [localhost] 2025-10-10 06:11:14.577053 | controller | 2025-10-10 06:11:14.577174 | controller | TASK [repo_setup : Dump current-podified hash url={{ cifmw_repo_setup_dlrn_uri }}/{{ cifmw_repo_setup_os_release }}{{ cifmw_repo_setup_dist_major_version }}-{{ cifmw_repo_setup_branch }}/current-podified/delorean.repo.md5, dest={{ cifmw_repo_setup_basedir }}/artifacts/repositories/delorean.repo.md5, mode=0644] *** 2025-10-10 06:11:14.577191 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.738) 0:00:17.142 ******** 2025-10-10 06:11:14.577223 | controller | skipping: [localhost] 2025-10-10 06:11:14.605628 | controller | 2025-10-10 06:11:14.605764 | controller | TASK [repo_setup : Slurp current podified hash src={{ cifmw_repo_setup_basedir }}/artifacts/repositories/delorean.repo.md5] *** 2025-10-10 06:11:14.605775 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.027) 0:00:17.169 ******** 2025-10-10 06:11:14.605800 | controller | skipping: [localhost] 2025-10-10 06:11:14.634234 | controller | 2025-10-10 06:11:14.634348 | controller | TASK [repo_setup : Update the value of full_hash _repo_setup_json={{ _repo_setup_json | combine({'full_hash': _hash}, recursive=true) }}] *** 2025-10-10 06:11:14.634359 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.028) 0:00:17.198 ******** 2025-10-10 06:11:14.634387 | controller | skipping: [localhost] 2025-10-10 06:11:14.692554 | controller | 2025-10-10 06:11:14.692779 | controller | TASK [repo_setup : Export hashes facts for further use cifmw_repo_setup_full_hash={{ _repo_setup_json['full_hash'] }}, cifmw_repo_setup_commit_hash={{ _repo_setup_json['commit_hash'] }}, cifmw_repo_setup_distro_hash={{ _repo_setup_json['distro_hash'] }}, cifmw_repo_setup_extended_hash={{ _repo_setup_json['extended_hash'] }}, cifmw_repo_setup_dlrn_api_url={{ _repo_setup_json['dlrn_api_url'] }}, cifmw_repo_setup_dlrn_url={{ _repo_setup_json['dlrn_url'] }}, cifmw_repo_setup_release={{ _repo_setup_json['release'] }}, cacheable=True] *** 2025-10-10 06:11:14.692806 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.028) 0:00:17.226 ******** 2025-10-10 06:11:14.692841 | controller | ok: [localhost] 2025-10-10 06:11:14.725675 | controller | 2025-10-10 06:11:14.725820 | controller | TASK [repo_setup : Create download directory path={{ cifmw_repo_setup_rhos_release_path }}, state=directory, mode=0755] *** 2025-10-10 06:11:14.725828 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.058) 0:00:17.285 ******** 2025-10-10 06:11:14.725853 | controller | skipping: [localhost] 2025-10-10 06:11:14.752300 | controller | 2025-10-10 06:11:14.752412 | controller | TASK [repo_setup : Print the URL to request msg={{ cifmw_repo_setup_rhos_release_rpm }}] *** 2025-10-10 06:11:14.752421 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.032) 0:00:17.317 ******** 2025-10-10 06:11:14.752446 | controller | skipping: [localhost] 2025-10-10 06:11:14.779819 | controller | 2025-10-10 06:11:14.779957 | controller | TASK [Download the RPM name=krb_request] *************************************** 2025-10-10 06:11:14.779965 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.027) 0:00:17.344 ******** 2025-10-10 06:11:14.779990 | controller | skipping: [localhost] 2025-10-10 06:11:14.802490 | controller | 2025-10-10 06:11:14.802597 | controller | TASK [repo_setup : Install RHOS Release tool name={{ 2025-10-10 06:11:14.802605 | controller | cifmw_repo_setup_rhos_release_rpm 2025-10-10 06:11:14.802637 | controller | if cifmw_repo_setup_rhos_release_rpm is not url 2025-10-10 06:11:14.802642 | controller | else cifmw_krb_request_out.path 2025-10-10 06:11:14.802649 | controller | }}, state=present, disable_gpg_check={{ cifmw_repo_setup_rhos_release_gpg_check | bool }}] *** 2025-10-10 06:11:14.802655 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.027) 0:00:17.372 ******** 2025-10-10 06:11:14.802678 | controller | skipping: [localhost] 2025-10-10 06:11:14.827049 | controller | 2025-10-10 06:11:14.827174 | controller | TASK [repo_setup : Get rhos-release tool version _raw_params=rhos-release --version] *** 2025-10-10 06:11:14.827189 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.022) 0:00:17.395 ******** 2025-10-10 06:11:14.827216 | controller | skipping: [localhost] 2025-10-10 06:11:14.855874 | controller | 2025-10-10 06:11:14.855969 | controller | TASK [repo_setup : Print rhos-release tool version msg={{ rr_version.stdout }}] *** 2025-10-10 06:11:14.855977 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.024) 0:00:17.419 ******** 2025-10-10 06:11:14.855998 | controller | skipping: [localhost] 2025-10-10 06:11:14.888082 | controller | 2025-10-10 06:11:14.888189 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }} _raw_params=rhos-release {{ cifmw_repo_setup_rhos_release_args }} \ 2025-10-10 06:11:14.888198 | controller | -t {{ cifmw_repo_setup_output }}] *** 2025-10-10 06:11:14.888205 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.028) 0:00:17.448 ******** 2025-10-10 06:11:14.888240 | controller | skipping: [localhost] 2025-10-10 06:11:15.149071 | controller | 2025-10-10 06:11:15.149180 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh path=/etc/ci/mirror_info.sh] *** 2025-10-10 06:11:15.149198 | controller | Friday 10 October 2025 06:11:14 +0000 (0:00:00.032) 0:00:17.480 ******** 2025-10-10 06:11:15.149227 | controller | ok: [localhost] 2025-10-10 06:11:15.388625 | controller | 2025-10-10 06:11:15.388667 | controller | TASK [repo_setup : Use RDO proxy mirrors chdir={{ cifmw_repo_setup_output }}, _raw_params=set -o pipefail 2025-10-10 06:11:15.388675 | controller | source /etc/ci/mirror_info.sh 2025-10-10 06:11:15.388710 | controller | sed -i -e "s|https://trunk.rdoproject.org|$NODEPOOL_RDO_PROXY|g" *.repo 2025-10-10 06:11:15.388718 | controller | ] *** 2025-10-10 06:11:15.388725 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.260) 0:00:17.741 ******** 2025-10-10 06:11:15.388737 | controller | changed: [localhost] 2025-10-10 06:11:15.629794 | controller | 2025-10-10 06:11:15.629841 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) chdir={{ cifmw_repo_setup_output }}, _raw_params=set -o pipefail 2025-10-10 06:11:15.629849 | controller | source /etc/ci/mirror_info.sh 2025-10-10 06:11:15.629856 | controller | sed -i -e "s|http://mirror.stream.centos.org|$NODEPOOL_CENTOS_MIRROR|g" *.repo 2025-10-10 06:11:15.629863 | controller | ] *** 2025-10-10 06:11:15.629869 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.240) 0:00:17.981 ******** 2025-10-10 06:11:15.629880 | controller | changed: [localhost] 2025-10-10 06:11:15.668997 | controller | 2025-10-10 06:11:15.669065 | controller | TASK [repo_setup : Check for gating.repo file on content provider url=http://{{ content_provider_registry_ip }}:8766/gating.repo] *** 2025-10-10 06:11:15.669073 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.241) 0:00:18.222 ******** 2025-10-10 06:11:15.669087 | controller | skipping: [localhost] 2025-10-10 06:11:15.712179 | controller | 2025-10-10 06:11:15.712284 | controller | TASK [repo_setup : Populate gating repo from content provider ip content=[gating-repo] 2025-10-10 06:11:15.712296 | controller | baseurl=http://{{ content_provider_registry_ip }}:8766/ 2025-10-10 06:11:15.712304 | controller | enabled=1 2025-10-10 06:11:15.712313 | controller | gpgcheck=0 2025-10-10 06:11:15.712321 | controller | priority=1 2025-10-10 06:11:15.712330 | controller | , dest={{ cifmw_repo_setup_output }}/gating.repo, mode=0644] *** 2025-10-10 06:11:15.712357 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.038) 0:00:18.261 ******** 2025-10-10 06:11:15.712379 | controller | skipping: [localhost] 2025-10-10 06:11:15.761978 | controller | 2025-10-10 06:11:15.762049 | controller | TASK [repo_setup : Check for DLRN repo at the destination path={{ cifmw_repo_setup_output }}/delorean.repo] *** 2025-10-10 06:11:15.762067 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.043) 0:00:18.304 ******** 2025-10-10 06:11:15.762093 | controller | skipping: [localhost] 2025-10-10 06:11:15.796900 | controller | 2025-10-10 06:11:15.796954 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo path={{ cifmw_repo_setup_output }}/delorean.repo, regexp=priority=1, replace=priority=20] *** 2025-10-10 06:11:15.796968 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.049) 0:00:18.354 ******** 2025-10-10 06:11:15.796985 | controller | skipping: [localhost] 2025-10-10 06:11:15.835537 | controller | 2025-10-10 06:11:15.835585 | controller | TASK [repo_setup : Check for DLRN component repo path={{ cifmw_repo_setup_output }}/{{ _comp_repo }}] *** 2025-10-10 06:11:15.835605 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.034) 0:00:18.389 ******** 2025-10-10 06:11:15.835621 | controller | skipping: [localhost] 2025-10-10 06:11:15.884848 | controller | 2025-10-10 06:11:15.884919 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo path={{ cifmw_repo_setup_output }}//{{ _comp_repo }}, regexp=priority=1, replace=priority=2] *** 2025-10-10 06:11:15.884937 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.037) 0:00:18.427 ******** 2025-10-10 06:11:15.884962 | controller | skipping: [localhost] 2025-10-10 06:11:15.921652 | controller | 2025-10-10 06:11:15.921726 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory paths=/etc/yum.repos.d/, patterns=*.repo, recurse=False] *** 2025-10-10 06:11:15.921737 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.049) 0:00:18.476 ******** 2025-10-10 06:11:15.921752 | controller | skipping: [localhost] 2025-10-10 06:11:15.947171 | controller | 2025-10-10 06:11:15.947225 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory path={{ item }}, state=absent] *** 2025-10-10 06:11:15.947235 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.037) 0:00:18.514 ******** 2025-10-10 06:11:15.947250 | controller | skipping: [localhost] 2025-10-10 06:11:15.972738 | controller | 2025-10-10 06:11:15.972791 | controller | TASK [repo_setup : Cleanup existing metadata _raw_params=dnf clean metadata] *** 2025-10-10 06:11:15.972800 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.025) 0:00:18.540 ******** 2025-10-10 06:11:15.972814 | controller | skipping: [localhost] 2025-10-10 06:11:15.999480 | controller | 2025-10-10 06:11:15.999533 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory mode=0755, remote_src=True, src={{ cifmw_repo_setup_output }}/, dest=/etc/yum.repos.d] *** 2025-10-10 06:11:15.999544 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.025) 0:00:18.565 ******** 2025-10-10 06:11:15.999559 | controller | skipping: [localhost] 2025-10-10 06:11:16.055474 | controller | 2025-10-10 06:11:16.055539 | controller | TASK [ci_setup : Gather variables for each operating system _raw_params={{ item }}] *** 2025-10-10 06:11:16.055547 | controller | Friday 10 October 2025 06:11:15 +0000 (0:00:00.026) 0:00:18.592 ******** 2025-10-10 06:11:16.055563 | controller | ok: [localhost] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml) 2025-10-10 06:11:16.083806 | controller | 2025-10-10 06:11:16.083866 | controller | TASK [ci_setup : List packages to install var=cifmw_ci_setup_packages] ********* 2025-10-10 06:11:16.083877 | controller | Friday 10 October 2025 06:11:16 +0000 (0:00:00.055) 0:00:18.648 ******** 2025-10-10 06:11:16.083894 | controller | ok: [localhost] => 2025-10-10 06:11:59.958789 | controller | cifmw_ci_setup_packages: 2025-10-10 06:11:59.958858 | controller | - bash-completion 2025-10-10 06:11:59.958868 | controller | - ca-certificates 2025-10-10 06:11:59.958877 | controller | - git-core 2025-10-10 06:11:59.958885 | controller | - make 2025-10-10 06:11:59.958893 | controller | - tar 2025-10-10 06:11:59.958901 | controller | - tmux 2025-10-10 06:11:59.958909 | controller | - python3-pip 2025-10-10 06:11:59.958927 | controller | 2025-10-10 06:11:59.958936 | controller | TASK [ci_setup : Install needed packages name={{ cifmw_ci_setup_packages }}, state=latest] *** 2025-10-10 06:11:59.958945 | controller | Friday 10 October 2025 06:11:16 +0000 (0:00:00.028) 0:00:18.676 ******** 2025-10-10 06:11:59.958966 | controller | changed: [localhost] 2025-10-10 06:12:00.161094 | controller | 2025-10-10 06:12:00.161182 | controller | TASK [ci_setup : Gather version of openshift client _raw_params=oc version --client -o yaml] *** 2025-10-10 06:12:00.161191 | controller | Friday 10 October 2025 06:11:59 +0000 (0:00:43.874) 0:01:02.551 ******** 2025-10-10 06:12:00.161209 | controller | ok: [localhost] 2025-10-10 06:12:00.386717 | controller | 2025-10-10 06:12:00.386837 | controller | TASK [ci_setup : Ensure openshift client install path is present path={{ cifmw_ci_setup_oc_install_path }}, state=directory, mode=0755] *** 2025-10-10 06:12:00.386855 | controller | Friday 10 October 2025 06:12:00 +0000 (0:00:00.202) 0:01:02.753 ******** 2025-10-10 06:12:00.386888 | controller | changed: [localhost] 2025-10-10 06:12:05.602438 | controller | 2025-10-10 06:12:05.602527 | controller | TASK [ci_setup : Install openshift client src={{ cifmw_ci_setup_openshift_client_download_uri }}/{{ cifmw_ci_setup_openshift_client_version }}/openshift-client-linux.tar.gz, dest={{ cifmw_ci_setup_oc_install_path }}, remote_src=True, mode=0755, creates={{ cifmw_ci_setup_oc_install_path }}/oc] *** 2025-10-10 06:12:05.602542 | controller | Friday 10 October 2025 06:12:00 +0000 (0:00:00.224) 0:01:02.978 ******** 2025-10-10 06:12:05.602562 | controller | changed: [localhost] 2025-10-10 06:12:05.636761 | controller | 2025-10-10 06:12:05.636849 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed cifmw_path={{ cifmw_ci_setup_oc_install_path }}:{{ ansible_env.PATH }}, cacheable=True] *** 2025-10-10 06:12:05.636860 | controller | Friday 10 October 2025 06:12:05 +0000 (0:00:05.216) 0:01:08.194 ******** 2025-10-10 06:12:05.636882 | controller | skipping: [localhost] 2025-10-10 06:12:06.002875 | controller | 2025-10-10 06:12:06.002976 | controller | TASK [ci_setup : Create completion file] *************************************** 2025-10-10 06:12:06.002985 | controller | Friday 10 October 2025 06:12:05 +0000 (0:00:00.034) 0:01:08.229 ******** 2025-10-10 06:12:06.003010 | controller | changed: [localhost] 2025-10-10 06:12:06.339418 | controller | 2025-10-10 06:12:06.339504 | controller | TASK [ci_setup : Source completion from within .bashrc create=True, mode=0644, path={{ ansible_user_dir }}/.bashrc, block=if [ -f ~/.oc_completion ]; then 2025-10-10 06:12:06.339513 | controller | source ~/.oc_completion 2025-10-10 06:12:06.339520 | controller | fi] *** 2025-10-10 06:12:06.339526 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.366) 0:01:08.595 ******** 2025-10-10 06:12:06.339562 | controller | changed: [localhost] 2025-10-10 06:12:06.363207 | controller | 2025-10-10 06:12:06.363275 | controller | TASK [ci_setup : Check rhsm status _raw_params=subscription-manager status] **** 2025-10-10 06:12:06.363283 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.336) 0:01:08.932 ******** 2025-10-10 06:12:06.363303 | controller | skipping: [localhost] 2025-10-10 06:12:06.390676 | controller | 2025-10-10 06:12:06.390793 | controller | TASK [ci_setup : Gather the repos to be enabled _repos={{ 2025-10-10 06:12:06.390810 | controller | cifmw_ci_setup_rhel_rhsm_default_repos + 2025-10-10 06:12:06.390824 | controller | (cifmw_ci_setup_rhel_rhsm_extra_repos | default([])) 2025-10-10 06:12:06.390837 | controller | }}] *** 2025-10-10 06:12:06.390851 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.023) 0:01:08.956 ******** 2025-10-10 06:12:06.390880 | controller | skipping: [localhost] 2025-10-10 06:12:06.424054 | controller | 2025-10-10 06:12:06.424126 | controller | TASK [ci_setup : Enabling the required repositories. name={{ item }}, state={{ rhsm_repo_state | default('enabled') }}] *** 2025-10-10 06:12:06.424138 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.027) 0:01:08.983 ******** 2025-10-10 06:12:06.424160 | controller | skipping: [localhost] 2025-10-10 06:12:06.455985 | controller | 2025-10-10 06:12:06.456062 | controller | TASK [ci_setup : Get current /etc/redhat-release _raw_params=cat /etc/redhat-release] *** 2025-10-10 06:12:06.456070 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.033) 0:01:09.016 ******** 2025-10-10 06:12:06.456088 | controller | skipping: [localhost] 2025-10-10 06:12:06.480492 | controller | 2025-10-10 06:12:06.480575 | controller | TASK [ci_setup : Print current /etc/redhat-release msg={{ _current_rh_release.stdout }}] *** 2025-10-10 06:12:06.480592 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.031) 0:01:09.048 ******** 2025-10-10 06:12:06.480618 | controller | skipping: [localhost] 2025-10-10 06:12:06.512247 | controller | 2025-10-10 06:12:06.512340 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum name={{ item.name }}, baseurl={{ item.baseurl }}, description={{ item.description | default(item.name) }}, gpgcheck={{ item.gpgcheck | default(false) }}, enabled=True, state={{ yum_repo_state | default('present') }}] *** 2025-10-10 06:12:06.512359 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.024) 0:01:09.073 ******** 2025-10-10 06:12:06.512387 | controller | skipping: [localhost] 2025-10-10 06:12:07.700553 | controller | 2025-10-10 06:12:07.700674 | controller | TASK [ci_setup : Manage directories path={{ item }}, state={{ directory_state }}, mode=0755, owner={{ ansible_user_id }}, group={{ ansible_user_id }}] *** 2025-10-10 06:12:07.700741 | controller | Friday 10 October 2025 06:12:06 +0000 (0:00:00.031) 0:01:09.104 ******** 2025-10-10 06:12:07.700779 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr) 2025-10-10 06:12:08.172490 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/logs) 2025-10-10 06:12:08.172597 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/tmp) 2025-10-10 06:12:08.172609 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/volumes) 2025-10-10 06:12:08.172617 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/parameters) 2025-10-10 06:12:08.172625 | controller | 2025-10-10 06:12:08.172634 | controller | TASK [cifmw_setup : Create artifacts with custom params mode=0644, dest={{ cifmw_basedir|default(ansible_user_dir ~ '/ci-framework-data') }}/artifacts/parameters/custom-params.yml, content={{ ci_framework_params | to_nice_yaml }}] *** 2025-10-10 06:12:08.172644 | controller | Friday 10 October 2025 06:12:07 +0000 (0:00:01.187) 0:01:10.292 ******** 2025-10-10 06:12:08.172672 | controller | changed: [localhost] 2025-10-10 06:12:09.012160 | controller | 2025-10-10 06:12:09.012263 | controller | PLAY [Run ci/playbooks/edpm_build_images/edpm_image_builder.yml] *************** 2025-10-10 06:12:09.012271 | controller | 2025-10-10 06:12:09.012278 | controller | TASK [Gathering Facts ] ******************************************************** 2025-10-10 06:12:09.012284 | controller | Friday 10 October 2025 06:12:08 +0000 (0:00:00.472) 0:01:10.765 ******** 2025-10-10 06:12:09.012308 | controller | ok: [controller] 2025-10-10 06:12:09.311540 | controller | 2025-10-10 06:12:09.311755 | controller | TASK [Read hash from delorean.repo.md5 file path={{ cifmw_basedir }}/artifacts/repositories/delorean.repo.md5] *** 2025-10-10 06:12:09.311770 | controller | Friday 10 October 2025 06:12:09 +0000 (0:00:00.839) 0:01:11.604 ******** 2025-10-10 06:12:09.311798 | controller | ok: [controller] 2025-10-10 06:12:09.341511 | controller | 2025-10-10 06:12:09.341632 | controller | TASK [Set fact for cifmw_edpm_build_images_tag var cifmw_edpm_build_images_tag={{ file_content['content'] | b64decode | string | trim }}] *** 2025-10-10 06:12:09.341656 | controller | Friday 10 October 2025 06:12:09 +0000 (0:00:00.299) 0:01:11.904 ******** 2025-10-10 06:12:09.341719 | controller | ok: [controller] 2025-10-10 06:12:09.372629 | controller | 2025-10-10 06:12:09.372776 | controller | TASK [edpm_build_images : Add edpm-image-builder to the list of packages to be installed on host cifmw_edpm_build_images_host_packages={{ cifmw_edpm_build_images_host_packages + ['edpm-image-builder'] }}] *** 2025-10-10 06:12:09.372790 | controller | Friday 10 October 2025 06:12:09 +0000 (0:00:00.030) 0:01:11.934 ******** 2025-10-10 06:12:09.372819 | controller | ok: [controller] 2025-10-10 06:13:15.969444 | controller | 2025-10-10 06:13:15.969491 | controller | TASK [edpm_build_images : Install required packages name={{ cifmw_edpm_build_images_host_packages }}, state=latest] *** 2025-10-10 06:13:15.969500 | controller | Friday 10 October 2025 06:12:09 +0000 (0:00:00.031) 0:01:11.965 ******** 2025-10-10 06:13:15.969512 | controller | changed: [controller] 2025-10-10 06:13:16.177839 | controller | 2025-10-10 06:13:16.177874 | controller | TASK [edpm_build_images : Ensure logs/edpm_images directory path={{ cifmw_edpm_build_images_basedir }}/logs/edpm_images, state=directory, mode=0755] *** 2025-10-10 06:13:16.177890 | controller | Friday 10 October 2025 06:13:15 +0000 (0:01:06.596) 0:02:18.561 ******** 2025-10-10 06:13:16.177902 | controller | changed: [controller] 2025-10-10 06:13:17.080561 | controller | 2025-10-10 06:13:17.080602 | controller | TASK [discover_latest_image : Get latest image url={{ cifmw_discover_latest_image_base_url }}, image_prefix={{ cifmw_discover_latest_image_qcow_prefix }}, images_file={{ cifmw_discover_latest_image_images_file }}] *** 2025-10-10 06:13:17.080611 | controller | Friday 10 October 2025 06:13:16 +0000 (0:00:00.209) 0:02:18.770 ******** 2025-10-10 06:13:17.080623 | controller | changed: [controller] 2025-10-10 06:13:17.123346 | controller | 2025-10-10 06:13:17.123385 | controller | TASK [discover_latest_image : Export facts accordingly cifmw_discovered_image_name={{ discovered_image['data']['image_name'] }}, cifmw_discovered_image_url={{ discovered_image['data']['image_url'] }}, cifmw_discovered_hash={{ discovered_image['data']['hash'] }}, cifmw_discovered_hash_algorithm={{ discovered_image['data']['hash_algorithm'] }}, cacheable=True] *** 2025-10-10 06:13:17.123393 | controller | Friday 10 October 2025 06:13:17 +0000 (0:00:00.898) 0:02:19.669 ******** 2025-10-10 06:13:17.123405 | controller | ok: [controller] 2025-10-10 06:13:29.244408 | controller | 2025-10-10 06:13:29.244493 | controller | TASK [edpm_build_images : Download TripleO source image url={{ cifmw_discovered_image_url }}, dest={{ cifmw_edpm_build_images_basedir }}, timeout=20, mode=0644] *** 2025-10-10 06:13:29.244501 | controller | Friday 10 October 2025 06:13:17 +0000 (0:00:00.046) 0:02:19.716 ******** 2025-10-10 06:13:29.244519 | controller | changed: [controller] 2025-10-10 06:13:29.267424 | controller | 2025-10-10 06:13:29.267487 | controller | TASK [edpm_build_images : Check if cert exits path={{ cifmw_edpm_build_images_cert_path }}] *** 2025-10-10 06:13:29.267495 | controller | Friday 10 October 2025 06:13:29 +0000 (0:00:12.120) 0:02:31.836 ******** 2025-10-10 06:13:29.267510 | controller | skipping: [controller] 2025-10-10 06:13:29.290609 | controller | 2025-10-10 06:13:29.290666 | controller | TASK [edpm_build_images : Read the certificates path={{ cifmw_edpm_build_images_cert_path }}, ou_filter={{ cifmw_edpm_build_images_cert_filter_ou | default(omit) }}, cn_filter={{ cifmw_edpm_build_images_cert_filter_cn | default(omit) }}] *** 2025-10-10 06:13:29.290677 | controller | Friday 10 October 2025 06:13:29 +0000 (0:00:00.023) 0:02:31.860 ******** 2025-10-10 06:13:29.290713 | controller | skipping: [controller] 2025-10-10 06:13:29.317210 | controller | 2025-10-10 06:13:29.317276 | controller | TASK [edpm_build_images : Dump the certificates dest={{ _cifmw_edpm_build_images_cert_source }}, content={{ _cifmw_edpm_build_images_certs.certs | join(' 2025-10-10 06:13:29.317284 | controller | ') }}, mode=0644] *** 2025-10-10 06:13:29.317291 | controller | Friday 10 October 2025 06:13:29 +0000 (0:00:00.023) 0:02:31.883 ******** 2025-10-10 06:13:29.317308 | controller | skipping: [controller] 2025-10-10 06:13:29.343186 | controller | 2025-10-10 06:13:29.343261 | controller | TASK [edpm_build_images : Install libguestfs packages name=['libguestfs', 'libguestfs-tools', 'libguestfs-tools-c'], state=present] *** 2025-10-10 06:13:29.343270 | controller | Friday 10 October 2025 06:13:29 +0000 (0:00:00.026) 0:02:31.910 ******** 2025-10-10 06:13:29.343288 | controller | skipping: [controller] 2025-10-10 06:13:29.367888 | controller | 2025-10-10 06:13:29.367930 | controller | TASK [edpm_build_images : Add cert if it exists _raw_params=virt-customize -a {{ cifmw_edpm_build_images_basedir }}/{{ cifmw_discovered_image_name }} --upload {{ _cifmw_edpm_build_images_cert_source }}:{{ cifmw_edpm_build_images_cert_dest }} --run-command 'update-ca-trust' 2025-10-10 06:13:29.367938 | controller | ] *** 2025-10-10 06:13:29.367945 | controller | Friday 10 October 2025 06:13:29 +0000 (0:00:00.026) 0:02:31.936 ******** 2025-10-10 06:13:29.367957 | controller | skipping: [controller] 2025-10-10 06:21:39.440980 | controller | 2025-10-10 06:21:39.442726 | controller | TASK [edpm_build_images : Build EDPM hardened uefi image chdir={{ cifmw_edpm_image_builder_repo_path }}, _raw_params=diskimage-builder {% if ansible_distribution | lower == 'centos' %} images/edpm-hardened-uefi-{{ ansible_distribution | lower }}-{{ ansible_distribution_major_version }}-stream.yaml {% else %} images/edpm-hardened-uefi-rhel-{{ ansible_distribution_major_version }}.yaml {% endif %} > {{ cifmw_edpm_build_images_basedir }}/logs/edpm_images/edpm_hardened_uefi_image_build.log 2> {{ cifmw_edpm_build_images_basedir }}/logs/edpm_images/edpm_hardened_uefi_image_build_err.log] *** 2025-10-10 06:21:39.442764 | controller | Friday 10 October 2025 06:13:29 +0000 (0:00:00.023) 0:02:31.959 ******** 2025-10-10 06:21:39.442784 | controller | changed: [controller] 2025-10-10 06:24:41.169256 | controller | 2025-10-10 06:24:41.169306 | controller | TASK [edpm_build_images : Build ironic-python-agent image chdir={{ cifmw_edpm_image_builder_repo_path }}, _raw_params=diskimage-builder {% if ansible_distribution | lower == 'centos' %} images/ironic-python-agent-{{ ansible_distribution | lower }}-{{ ansible_distribution_major_version }}-stream.yaml {% else %} images/ironic-python-agent-rhel-{{ ansible_distribution_major_version }}.yaml {% endif %} > {{ cifmw_edpm_build_images_basedir }}/logs/edpm_images/ironic_python_agent_image_build.log 2> {{ cifmw_edpm_build_images_basedir }}/logs/edpm_images/ironic_python_agent_image_build_err.log] *** 2025-10-10 06:24:41.169316 | controller | Friday 10 October 2025 06:21:39 +0000 (0:08:10.073) 0:10:42.033 ******** 2025-10-10 06:24:41.169331 | controller | changed: [controller] 2025-10-10 06:24:58.912137 | controller | 2025-10-10 06:24:58.912504 | controller | TASK [edpm_build_images : Package edpm-hardened-uefi image inside container image chdir={{ cifmw_edpm_image_builder_repo_path }}, _raw_params=buildah bud -f ./Containerfile.image -t edpm-hardened-uefi:{{ cifmw_edpm_build_images_tag }} --build-arg BASE_IMAGE={{ cifmw_edpm_build_images_base_image }} --logfile {{ cifmw_edpm_build_images_basedir }}/logs/edpm_images/edpm_hardened_uefi_container_package.log] *** 2025-10-10 06:24:58.912518 | controller | Friday 10 October 2025 06:24:41 +0000 (0:03:01.728) 0:13:43.762 ******** 2025-10-10 06:24:58.912537 | controller | changed: [controller] 2025-10-10 06:25:14.825734 | controller | 2025-10-10 06:25:14.825808 | controller | TASK [edpm_build_images : Package ironic-python-agent image inside container image chdir={{ cifmw_edpm_image_builder_repo_path }}, _raw_params=buildah bud -f ./Containerfile.ramdisk -t ironic-python-agent:{{ cifmw_edpm_build_images_tag }} --build-arg BASE_IMAGE={{ cifmw_edpm_build_images_base_image }} --logfile {{ cifmw_edpm_build_images_basedir }}/logs/edpm_images/ironic_python_agent_container_package.log] *** 2025-10-10 06:25:14.825818 | controller | Friday 10 October 2025 06:24:58 +0000 (0:00:17.742) 0:14:01.505 ******** 2025-10-10 06:25:14.825834 | controller | changed: [controller] 2025-10-10 06:25:38.303490 | controller | 2025-10-10 06:25:38.303555 | controller | TASK [edpm_build_images : Push images to registry with tag c4b77291aeca5591ac860bd4127cec2f name={{ item }}, push_args={'dest': '{{ cifmw_edpm_build_images_push_registry }}/{{ cifmw_edpm_build_images_push_registry_namespace }}'}, tag={{ cifmw_edpm_build_images_tag }}, pull=False, push=True] *** 2025-10-10 06:25:38.303564 | controller | Friday 10 October 2025 06:25:14 +0000 (0:00:15.913) 0:14:17.418 ******** 2025-10-10 06:25:38.303577 | controller | changed: [controller] => (item=edpm-hardened-uefi) 2025-10-10 06:25:39.008077 | controller | changed: [controller] => (item=ironic-python-agent) 2025-10-10 06:25:39.008123 | controller | 2025-10-10 06:25:39.008134 | controller | TASK [edpm_build_images : Retag the images with podified-ci-testing tag image={{ item }}:{{ cifmw_edpm_build_images_tag }}, target_names=['{{ item }}:podified-ci-testing']] *** 2025-10-10 06:25:39.008143 | controller | Friday 10 October 2025 06:25:38 +0000 (0:00:23.478) 0:14:40.896 ******** 2025-10-10 06:25:39.008159 | controller | changed: [controller] => (item=edpm-hardened-uefi) 2025-10-10 06:25:41.014889 | controller | changed: [controller] => (item=ironic-python-agent) 2025-10-10 06:25:41.014952 | controller | 2025-10-10 06:25:41.014965 | controller | TASK [edpm_build_images : Push images to registry with podified-ci-testing tag name={{ item }}, push_args={'dest': '{{ cifmw_edpm_build_images_push_registry }}/{{ cifmw_edpm_build_images_push_registry_namespace }}'}, tag=podified-ci-testing, pull=False, push=True] *** 2025-10-10 06:25:41.014976 | controller | Friday 10 October 2025 06:25:39 +0000 (0:00:00.704) 0:14:41.600 ******** 2025-10-10 06:25:41.015011 | controller | changed: [controller] => (item=edpm-hardened-uefi) 2025-10-10 06:25:41.322129 | controller | changed: [controller] => (item=ironic-python-agent) 2025-10-10 06:25:41.322188 | controller | 2025-10-10 06:25:41.322196 | controller | TASK [edpm_build_images : Dump edpm container images in the file chdir={{ cifmw_edpm_image_builder_repo_path }}, _raw_params=buildah images | grep -E '(edpm-hardened-uefi|ironic-python-agent)' | tee -a {{ cifmw_edpm_build_images_basedir }}/logs/containers-built.log] *** 2025-10-10 06:25:41.322203 | controller | Friday 10 October 2025 06:25:41 +0000 (0:00:02.006) 0:14:43.607 ******** 2025-10-10 06:25:41.322217 | controller | changed: [controller] 2025-10-10 06:25:41.396617 | controller | 2025-10-10 06:25:41.396724 | controller | PLAY RECAP ********************************************************************* 2025-10-10 06:25:41.396741 | controller | controller : ok=17 changed=12 unreachable=0 failed=0 skipped=5 rescued=0 ignored=0 2025-10-10 06:25:41.396868 | controller | localhost : ok=27 changed=17 unreachable=0 failed=0 skipped=34 rescued=0 ignored=0 2025-10-10 06:25:41.396885 | controller | 2025-10-10 06:25:41.396892 | controller | Friday 10 October 2025 06:25:41 +0000 (0:00:00.307) 0:14:43.915 ******** 2025-10-10 06:25:41.396899 | controller | =============================================================================== 2025-10-10 06:25:41.396905 | controller | edpm_build_images : Build EDPM hardened uefi image -------------------- 490.07s 2025-10-10 06:25:41.396911 | controller | edpm_build_images : Build ironic-python-agent image ------------------- 181.73s 2025-10-10 06:25:41.396917 | controller | edpm_build_images : Install required packages -------------------------- 66.60s 2025-10-10 06:25:41.396923 | controller | ci_setup : Install needed packages ------------------------------------- 43.87s 2025-10-10 06:25:41.396929 | controller | edpm_build_images : Push images to registry with tag c4b77291aeca5591ac860bd4127cec2f -- 23.48s 2025-10-10 06:25:41.396935 | controller | edpm_build_images : Package edpm-hardened-uefi image inside container image -- 17.74s 2025-10-10 06:25:41.396942 | controller | edpm_build_images : Package ironic-python-agent image inside container image -- 15.91s 2025-10-10 06:25:41.396948 | controller | edpm_build_images : Download TripleO source image ---------------------- 12.12s 2025-10-10 06:25:41.396954 | controller | repo_setup : Initialize python venv and install requirements ------------ 8.89s 2025-10-10 06:25:41.396960 | controller | ci_setup : Install openshift client ------------------------------------- 5.22s 2025-10-10 06:25:41.396967 | controller | edpm_build_images : Push images to registry with podified-ci-testing tag --- 2.01s 2025-10-10 06:25:41.396973 | controller | install_ca : Update ca bundle ------------------------------------------- 1.48s 2025-10-10 06:25:41.396979 | controller | ci_setup : Manage directories ------------------------------------------- 1.19s 2025-10-10 06:25:41.396985 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.03s 2025-10-10 06:25:41.396991 | controller | Gathering Facts --------------------------------------------------------- 1.01s 2025-10-10 06:25:41.396997 | controller | discover_latest_image : Get latest image -------------------------------- 0.90s 2025-10-10 06:25:41.397003 | controller | Gathering Facts --------------------------------------------------------- 0.84s 2025-10-10 06:25:41.397009 | controller | repo_setup : Install repo-setup package --------------------------------- 0.80s 2025-10-10 06:25:41.397015 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.74s 2025-10-10 06:25:41.397021 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.71s 2025-10-10 06:25:41.657796 | controller | changed 2025-10-10 06:25:41.703771 | 2025-10-10 06:25:41.703890 | PLAY RECAP 2025-10-10 06:25:41.703971 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-10 06:25:41.704013 | 2025-10-10 06:25:41.811793 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/edpm_build_images/run.yml@main] 2025-10-10 06:25:41.814164 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-10 06:25:42.465781 | 2025-10-10 06:25:42.465917 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-10 06:25:42.487070 | 2025-10-10 06:25:42.487165 | TASK [Filter out host if needed] 2025-10-10 06:25:42.497587 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-10 06:25:42.502230 | 2025-10-10 06:25:42.502294 | TASK [Ensure file is present] 2025-10-10 06:25:42.936908 | controller | ok 2025-10-10 06:25:42.951522 | 2025-10-10 06:25:42.951708 | TASK [Manage molecule report file] 2025-10-10 06:25:43.502314 | controller | skipping: Conditional result was False 2025-10-10 06:25:43.515224 | 2025-10-10 06:25:43.515373 | TASK [Check if we get ci-framework-data basedir] 2025-10-10 06:25:43.792607 | controller | ok 2025-10-10 06:25:43.806748 | 2025-10-10 06:25:43.806896 | TASK [Create ci-framework-data log directory for zuul] 2025-10-10 06:25:44.236979 | controller | changed 2025-10-10 06:25:44.248929 | 2025-10-10 06:25:44.249102 | TASK [Copy ci-framework interesting files] 2025-10-10 06:25:44.690270 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-10 06:25:44.794496 | controller | changed 2025-10-10 06:25:44.805878 | 2025-10-10 06:25:44.806026 | TASK [Get SELinux listing] 2025-10-10 06:25:45.358073 | controller | changed 2025-10-10 06:25:45.370492 | 2025-10-10 06:25:45.370634 | TASK [Generate log index] 2025-10-10 06:25:46.359639 | controller | changed 2025-10-10 06:25:46.370911 | 2025-10-10 06:25:46.371046 | TASK [Get some env related data] 2025-10-10 06:25:47.401496 | controller | /home/zuul/.local/bin/ansible 2025-10-10 06:25:48.425081 | controller | changed 2025-10-10 06:25:48.436992 | 2025-10-10 06:25:48.437125 | TASK [Generate list of logs to collect in home directory] 2025-10-10 06:25:48.844074 | controller | ok: All paths examined 2025-10-10 06:25:48.894395 | 2025-10-10 06:25:48.894577 | LOOP [Copy logs from home directory] 2025-10-10 06:25:49.396489 | controller | changed: 2025-10-10 06:25:49.396829 | controller | { 2025-10-10 06:25:49.396886 | controller | "atime": 1760076634.8447735, 2025-10-10 06:25:49.396928 | controller | "ctime": 1760077541.3211446, 2025-10-10 06:25:49.396965 | controller | "dev": 64513, 2025-10-10 06:25:49.397002 | controller | "gid": 1000, 2025-10-10 06:25:49.397060 | controller | "gr_name": "zuul", 2025-10-10 06:25:49.397101 | controller | "inode": 4467286, 2025-10-10 06:25:49.397136 | controller | "isblk": false, 2025-10-10 06:25:49.397171 | controller | "ischr": false, 2025-10-10 06:25:49.397204 | controller | "isdir": false, 2025-10-10 06:25:49.397237 | controller | "isfifo": false, 2025-10-10 06:25:49.397271 | controller | "isgid": false, 2025-10-10 06:25:49.397303 | controller | "islnk": false, 2025-10-10 06:25:49.397335 | controller | "isreg": true, 2025-10-10 06:25:49.397366 | controller | "issock": false, 2025-10-10 06:25:49.397397 | controller | "isuid": false, 2025-10-10 06:25:49.397428 | controller | "mode": "0644", 2025-10-10 06:25:49.397460 | controller | "mtime": 1760077541.3211446, 2025-10-10 06:25:49.397492 | controller | "nlink": 1, 2025-10-10 06:25:49.397526 | controller | "path": "/home/zuul/ansible.log", 2025-10-10 06:25:49.397565 | controller | "pw_name": "zuul", 2025-10-10 06:25:49.397600 | controller | "rgrp": true, 2025-10-10 06:25:49.397635 | controller | "roth": true, 2025-10-10 06:25:49.397696 | controller | "rusr": true, 2025-10-10 06:25:49.397742 | controller | "size": 49765, 2025-10-10 06:25:49.397776 | controller | "uid": 1000, 2025-10-10 06:25:49.397809 | controller | "wgrp": false, 2025-10-10 06:25:49.397842 | controller | "woth": false, 2025-10-10 06:25:49.397879 | controller | "wusr": true, 2025-10-10 06:25:49.397915 | controller | "xgrp": false, 2025-10-10 06:25:49.397948 | controller | "xoth": false, 2025-10-10 06:25:49.397980 | controller | "xusr": false 2025-10-10 06:25:49.398012 | controller | } 2025-10-10 06:25:49.413950 | 2025-10-10 06:25:49.414228 | TASK [Copy crio stats log file] 2025-10-10 06:25:49.443510 | controller | skipping: Conditional result was False 2025-10-10 06:25:49.457061 | 2025-10-10 06:25:49.457228 | TASK [Get SELinux related data] 2025-10-10 06:25:49.753189 | controller | 2025-10-10 06:25:50.008481 | controller | ERROR 2025-10-10 06:25:50.008843 | controller | { 2025-10-10 06:25:50.008963 | controller | "delta": "0:00:00.012319", 2025-10-10 06:25:50.009041 | controller | "end": "2025-10-10 06:25:49.754413", 2025-10-10 06:25:50.009084 | controller | "msg": "non-zero return code", 2025-10-10 06:25:50.009120 | controller | "rc": 1, 2025-10-10 06:25:50.009156 | controller | "start": "2025-10-10 06:25:49.742094" 2025-10-10 06:25:50.009189 | controller | } 2025-10-10 06:25:50.009246 | controller | ERROR: Ignoring Errors 2025-10-10 06:25:50.026108 | 2025-10-10 06:25:50.026309 | TASK [Create system configuration directory] 2025-10-10 06:25:50.293207 | controller | changed 2025-10-10 06:25:50.305968 | 2025-10-10 06:25:50.306102 | TASK [Get some of the system configurations] 2025-10-10 06:25:50.867987 | controller | changed 2025-10-10 06:25:50.881317 | 2025-10-10 06:25:50.881477 | TASK [Copy generated documentation if available] 2025-10-10 06:25:50.920026 | controller | skipping: Conditional result was False 2025-10-10 06:25:50.929858 | 2025-10-10 06:25:50.930153 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-10 06:25:50.968707 | controller | skipping: Conditional result was False 2025-10-10 06:25:50.978329 | 2025-10-10 06:25:50.978425 | TASK [Compress logs bigger than 2MB] 2025-10-10 06:25:51.523501 | controller | changed 2025-10-10 06:25:51.531693 | 2025-10-10 06:25:51.531781 | TASK [Copy files from workspace on node] 2025-10-10 06:25:51.556878 | controller | ok 2025-10-10 06:25:51.591578 | 2025-10-10 06:25:51.591710 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-10 06:25:51.627183 | controller | skipping: Conditional result was False 2025-10-10 06:25:51.636269 | 2025-10-10 06:25:51.636357 | TASK [fetch-output : Set log path for single node] 2025-10-10 06:25:51.678535 | controller | ok 2025-10-10 06:25:51.685846 | 2025-10-10 06:25:51.685954 | LOOP [fetch-output : Ensure local output dirs] 2025-10-10 06:25:51.963139 | controller -> localhost | ok: "/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/logs" 2025-10-10 06:25:51.963435 | controller -> localhost | changed: All items complete 2025-10-10 06:25:51.963466 | 2025-10-10 06:25:52.168889 | controller -> localhost | changed: "/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/artifacts" 2025-10-10 06:25:52.383360 | controller -> localhost | changed: "/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/docs" 2025-10-10 06:25:52.402450 | 2025-10-10 06:25:52.402738 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-10 06:25:53.213586 | controller | changed: 2025-10-10 06:25:53.214047 | controller | .d..t...... ./ 2025-10-10 06:25:53.214116 | controller | >f+++++++++ README.html 2025-10-10 06:25:53.214160 | controller | >f+++++++++ ansible.log 2025-10-10 06:25:53.214202 | controller | >f+++++++++ dmesg.log 2025-10-10 06:25:53.214241 | controller | >f+++++++++ installed-pkgs.log 2025-10-10 06:25:53.214279 | controller | >f+++++++++ python.log 2025-10-10 06:25:53.214316 | controller | >f+++++++++ registries.conf 2025-10-10 06:25:53.214355 | controller | >f+++++++++ selinux-denials.log 2025-10-10 06:25:53.214394 | controller | >f+++++++++ selinux-listing.log 2025-10-10 06:25:53.214436 | controller | cd+++++++++ ci-framework-data/ 2025-10-10 06:25:53.214474 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-10 06:25:53.214511 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-10 06:25:53.214547 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/ 2025-10-10 06:25:53.214582 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/ 2025-10-10 06:25:53.214618 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/ 2025-10-10 06:25:53.214698 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-10 06:25:53.214749 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/custom-params.yml 2025-10-10 06:25:53.214786 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-10 06:25:53.214821 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/ 2025-10-10 06:25:53.214857 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5 2025-10-10 06:25:53.214892 | controller | cd+++++++++ ci-framework-data/logs/ 2025-10-10 06:25:53.214927 | controller | >f+++++++++ ci-framework-data/logs/containers-built.log 2025-10-10 06:25:53.214963 | controller | cd+++++++++ ci-framework-data/logs/edpm_images/ 2025-10-10 06:25:53.215000 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/edpm_hardened_uefi_container_package.log 2025-10-10 06:25:53.215038 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/edpm_hardened_uefi_image_build.log 2025-10-10 06:25:53.215074 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/edpm_hardened_uefi_image_build_err.log 2025-10-10 06:25:53.215110 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/ironic_python_agent_container_package.log 2025-10-10 06:25:53.215146 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/ironic_python_agent_image_build.log 2025-10-10 06:25:53.215181 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/ironic_python_agent_image_build_err.log 2025-10-10 06:25:53.215216 | controller | cd+++++++++ registries.conf.d/ 2025-10-10 06:25:53.215252 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-10 06:25:53.215287 | controller | cd+++++++++ system-config/ 2025-10-10 06:25:53.215322 | controller | cd+++++++++ system-config/libvirt/ 2025-10-10 06:25:53.215356 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-10 06:25:53.215390 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-10 06:25:53.764173 | controller | changed: .d..t...... ./ 2025-10-10 06:25:54.308012 | controller | changed: .d..t...... ./ 2025-10-10 06:25:54.336426 | 2025-10-10 06:25:54.336637 | TASK [Return artifact to Zuul] 2025-10-10 06:25:54.363954 | controller | skipping: Conditional result was False 2025-10-10 06:25:54.393354 | 2025-10-10 06:25:54.393435 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-10 06:25:54.393588 | 2025-10-10 06:25:54.393626 | PLAY RECAP 2025-10-10 06:25:54.393703 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-10-10 06:25:54.393739 | 2025-10-10 06:25:54.524482 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-10 06:25:54.525656 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-10 06:25:55.105996 | 2025-10-10 06:25:55.106154 | PLAY [Report DLRN results after job run] 2025-10-10 06:25:55.126546 | 2025-10-10 06:25:55.126627 | TASK [Report job status to DLRN] 2025-10-10 06:25:55.147580 | controller | ok 2025-10-10 06:25:55.170122 | 2025-10-10 06:25:55.170226 | TASK [dlrn_report : Warning if DLRN is not running] 2025-10-10 06:25:55.235432 | controller | skipping: Conditional result was False 2025-10-10 06:25:55.243119 | 2025-10-10 06:25:55.243211 | TASK [dlrn_report : Install dlrnapi-client shyaml package] 2025-10-10 06:25:56.650501 | controller | changed 2025-10-10 06:25:56.662901 | 2025-10-10 06:25:56.663043 | TASK [dlrn_report : Install kinit related package] 2025-10-10 06:25:56.712108 | controller | skipping: Conditional result was False 2025-10-10 06:25:56.724020 | 2025-10-10 06:25:56.724161 | TASK [dlrn_report : Install dlrn kerberos related packages] 2025-10-10 06:25:56.781796 | controller | skipping: Conditional result was False 2025-10-10 06:25:56.794346 | 2025-10-10 06:25:56.794484 | TASK [Set zuul-log-path fact] 2025-10-10 06:25:56.863186 | controller | ok 2025-10-10 06:25:56.898509 | 2025-10-10 06:25:56.898605 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 06:25:56.977013 | controller | ok 2025-10-10 06:25:56.997379 | 2025-10-10 06:25:56.997524 | TASK [dlrn_report : Set the the value of cifmw_repo_setup_promotion when multiple dlrn tags are used] 2025-10-10 06:25:57.056438 | controller | skipping: Conditional result was False 2025-10-10 06:25:57.065026 | 2025-10-10 06:25:57.065115 | TASK [Get hash related data from repo_setup role] 2025-10-10 06:25:57.121841 | controller | ok 2025-10-10 06:25:57.235905 | 2025-10-10 06:25:57.236075 | LOOP [repo_setup : Ensure directories are present] 2025-10-10 06:25:57.696464 | controller | ok: "tmp" 2025-10-10 06:25:57.966944 | controller | ok: "artifacts/repositories" 2025-10-10 06:25:58.221384 | controller | ok: "venv/repo_setup" 2025-10-10 06:25:58.236116 | 2025-10-10 06:25:58.236266 | TASK [repo_setup : Make sure git-core package is installed] 2025-10-10 06:26:00.196382 | controller | ok: Nothing to do 2025-10-10 06:26:00.208175 | 2025-10-10 06:26:00.208318 | TASK [repo_setup : Get repo-setup repository] 2025-10-10 06:26:00.776691 | controller | ok 2025-10-10 06:26:00.789169 | 2025-10-10 06:26:00.789318 | TASK [repo_setup : Initialize python venv and install requirements] 2025-10-10 06:26:02.396809 | controller | ok 2025-10-10 06:26:02.410568 | 2025-10-10 06:26:02.410747 | TASK [repo_setup : Install repo-setup package] 2025-10-10 06:26:12.983293 | controller | ok: Did not run command since '/home/zuul/ci-framework-data/venv/repo-setup/bin/repo-setup' exists 2025-10-10 06:26:12.998240 | 2025-10-10 06:26:12.998432 | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] 2025-10-10 06:26:13.077370 | controller | skipping: Conditional result was False 2025-10-10 06:26:13.090144 | 2025-10-10 06:26:13.090288 | TASK [repo_setup : Run repo-setup] 2025-10-10 06:26:13.852939 | controller | Cache was expired 2025-10-10 06:26:13.899625 | controller | 189 files removed 2025-10-10 06:26:13.941923 | controller | Removed old repo "/etc/yum.repos.d/delorean.repo" 2025-10-10 06:26:13.961959 | controller | Removed old repo "/etc/yum.repos.d/delorean-antelope-testing.repo" 2025-10-10 06:26:13.962086 | controller | Removed old repo "/etc/yum.repos.d/repo-setup-centos-highavailability.repo" 2025-10-10 06:26:13.962099 | controller | Removed old repo "/etc/yum.repos.d/repo-setup-centos-powertools.repo" 2025-10-10 06:26:13.962106 | controller | Installed repo delorean to /etc/yum.repos.d/delorean.repo 2025-10-10 06:26:13.962112 | controller | Installed repo delorean-antelope-testing to /etc/yum.repos.d/delorean-antelope-testing.repo 2025-10-10 06:26:13.962119 | controller | Installed repo repo-setup-centos-highavailability to /etc/yum.repos.d/repo-setup-centos-highavailability.repo 2025-10-10 06:26:13.962125 | controller | Installed repo repo-setup-centos-powertools to /etc/yum.repos.d/repo-setup-centos-powertools.repo 2025-10-10 06:26:13.962131 | controller | Installed repo repo-setup-centos-appstream to /etc/yum.repos.d/repo-setup-centos-appstream.repo 2025-10-10 06:26:13.962137 | controller | Installed repo repo-setup-centos-baseos to /etc/yum.repos.d/repo-setup-centos-baseos.repo 2025-10-10 06:26:14.145011 | controller | changed 2025-10-10 06:26:14.157462 | 2025-10-10 06:26:14.157596 | TASK [repo_setup : Get component repo] 2025-10-10 06:26:14.248605 | controller | skipping: Conditional result was False 2025-10-10 06:26:14.262949 | 2025-10-10 06:26:14.263096 | TASK [repo_setup : Rename component repo] 2025-10-10 06:26:14.342658 | controller | skipping: Conditional result was False 2025-10-10 06:26:14.356712 | 2025-10-10 06:26:14.356857 | TASK [repo_setup : Disable component repo in current-podified dlrn repo] 2025-10-10 06:26:14.425473 | controller | skipping: Conditional result was False 2025-10-10 06:26:14.438893 | 2025-10-10 06:26:14.439045 | TASK [repo_setup : Run repo-setup-get-hash] 2025-10-10 06:26:15.061245 | controller | {"commit_hash": null, "distro_hash": null, "full_hash": "c4b77291aeca5591ac860bd4127cec2f", "extended_hash": null, "dlrn_url": "https://trunk.rdoproject.org/centos9-antelope/podified-ci-testing/delorean.repo.md5", "dlrn_api_url": "https://trunk.rdoproject.org/api-centos9-antelope", "os_version": "centos9", "release": "antelope", "component": null, "tag": "podified-ci-testing"} 2025-10-10 06:26:15.492484 | controller | changed 2025-10-10 06:26:15.506276 | 2025-10-10 06:26:15.506414 | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] 2025-10-10 06:26:16.564627 | controller | ok 2025-10-10 06:26:16.576775 | 2025-10-10 06:26:16.576935 | TASK [repo_setup : Dump current-podified hash] 2025-10-10 06:26:16.656085 | controller | skipping: Conditional result was False 2025-10-10 06:26:16.669117 | 2025-10-10 06:26:16.669256 | TASK [repo_setup : Slurp current podified hash] 2025-10-10 06:26:16.727649 | controller | skipping: Conditional result was False 2025-10-10 06:26:16.740340 | 2025-10-10 06:26:16.740476 | TASK [repo_setup : Update the value of full_hash] 2025-10-10 06:26:16.788427 | controller | skipping: Conditional result was False 2025-10-10 06:26:16.800859 | 2025-10-10 06:26:16.800995 | TASK [repo_setup : Export hashes facts for further use] 2025-10-10 06:26:16.872160 | controller | ok 2025-10-10 06:26:16.883924 | 2025-10-10 06:26:16.884058 | TASK [repo_setup : Create download directory] 2025-10-10 06:26:16.931898 | controller | skipping: Conditional result was False 2025-10-10 06:26:16.946941 | 2025-10-10 06:26:16.947079 | TASK [repo_setup : Print the URL to request] 2025-10-10 06:26:16.994739 | controller | skipping: Conditional result was False 2025-10-10 06:26:17.007528 | 2025-10-10 06:26:17.007659 | TASK [Download the RPM] 2025-10-10 06:26:17.055439 | controller | skipping: Conditional result was False 2025-10-10 06:26:17.068226 | 2025-10-10 06:26:17.068363 | TASK [repo_setup : Install RHOS Release tool] 2025-10-10 06:26:17.117290 | controller | skipping: Conditional result was False 2025-10-10 06:26:17.130791 | 2025-10-10 06:26:17.130947 | TASK [repo_setup : Get rhos-release tool version] 2025-10-10 06:26:17.700393 | controller | skipping: Conditional result was False 2025-10-10 06:26:17.708607 | 2025-10-10 06:26:17.708715 | TASK [repo_setup : Print rhos-release tool version] 2025-10-10 06:26:17.775241 | controller | skipping: Conditional result was False 2025-10-10 06:26:17.785376 | 2025-10-10 06:26:17.785470 | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] 2025-10-10 06:26:18.324183 | controller | skipping: Conditional result was False 2025-10-10 06:26:18.332847 | 2025-10-10 06:26:18.332938 | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] 2025-10-10 06:26:18.667465 | controller | ok 2025-10-10 06:26:18.681632 | 2025-10-10 06:26:18.681810 | TASK [repo_setup : Use RDO proxy mirrors] 2025-10-10 06:26:19.262714 | controller | changed 2025-10-10 06:26:19.268484 | 2025-10-10 06:26:19.268546 | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] 2025-10-10 06:26:19.798253 | controller | changed 2025-10-10 06:26:19.804124 | 2025-10-10 06:26:19.804186 | TASK [repo_setup : Check for gating.repo file on content provider] 2025-10-10 06:26:19.889859 | controller | skipping: Conditional result was False 2025-10-10 06:26:19.896031 | 2025-10-10 06:26:19.896096 | TASK [repo_setup : Populate gating repo from content provider ip] 2025-10-10 06:26:19.972201 | controller | skipping: Conditional result was False 2025-10-10 06:26:19.987237 | 2025-10-10 06:26:19.987397 | TASK [repo_setup : Check for DLRN repo at the destination] 2025-10-10 06:26:20.055342 | controller | skipping: Conditional result was False 2025-10-10 06:26:20.068524 | 2025-10-10 06:26:20.068697 | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] 2025-10-10 06:26:20.126441 | controller | skipping: Conditional result was False 2025-10-10 06:26:20.139336 | 2025-10-10 06:26:20.139470 | TASK [repo_setup : Check for DLRN component repo] 2025-10-10 06:26:20.217474 | controller | skipping: Conditional result was False 2025-10-10 06:26:20.230442 | 2025-10-10 06:26:20.230581 | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] 2025-10-10 06:26:20.309569 | controller | skipping: Conditional result was False 2025-10-10 06:26:20.323160 | 2025-10-10 06:26:20.323295 | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] 2025-10-10 06:26:20.400938 | controller | skipping: Conditional result was False 2025-10-10 06:26:20.409550 | 2025-10-10 06:26:20.409730 | LOOP [repo_setup : Remove existing repos from /etc/yum.repos.d directory] 2025-10-10 06:26:20.496498 | 2025-10-10 06:26:20.496736 | TASK [repo_setup : Cleanup existing metadata] 2025-10-10 06:26:21.038764 | controller | skipping: Conditional result was False 2025-10-10 06:26:21.052642 | 2025-10-10 06:26:21.052840 | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] 2025-10-10 06:26:21.132437 | controller | skipping: Conditional result was False 2025-10-10 06:26:21.159438 | 2025-10-10 06:26:21.159608 | TASK [dlrn_report : Perform kinit for DLRN kerberos authentication] 2025-10-10 06:26:21.707707 | controller | skipping: Conditional result was False 2025-10-10 06:26:21.721774 | 2025-10-10 06:26:21.721957 | TASK [dlrn_report : Set empty value for dlrnapi password] 2025-10-10 06:26:21.801410 | controller | skipping: Conditional result was False 2025-10-10 06:26:21.814335 | 2025-10-10 06:26:21.814554 | TASK [dlrn_report : Report results to dlrn for the tested hash] 2025-10-10 06:26:22.149261 | controller | REPORTING SUCCESS TO DLRN API 2025-10-10 06:26:22.598329 | controller | { 2025-10-10 06:26:22.612696 | controller | "aggregate_hash": "c4b77291aeca5591ac860bd4127cec2f", 2025-10-10 06:26:22.612960 | controller | "commit_hash": null, 2025-10-10 06:26:22.612971 | controller | "component": null, 2025-10-10 06:26:22.612980 | controller | "distro_hash": null, 2025-10-10 06:26:22.612988 | controller | "extended_hash": null, 2025-10-10 06:26:22.612995 | controller | "in_progress": false, 2025-10-10 06:26:22.613003 | controller | "job_id": "periodic-edpm-build-push-images-centos-9-antelope", 2025-10-10 06:26:22.613011 | controller | "notes": "", 2025-10-10 06:26:22.613019 | controller | "success": true, 2025-10-10 06:26:22.613027 | controller | "timestamp": 1760077582, 2025-10-10 06:26:22.613034 | controller | "url": "https://logserver.rdoproject.org/be0/rdoproject.org/be058301cb644d2b92ffdd4d638a6a0e" 2025-10-10 06:26:22.613041 | controller | } 2025-10-10 06:26:22.872206 | controller | changed 2025-10-10 06:26:22.924252 | 2025-10-10 06:26:22.924348 | PLAY RECAP 2025-10-10 06:26:22.924403 | controller | ok: 15 changed: 6 unreachable: 0 failed: 0 skipped: 30 rescued: 0 ignored: 0 2025-10-10 06:26:22.924430 | 2025-10-10 06:26:23.043432 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-10 06:26:23.044702 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-10 06:26:23.631252 | 2025-10-10 06:26:23.631387 | PLAY [all] 2025-10-10 06:26:23.650558 | 2025-10-10 06:26:23.650650 | TASK [include_role : fetch-output] 2025-10-10 06:26:23.679970 | controller | ok 2025-10-10 06:26:23.698943 | 2025-10-10 06:26:23.699102 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-10 06:26:23.765330 | controller | skipping: Conditional result was False 2025-10-10 06:26:23.773708 | 2025-10-10 06:26:23.773803 | TASK [fetch-output : Set log path for single node] 2025-10-10 06:26:23.806866 | controller | ok 2025-10-10 06:26:23.813902 | 2025-10-10 06:26:23.813995 | LOOP [fetch-output : Ensure local output dirs] 2025-10-10 06:26:24.232016 | controller -> localhost | ok: "/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/logs" 2025-10-10 06:26:24.474344 | controller -> localhost | ok: "/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/artifacts" 2025-10-10 06:26:24.684090 | controller -> localhost | ok: "/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/docs" 2025-10-10 06:26:24.702172 | 2025-10-10 06:26:24.702331 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-10 06:26:25.386079 | controller | ok 2025-10-10 06:26:25.386471 | controller | ok: All items complete 2025-10-10 06:26:25.386532 | 2025-10-10 06:26:25.902616 | controller | ok 2025-10-10 06:26:26.386316 | controller | ok 2025-10-10 06:26:26.401108 | 2025-10-10 06:26:26.401264 | TASK [include_role : fetch-output-openshift] 2025-10-10 06:26:26.427267 | controller | skipping: Conditional result was False 2025-10-10 06:26:26.434050 | 2025-10-10 06:26:26.434115 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-10 06:26:26.477820 | controller | skipping: Conditional result was False 2025-10-10 06:26:26.487797 | controller | skipping: Conditional result was False 2025-10-10 06:26:26.515448 | 2025-10-10 06:26:26.515534 | PLAY [all] 2025-10-10 06:26:26.529797 | 2025-10-10 06:26:26.529861 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-10 06:26:27.066389 | controller | changed 2025-10-10 06:26:27.091152 | 2025-10-10 06:26:27.091205 | PLAY RECAP 2025-10-10 06:26:27.091249 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-10-10 06:26:27.091268 | 2025-10-10 06:26:27.196503 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-10 06:26:27.197608 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-10 06:26:27.825139 | 2025-10-10 06:26:27.825279 | PLAY [localhost] 2025-10-10 06:26:27.843056 | 2025-10-10 06:26:27.843146 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-10 06:26:28.276850 | localhost | changed 2025-10-10 06:26:28.286655 | 2025-10-10 06:26:28.286862 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-10 06:26:28.333033 | localhost | ok 2025-10-10 06:26:28.350140 | 2025-10-10 06:26:28.350273 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-10 06:26:28.774196 | localhost | changed 2025-10-10 06:26:28.784478 | 2025-10-10 06:26:28.784623 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-10 06:26:29.481899 | localhost | changed 2025-10-10 06:26:29.492652 | 2025-10-10 06:26:29.492837 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-10 06:26:29.968228 | localhost | Identity added: /var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/tmp/ansible.donfseus (/var/lib/zuul/builds/be058301cb644d2b92ffdd4d638a6a0e/work/tmp/ansible.donfseus) 2025-10-10 06:26:29.968587 | localhost | ok: Runtime: 0:00:00.012788 2025-10-10 06:26:29.977967 | 2025-10-10 06:26:29.978102 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-10 06:26:30.303318 | localhost | ok: Runtime: 0:00:00.008161 2025-10-10 06:26:30.308896 | 2025-10-10 06:26:30.308962 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-10 06:26:30.394200 | localhost | changed 2025-10-10 06:26:30.403222 | 2025-10-10 06:26:30.403352 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-10 06:26:30.846719 | localhost | changed 2025-10-10 06:26:30.887408 | 2025-10-10 06:26:30.887546 | PLAY [localhost] 2025-10-10 06:26:30.905328 | 2025-10-10 06:26:30.905434 | TASK [Generate bulk log download script] 2025-10-10 06:26:30.928062 | localhost | ok 2025-10-10 06:26:30.945132 | 2025-10-10 06:26:30.945267 | TASK [local-log-download : Check API endpoint is defined] 2025-10-10 06:26:30.988126 | localhost | ok: All assertions passed 2025-10-10 06:26:30.994834 | 2025-10-10 06:26:30.994922 | TASK [local-log-download : Create download script] 2025-10-10 06:26:31.497924 | localhost -> localhost | changed 2025-10-10 06:26:31.517214 | 2025-10-10 06:26:31.517349 | TASK [Register quick-download link] 2025-10-10 06:26:31.545354 | localhost | ok 2025-10-10 06:26:31.601905 | 2025-10-10 06:26:31.602032 | PLAY [logserver.rdoproject.org] 2025-10-10 06:26:31.611434 | 2025-10-10 06:26:31.611492 | TASK [Set zuul-log-path fact] 2025-10-10 06:26:31.628426 | logserver.rdoproject.org | ok 2025-10-10 06:26:31.636894 | 2025-10-10 06:26:31.636954 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 06:26:31.663925 | logserver.rdoproject.org | ok 2025-10-10 06:26:31.668891 | 2025-10-10 06:26:31.668951 | TASK [upload-logs : Create log directories] 2025-10-10 06:26:32.516125 | logserver.rdoproject.org | changed 2025-10-10 06:26:32.523089 | 2025-10-10 06:26:32.523224 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-10 06:26:32.857799 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006875 2025-10-10 06:26:32.867589 | 2025-10-10 06:26:32.867755 | TASK [upload-logs : Upload logs to log server] 2025-10-10 06:26:33.636434 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-10 06:26:33.643281 | 2025-10-10 06:26:33.643412 | LOOP [upload-logs : Compress console log and json output] 2025-10-10 06:26:33.702032 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 06:26:33.714040 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 06:26:33.730547 | 2025-10-10 06:26:33.730757 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-10 06:26:33.782521 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 06:26:33.783030 | 2025-10-10 06:26:33.785322 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-10 06:26:33.796627 | 2025-10-10 06:26:33.796830 | LOOP [upload-logs : Upload console log and json output]