2025-12-11 05:05:01.339582 | Job console starting... 2025-12-11 05:05:01.551470 | Updating repositories 2025-12-11 05:05:02.289229 | Preparing job workspace 2025-12-11 05:05:09.274167 | Running Ansible setup... 2025-12-11 05:05:12.035012 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-11 05:05:12.495245 | 2025-12-11 05:05:12.495336 | PLAY [localhost] 2025-12-11 05:05:12.502896 | 2025-12-11 05:05:12.502959 | TASK [Gathering Facts] 2025-12-11 05:05:13.247734 | localhost | ok 2025-12-11 05:05:13.260349 | 2025-12-11 05:05:13.260426 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-11 05:05:13.546912 | localhost -> localhost | changed 2025-12-11 05:05:13.551463 | 2025-12-11 05:05:13.551529 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-11 05:05:14.183052 | localhost -> localhost | changed 2025-12-11 05:05:14.191105 | 2025-12-11 05:05:14.191186 | TASK [Setup log path fact] 2025-12-11 05:05:14.207615 | localhost | ok 2025-12-11 05:05:14.217923 | 2025-12-11 05:05:14.217990 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 05:05:14.234821 | localhost | ok 2025-12-11 05:05:14.241500 | 2025-12-11 05:05:14.241562 | TASK [emit-job-header : Print job information] 2025-12-11 05:05:14.267786 | # Job Information 2025-12-11 05:05:14.267889 | Ansible Version: 2.15.12 2025-12-11 05:05:14.267916 | Job: periodic-edpm-build-push-images-centos-9-master 2025-12-11 05:05:14.267936 | Pipeline: openstack-periodic-container-master-centos9 2025-12-11 05:05:14.267956 | Executor: ibm-bm3-ze.softwarefactory-project.io 2025-12-11 05:05:14.267975 | Triggered by: https://review.rdoproject.org/r/plugins/gitiles/rdo-jobs/+/None^!/ 2025-12-11 05:05:14.267992 | Log URL (when completed): https://logserver.rdoproject.org/2b0/rdoproject.org/2b04894328cf478ebeac1f004357ce88/ 2025-12-11 05:05:14.268008 | Event ID: e338714bc6ff4ee79e0232995389f30d 2025-12-11 05:05:14.271366 | 2025-12-11 05:05:14.271429 | LOOP [emit-job-header : Print node information] 2025-12-11 05:05:14.349099 | localhost | ok: 2025-12-11 05:05:14.349273 | localhost | # Node Information 2025-12-11 05:05:14.349300 | localhost | Inventory Hostname: controller 2025-12-11 05:05:14.349322 | localhost | Hostname: np0005554836 2025-12-11 05:05:14.349340 | localhost | Username: zuul 2025-12-11 05:05:14.349358 | localhost | Distro: CentOS 9 2025-12-11 05:05:14.349375 | localhost | Provider: ibm-bm3-nodepool 2025-12-11 05:05:14.349391 | localhost | Region: regionOne 2025-12-11 05:05:14.349406 | localhost | Label: cloud-centos-9-stream-tripleo 2025-12-11 05:05:14.349421 | localhost | Product Name: OpenStack Compute 2025-12-11 05:05:14.349435 | localhost | Interface IP: 192.168.25.2 2025-12-11 05:05:14.373165 | 2025-12-11 05:05:14.373231 | PLAY [all] 2025-12-11 05:05:14.378834 | 2025-12-11 05:05:14.378891 | TASK [Gather network facts] 2025-12-11 05:05:14.741964 | controller | ok 2025-12-11 05:05:14.754873 | 2025-12-11 05:05:14.754935 | TASK [include_role : start-zuul-console] 2025-12-11 05:05:14.772575 | controller | ok 2025-12-11 05:05:14.783294 | 2025-12-11 05:05:14.783366 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-11 05:05:15.075238 | controller | ok 2025-12-11 05:05:15.082881 | 2025-12-11 05:05:15.082943 | TASK [include_role : add-build-sshkey] 2025-12-11 05:05:15.099980 | controller | ok 2025-12-11 05:05:15.111295 | 2025-12-11 05:05:15.111353 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-11 05:05:15.286496 | controller -> localhost | ok 2025-12-11 05:05:15.291310 | 2025-12-11 05:05:15.291373 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-11 05:05:15.308618 | controller | ok 2025-12-11 05:05:15.319332 | controller | included: /var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-11 05:05:15.324223 | 2025-12-11 05:05:15.324279 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-11 05:05:15.842415 | controller -> localhost | Generating public/private rsa key pair. 2025-12-11 05:05:15.842597 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/2b04894328cf478ebeac1f004357ce88_id_rsa. 2025-12-11 05:05:15.842632 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/2b04894328cf478ebeac1f004357ce88_id_rsa.pub. 2025-12-11 05:05:15.842714 | controller -> localhost | The key fingerprint is: 2025-12-11 05:05:15.842741 | controller -> localhost | SHA256:Om+5lIg4A6Owlfy+t1qCWD5Mf4hs8Jd5G9kbvcuPP0c zuul-build-sshkey 2025-12-11 05:05:15.842762 | controller -> localhost | The key's randomart image is: 2025-12-11 05:05:15.842781 | controller -> localhost | +---[RSA 3072]----+ 2025-12-11 05:05:15.842798 | controller -> localhost | | | 2025-12-11 05:05:15.842815 | controller -> localhost | | | 2025-12-11 05:05:15.842832 | controller -> localhost | | | 2025-12-11 05:05:15.842848 | controller -> localhost | | . . | 2025-12-11 05:05:15.842865 | controller -> localhost | |= * S | 2025-12-11 05:05:15.842882 | controller -> localhost | |o# * = = o E | 2025-12-11 05:05:15.842898 | controller -> localhost | |+ & X X =.. . | 2025-12-11 05:05:15.842916 | controller -> localhost | | . * =.*o+ o. . | 2025-12-11 05:05:15.842933 | controller -> localhost | | ++oo+.=+oo | 2025-12-11 05:05:15.842950 | controller -> localhost | +----[SHA256]-----+ 2025-12-11 05:05:15.842992 | controller -> localhost | ok: Runtime: 0:00:00.219907 2025-12-11 05:05:15.848142 | 2025-12-11 05:05:15.848205 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-11 05:05:15.865622 | controller | ok 2025-12-11 05:05:15.874162 | controller | included: /var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-11 05:05:15.881218 | 2025-12-11 05:05:15.881282 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-11 05:05:15.894681 | controller | skipping: Conditional result was False 2025-12-11 05:05:15.899416 | 2025-12-11 05:05:15.899473 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-11 05:05:16.232373 | controller | changed 2025-12-11 05:05:16.236484 | 2025-12-11 05:05:16.236541 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-11 05:05:16.427200 | controller | ok 2025-12-11 05:05:16.431518 | 2025-12-11 05:05:16.431577 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-11 05:05:17.016418 | controller | changed 2025-12-11 05:05:17.021073 | 2025-12-11 05:05:17.021136 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-11 05:05:17.576955 | controller | changed 2025-12-11 05:05:17.581574 | 2025-12-11 05:05:17.581637 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-11 05:05:17.594548 | controller | skipping: Conditional result was False 2025-12-11 05:05:17.600154 | 2025-12-11 05:05:17.600219 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-11 05:05:17.876873 | controller -> localhost | changed 2025-12-11 05:05:17.886080 | 2025-12-11 05:05:17.886144 | TASK [add-build-sshkey : Add back temp key] 2025-12-11 05:05:18.091807 | controller -> localhost | Identity added: /var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/2b04894328cf478ebeac1f004357ce88_id_rsa (zuul-build-sshkey) 2025-12-11 05:05:18.092003 | controller -> localhost | ok: Runtime: 0:00:00.005777 2025-12-11 05:05:18.097425 | 2025-12-11 05:05:18.097486 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-11 05:05:18.369194 | controller | ok 2025-12-11 05:05:18.373580 | 2025-12-11 05:05:18.373643 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-11 05:05:18.397911 | controller | skipping: Conditional result was False 2025-12-11 05:05:18.406324 | 2025-12-11 05:05:18.406398 | TASK [include_role : validate-host] 2025-12-11 05:05:18.423983 | controller | ok 2025-12-11 05:05:18.442456 | 2025-12-11 05:05:18.442523 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-11 05:05:18.470282 | controller | ok 2025-12-11 05:05:18.474622 | 2025-12-11 05:05:18.474705 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-11 05:05:18.659929 | controller -> localhost | ok 2025-12-11 05:05:18.665201 | 2025-12-11 05:05:18.665266 | TASK [validate-host : Collect information about the host] 2025-12-11 05:05:20.277554 | controller | ok 2025-12-11 05:05:20.302460 | 2025-12-11 05:05:20.302539 | TASK [validate-host : Sanitize hostname] 2025-12-11 05:05:20.339577 | controller | ok 2025-12-11 05:05:20.343832 | 2025-12-11 05:05:20.343892 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-11 05:05:20.672183 | controller -> localhost | changed 2025-12-11 05:05:20.676974 | 2025-12-11 05:05:20.677034 | TASK [validate-host : Collect information about zuul worker] 2025-12-11 05:05:20.979267 | controller | ok 2025-12-11 05:05:20.983348 | 2025-12-11 05:05:20.983407 | TASK [validate-host : Write out all zuul information for each host] 2025-12-11 05:05:21.311006 | controller -> localhost | changed 2025-12-11 05:05:21.319360 | 2025-12-11 05:05:21.319423 | TASK [include_role : prepare-workspace-openshift] 2025-12-11 05:05:21.332389 | controller | skipping: Conditional result was False 2025-12-11 05:05:21.336885 | 2025-12-11 05:05:21.336947 | TASK [include_role : remove-zuul-sshkey] 2025-12-11 05:05:21.349706 | controller | skipping: Conditional result was False 2025-12-11 05:05:21.355891 | 2025-12-11 05:05:21.355954 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-11 05:05:21.539537 | controller | ok: "logs" 2025-12-11 05:05:21.539774 | controller | ok: All items complete 2025-12-11 05:05:21.539806 | 2025-12-11 05:05:21.692981 | controller | ok: "artifacts" 2025-12-11 05:05:21.847679 | controller | ok: "docs" 2025-12-11 05:05:21.859774 | 2025-12-11 05:05:21.859845 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-11 05:05:22.052370 | controller | changed: "logs" 2025-12-11 05:05:22.212710 | controller | changed: "artifacts" 2025-12-11 05:05:22.373780 | controller | changed: "docs" 2025-12-11 05:05:22.399938 | 2025-12-11 05:05:22.399986 | PLAY RECAP 2025-12-11 05:05:22.400027 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-12-11 05:05:22.400054 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-11 05:05:22.400072 | 2025-12-11 05:05:22.466719 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-12-11 05:05:22.467521 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-12-11 05:05:22.960032 | 2025-12-11 05:05:22.960126 | PLAY [all] 2025-12-11 05:05:22.978607 | 2025-12-11 05:05:22.978704 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-12-11 05:05:23.026836 | controller | ok 2025-12-11 05:05:23.031587 | 2025-12-11 05:05:23.031689 | TASK [mirror-info-fork : Create /etc/ci] 2025-12-11 05:05:23.343812 | controller | changed 2025-12-11 05:05:23.348596 | 2025-12-11 05:05:23.348682 | TASK [mirror-info-fork : Install ci_mirror script] 2025-12-11 05:05:24.097230 | controller | changed 2025-12-11 05:05:24.105560 | 2025-12-11 05:05:24.105624 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-12-11 05:05:24.435143 | controller | changed: 2025-12-11 05:05:24.435319 | controller | { 2025-12-11 05:05:24.435350 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-12-11 05:05:24.435379 | controller | } 2025-12-11 05:05:24.635591 | controller | changed: 2025-12-11 05:05:24.635753 | controller | { 2025-12-11 05:05:24.635790 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-12-11 05:05:24.635815 | controller | } 2025-12-11 05:05:24.833964 | controller | changed: 2025-12-11 05:05:24.834038 | controller | { 2025-12-11 05:05:24.834065 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-12-11 05:05:24.834109 | controller | } 2025-12-11 05:05:25.033422 | controller | changed: 2025-12-11 05:05:25.033472 | controller | { 2025-12-11 05:05:25.033497 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-12-11 05:05:25.033516 | controller | } 2025-12-11 05:05:25.226383 | controller | changed: 2025-12-11 05:05:25.226433 | controller | { 2025-12-11 05:05:25.226458 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-12-11 05:05:25.226478 | controller | } 2025-12-11 05:05:25.430620 | controller | changed: 2025-12-11 05:05:25.430695 | controller | { 2025-12-11 05:05:25.430725 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-12-11 05:05:25.430745 | controller | } 2025-12-11 05:05:25.625383 | controller | changed: 2025-12-11 05:05:25.625434 | controller | { 2025-12-11 05:05:25.625460 | 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-12-11 05:05:25.625480 | controller | } 2025-12-11 05:05:25.818903 | controller | changed: 2025-12-11 05:05:25.818949 | controller | { 2025-12-11 05:05:25.818973 | 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-12-11 05:05:25.818992 | controller | } 2025-12-11 05:05:26.021263 | controller | changed: 2025-12-11 05:05:26.021314 | controller | { 2025-12-11 05:05:26.021338 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-12-11 05:05:26.021357 | controller | } 2025-12-11 05:05:26.235418 | controller | changed: 2025-12-11 05:05:26.235473 | controller | { 2025-12-11 05:05:26.235498 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-12-11 05:05:26.235516 | controller | } 2025-12-11 05:05:26.419134 | controller | changed: 2025-12-11 05:05:26.419178 | controller | { 2025-12-11 05:05:26.419202 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-12-11 05:05:26.419220 | controller | } 2025-12-11 05:05:26.631202 | controller | changed: 2025-12-11 05:05:26.631259 | controller | { 2025-12-11 05:05:26.631284 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-12-11 05:05:26.631303 | controller | } 2025-12-11 05:05:26.812961 | controller | changed: 2025-12-11 05:05:26.813012 | controller | { 2025-12-11 05:05:26.813037 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-12-11 05:05:26.813055 | controller | } 2025-12-11 05:05:27.010872 | controller | changed: 2025-12-11 05:05:27.010927 | controller | { 2025-12-11 05:05:27.010953 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-12-11 05:05:27.010971 | controller | } 2025-12-11 05:05:27.203574 | controller | changed: 2025-12-11 05:05:27.203627 | controller | { 2025-12-11 05:05:27.203677 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-12-11 05:05:27.203703 | controller | } 2025-12-11 05:05:27.396456 | controller | changed: 2025-12-11 05:05:27.396525 | controller | { 2025-12-11 05:05:27.396548 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-12-11 05:05:27.396565 | controller | } 2025-12-11 05:05:27.587634 | controller | changed: 2025-12-11 05:05:27.587710 | controller | { 2025-12-11 05:05:27.587734 | 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-12-11 05:05:27.587753 | controller | } 2025-12-11 05:05:27.779350 | controller | changed: 2025-12-11 05:05:27.779408 | controller | { 2025-12-11 05:05:27.779433 | 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-12-11 05:05:27.779461 | controller | } 2025-12-11 05:05:27.984252 | controller | changed: 2025-12-11 05:05:27.984302 | controller | { 2025-12-11 05:05:27.984328 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-12-11 05:05:27.984346 | controller | } 2025-12-11 05:05:28.177744 | controller | changed: 2025-12-11 05:05:28.177797 | controller | { 2025-12-11 05:05:28.177822 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-12-11 05:05:28.177842 | controller | } 2025-12-11 05:05:28.369343 | controller | changed: 2025-12-11 05:05:28.369388 | controller | { 2025-12-11 05:05:28.369411 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-12-11 05:05:28.369429 | controller | } 2025-12-11 05:05:28.560925 | controller | changed: 2025-12-11 05:05:28.560971 | controller | { 2025-12-11 05:05:28.561000 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-12-11 05:05:28.561020 | controller | } 2025-12-11 05:05:28.753780 | controller | changed: 2025-12-11 05:05:28.753826 | controller | { 2025-12-11 05:05:28.753848 | 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-12-11 05:05:28.753867 | controller | } 2025-12-11 05:05:28.947044 | controller | changed: 2025-12-11 05:05:28.947090 | controller | { 2025-12-11 05:05:28.947112 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-12-11 05:05:28.947129 | controller | } 2025-12-11 05:05:29.137347 | controller | changed: 2025-12-11 05:05:29.137401 | controller | { 2025-12-11 05:05:29.137431 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-12-11 05:05:29.137455 | controller | } 2025-12-11 05:05:29.334864 | controller | changed: 2025-12-11 05:05:29.334915 | controller | { 2025-12-11 05:05:29.334938 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-12-11 05:05:29.334956 | controller | } 2025-12-11 05:05:29.356252 | 2025-12-11 05:05:29.356346 | TASK [Set timezone to UTC] 2025-12-11 05:05:29.729006 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-12-11 05:05:29.733714 | 2025-12-11 05:05:29.733779 | TASK [Create nodepool directory] 2025-12-11 05:05:29.925839 | controller | changed 2025-12-11 05:05:29.930798 | 2025-12-11 05:05:29.930862 | TASK [Create nodepool sub_nodes file] 2025-12-11 05:05:30.446285 | controller | changed 2025-12-11 05:05:30.450844 | 2025-12-11 05:05:30.450913 | TASK [Create nodepool sub_nodes_private file] 2025-12-11 05:05:30.944804 | controller | changed 2025-12-11 05:05:30.949508 | 2025-12-11 05:05:30.949569 | LOOP [Populate nodepool sub_nodes file] 2025-12-11 05:05:30.978187 | 2025-12-11 05:05:30.978308 | LOOP [Populate nodepool sub_nodes_private file] 2025-12-11 05:05:31.006254 | 2025-12-11 05:05:31.006372 | TASK [Create nodepool primary file] 2025-12-11 05:05:31.029815 | controller | skipping: Conditional result was False 2025-12-11 05:05:31.034907 | 2025-12-11 05:05:31.034969 | TASK [Create nodepool node_private for this node] 2025-12-11 05:05:31.570259 | controller | changed 2025-12-11 05:05:31.575106 | 2025-12-11 05:05:31.575165 | LOOP [Copy ssh keys to nodepool directory] 2025-12-11 05:05:31.873742 | controller | ok: Item: id_rsa Runtime: 0:00:00.005056 2025-12-11 05:05:31.873895 | 2025-12-11 05:05:32.032214 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.006045 2025-12-11 05:05:32.042236 | 2025-12-11 05:05:32.042319 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-12-11 05:05:32.597352 | controller | changed 2025-12-11 05:05:32.601841 | 2025-12-11 05:05:32.601905 | TASK [Validate sudoers config after edits] 2025-12-11 05:05:32.805478 | controller | /etc/sudoers: parsed OK 2025-12-11 05:05:32.805541 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-12-11 05:05:32.805558 | controller | /etc/sudoers.d/zuul: parsed OK 2025-12-11 05:05:32.805570 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-12-11 05:05:33.126297 | controller | ok: Runtime: 0:00:00.005046 2025-12-11 05:05:33.131004 | 2025-12-11 05:05:33.131060 | TASK [Show the environment passed in to job shell scripts] 2025-12-11 05:05:33.326463 | controller | SHELL=/bin/bash 2025-12-11 05:05:33.326552 | controller | ZUUL_PROJECT=rdo-jobs 2025-12-11 05:05:33.326563 | controller | ZUUL_SHORT_PROJECT_NAME=rdo-jobs 2025-12-11 05:05:33.326570 | controller | PWD=/home/zuul 2025-12-11 05:05:33.326576 | controller | ZUUL_PIPELINE=openstack-periodic-container-master-centos9 2025-12-11 05:05:33.326581 | controller | LOGNAME=zuul 2025-12-11 05:05:33.326587 | controller | XDG_SESSION_TYPE=tty 2025-12-11 05:05:33.326591 | controller | _=/usr/bin/env 2025-12-11 05:05:33.326596 | controller | MOTD_SHOWN=pam 2025-12-11 05:05:33.326601 | controller | HOME=/home/zuul 2025-12-11 05:05:33.326606 | controller | LANG=en_US.UTF-8 2025-12-11 05:05:33.326611 | controller | SSH_CONNECTION=192.168.25.12 60680 192.168.25.2 22 2025-12-11 05:05:33.326616 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH 2025-12-11 05:05:33.326622 | controller | WORKSPACE=/home/zuul/workspace 2025-12-11 05:05:33.326627 | controller | XDG_SESSION_CLASS=user 2025-12-11 05:05:33.326632 | controller | SELINUX_ROLE_REQUESTED= 2025-12-11 05:05:33.326637 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-12-11 05:05:33.326644 | controller | USER=zuul 2025-12-11 05:05:33.326650 | controller | ZUUL_VOTING=True 2025-12-11 05:05:33.326655 | controller | BUILD_TIMEOUT=5400000 2025-12-11 05:05:33.326660 | controller | SELINUX_USE_CURRENT_RANGE= 2025-12-11 05:05:33.326665 | controller | SHLVL=1 2025-12-11 05:05:33.326670 | controller | XDG_SESSION_ID=1 2025-12-11 05:05:33.326675 | controller | ZUUL_BRANCH=master 2025-12-11 05:05:33.326683 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-12-11 05:05:33.326688 | controller | SSH_CLIENT=192.168.25.12 60680 22 2025-12-11 05:05:33.326693 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-12-11 05:05:33.326698 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-12-11 05:05:33.326703 | controller | which_declare=declare -f 2025-12-11 05:05:33.326709 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-12-11 05:05:33.326715 | controller | SELINUX_LEVEL_REQUESTED= 2025-12-11 05:05:33.326719 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-12-11 05:05:33.326726 | controller | ZUUL_UUID=2b04894328cf478ebeac1f004357ce88 2025-12-11 05:05:33.326731 | controller | BASH_FUNC_which%%=() { ( alias; 2025-12-11 05:05:33.326736 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-12-11 05:05:33.326742 | controller | } 2025-12-11 05:05:33.656641 | controller | ok: Runtime: 0:00:00.005296 2025-12-11 05:05:33.661758 | 2025-12-11 05:05:33.661820 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-12-11 05:05:33.675730 | controller | skipping: Conditional result was False 2025-12-11 05:05:33.680584 | 2025-12-11 05:05:33.680642 | TASK [Symlink /home/zuul-worker/workspace] 2025-12-11 05:05:34.205083 | controller | skipping: Conditional result was False 2025-12-11 05:05:34.210224 | 2025-12-11 05:05:34.210287 | TASK [Ensure legacy workspace directory] 2025-12-11 05:05:34.390830 | controller | changed 2025-12-11 05:05:34.406514 | 2025-12-11 05:05:34.406566 | PLAY RECAP 2025-12-11 05:05:34.406608 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-12-11 05:05:34.406627 | 2025-12-11 05:05:34.474379 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-12-11 05:05:34.475256 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-12-11 05:05:34.928081 | 2025-12-11 05:05:34.928167 | PLAY [all,!compute] 2025-12-11 05:05:34.945871 | 2025-12-11 05:05:34.945937 | TASK [Enable container-tools rhel-modules for c8/crc node] 2025-12-11 05:05:35.472870 | controller | skipping: Conditional result was False 2025-12-11 05:05:35.478293 | 2025-12-11 05:05:35.478371 | TASK [Install podman] 2025-12-11 05:06:21.480353 | controller | changed 2025-12-11 05:06:21.485691 | 2025-12-11 05:06:21.485759 | TASK [Set var name for quay login zuul secret] 2025-12-11 05:06:21.533332 | controller | ok 2025-12-11 05:06:21.537801 | 2025-12-11 05:06:21.537863 | TASK [Print the username] 2025-12-11 05:06:21.826690 | controller | podified-master-centos9+cirobot 2025-12-11 05:06:22.061339 | controller | ok: Runtime: 0:00:00.003692 2025-12-11 05:06:22.066540 | 2025-12-11 05:06:22.066614 | TASK [Fail when user or password is not set] 2025-12-11 05:06:22.100829 | controller | skipping: Conditional result was False 2025-12-11 05:06:22.106280 | 2025-12-11 05:06:22.106352 | TASK [Set vars for quay login] 2025-12-11 05:06:22.154396 | controller | Output suppressed because no_log was given 2025-12-11 05:06:22.158871 | 2025-12-11 05:06:22.158931 | LOOP [Perform container registry login(s) with podman] 2025-12-11 05:06:23.015455 | controller | Output suppressed because no_log was given 2025-12-11 05:06:23.020519 | 2025-12-11 05:06:23.020580 | LOOP [Perform container registry login(s) with buildah] 2025-12-11 05:06:23.060129 | controller | Output suppressed because no_log was given 2025-12-11 05:06:23.069437 | 2025-12-11 05:06:23.069514 | TASK [Set Insecure registry for content provider] 2025-12-11 05:06:23.112949 | controller | skipping: Conditional result was False 2025-12-11 05:06:23.131803 | 2025-12-11 05:06:23.131854 | PLAY RECAP 2025-12-11 05:06:23.131902 | controller | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-12-11 05:06:23.131926 | 2025-12-11 05:06:23.193362 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-12-11 05:06:23.194273 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-12-11 05:06:23.699470 | 2025-12-11 05:06:23.699566 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-12-11 05:06:23.717710 | 2025-12-11 05:06:23.717778 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-12-11 05:06:23.735198 | controller | ok 2025-12-11 05:06:23.751717 | 2025-12-11 05:06:23.751798 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-12-11 05:06:23.775475 | controller | skipping: Conditional result was False 2025-12-11 05:06:23.781107 | 2025-12-11 05:06:23.781178 | TASK [mirror-info-fork : Create /etc/ci] 2025-12-11 05:06:24.072349 | controller | ok 2025-12-11 05:06:24.077215 | 2025-12-11 05:06:24.077277 | TASK [mirror-info-fork : Install ci_mirror script] 2025-12-11 05:06:24.644828 | controller | ok 2025-12-11 05:06:24.654369 | 2025-12-11 05:06:24.654428 | TASK [Prepare workspace] 2025-12-11 05:06:24.672475 | controller | ok 2025-12-11 05:06:24.687523 | 2025-12-11 05:06:24.687594 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-11 05:06:24.948092 | controller | ok 2025-12-11 05:06:24.954100 | 2025-12-11 05:06:24.954158 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-11 05:06:27.099865 | controller | Output suppressed because no_log was given 2025-12-11 05:06:27.108763 | 2025-12-11 05:06:27.108832 | LOOP [Create zuul-output directory] 2025-12-11 05:06:27.283221 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-12-11 05:06:27.433891 | controller | ok: "/home/zuul/zuul-output/logs" 2025-12-11 05:06:27.442258 | 2025-12-11 05:06:27.442322 | TASK [Install required packages] 2025-12-11 05:06:28.193255 | controller | ok: Nothing to do 2025-12-11 05:06:28.197996 | 2025-12-11 05:06:28.198057 | TASK [Install venv] 2025-12-11 05:07:30.244360 | controller | changed 2025-12-11 05:07:30.266481 | 2025-12-11 05:07:30.266535 | PLAY RECAP 2025-12-11 05:07:30.266577 | controller | ok: 7 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-12-11 05:07:30.266598 | 2025-12-11 05:07:30.331880 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-12-11 05:07:30.332726 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-12-11 05:07:30.790482 | 2025-12-11 05:07:30.790570 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-12-11 05:07:30.808777 | 2025-12-11 05:07:30.808842 | TASK [Create zuul-output directory] 2025-12-11 05:07:31.090991 | controller | changed 2025-12-11 05:07:31.095517 | 2025-12-11 05:07:31.095585 | TASK [Slurp Zuul inventory test] 2025-12-11 05:07:31.353333 | controller -> localhost | ok 2025-12-11 05:07:31.359786 | 2025-12-11 05:07:31.359852 | TASK [Save zuul inventory] 2025-12-11 05:07:32.067872 | controller | changed 2025-12-11 05:07:32.072799 | 2025-12-11 05:07:32.072884 | TASK [Save zuul vars without the change_message] 2025-12-11 05:07:32.639355 | controller | changed 2025-12-11 05:07:32.655532 | 2025-12-11 05:07:32.655591 | PLAY RECAP 2025-12-11 05:07:32.655690 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-11 05:07:32.655723 | 2025-12-11 05:07:32.725062 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-12-11 05:07:32.725976 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/edpm_build_images/run.yml@main] 2025-12-11 05:07:33.217020 | 2025-12-11 05:07:33.217127 | PLAY [Run ci/playbooks/edpm_build_images/run.yml] 2025-12-11 05:07:33.236149 | 2025-12-11 05:07:33.236222 | TASK [Filter out host if needed] 2025-12-11 05:07:33.245764 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-12-11 05:07:33.250139 | 2025-12-11 05:07:33.250205 | TASK [Run EDPM build image] 2025-12-11 05:07:34.055865 | controller | 2025-12-11 05:07:34.791431 | controller | PLAY [Bootstrap playbook] ****************************************************** 2025-12-11 05:07:34.791485 | controller | 2025-12-11 05:07:34.791493 | controller | TASK [Gathering Facts ] ******************************************************** 2025-12-11 05:07:34.791499 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.029) 0:00:00.029 ***** 2025-12-11 05:07:34.791504 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.028) 0:00:00.028 ***** 2025-12-11 05:07:34.791515 | controller | ok: [localhost] 2025-12-11 05:07:34.814885 | controller | 2025-12-11 05:07:34.814912 | 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-12-11 05:07:34.814925 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.736) 0:00:00.765 ***** 2025-12-11 05:07:34.814932 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.736) 0:00:00.764 ***** 2025-12-11 05:07:34.814942 | controller | ok: [localhost] 2025-12-11 05:07:34.862734 | controller | 2025-12-11 05:07:34.862758 | controller | TASK [cifmw_setup : Get customized parameters ci_framework_params={{ 2025-12-11 05:07:34.862767 | controller | hostvars[inventory_hostname] | 2025-12-11 05:07:34.862776 | controller | dict2items | 2025-12-11 05:07:34.862784 | controller | selectattr("key", "match", 2025-12-11 05:07:34.862790 | controller | "^(cifmw|pre|post)_(?!install_yamls|openshift_token|openshift_login|openshift_kubeconfig).*") | 2025-12-11 05:07:34.862797 | controller | list | items2dict 2025-12-11 05:07:34.862803 | controller | }}] *** 2025-12-11 05:07:34.862809 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.023) 0:00:00.789 ***** 2025-12-11 05:07:34.862815 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.023) 0:00:00.788 ***** 2025-12-11 05:07:34.862825 | controller | ok: [localhost] 2025-12-11 05:07:35.111800 | controller | 2025-12-11 05:07:35.111886 | controller | TASK [install_ca : Ensure target directory exists path={{ cifmw_install_ca_trust_dir }}, state=directory, mode=0755] *** 2025-12-11 05:07:35.111897 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.047) 0:00:00.837 ***** 2025-12-11 05:07:35.111904 | controller | Thursday 11 December 2025 05:07:34 +0000 (0:00:00.047) 0:00:00.836 ***** 2025-12-11 05:07:35.111917 | controller | ok: [localhost] 2025-12-11 05:07:35.130607 | controller | 2025-12-11 05:07:35.130630 | 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-12-11 05:07:35.130639 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.248) 0:00:01.085 ***** 2025-12-11 05:07:35.130645 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.248) 0:00:01.084 ***** 2025-12-11 05:07:35.130661 | controller | skipping: [localhost] 2025-12-11 05:07:35.149605 | controller | 2025-12-11 05:07:35.149628 | 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-12-11 05:07:35.149636 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.019) 0:00:01.105 ***** 2025-12-11 05:07:35.149642 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.019) 0:00:01.103 ***** 2025-12-11 05:07:35.149653 | controller | skipping: [localhost] 2025-12-11 05:07:35.189657 | controller | 2025-12-11 05:07:35.189682 | 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-12-11 05:07:35.189691 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.019) 0:00:01.124 ***** 2025-12-11 05:07:35.189698 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.019) 0:00:01.123 ***** 2025-12-11 05:07:35.189710 | controller | skipping: [localhost] 2025-12-11 05:07:36.292559 | controller | 2025-12-11 05:07:36.292642 | controller | TASK [install_ca : Update ca bundle _raw_params=update-ca-trust] *************** 2025-12-11 05:07:36.292652 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.039) 0:00:01.164 ***** 2025-12-11 05:07:36.292680 | controller | Thursday 11 December 2025 05:07:35 +0000 (0:00:00.039) 0:00:01.163 ***** 2025-12-11 05:07:36.292698 | controller | changed: [localhost] 2025-12-11 05:07:36.783256 | controller | 2025-12-11 05:07:36.783311 | controller | TASK [repo_setup : Ensure directories are present path={{ cifmw_repo_setup_basedir }}/{{ item }}, state=directory, mode=0755] *** 2025-12-11 05:07:36.783320 | controller | Thursday 11 December 2025 05:07:36 +0000 (0:00:01.102) 0:00:02.266 ***** 2025-12-11 05:07:36.783327 | controller | Thursday 11 December 2025 05:07:36 +0000 (0:00:01.102) 0:00:02.265 ***** 2025-12-11 05:07:36.783348 | controller | changed: [localhost] => (item=tmp) 2025-12-11 05:07:37.517815 | controller | changed: [localhost] => (item=artifacts/repositories) 2025-12-11 05:07:37.517860 | controller | changed: [localhost] => (item=venv/repo_setup) 2025-12-11 05:07:37.517868 | controller | 2025-12-11 05:07:37.517875 | controller | TASK [repo_setup : Make sure git-core package is installed name=git-core, state=present] *** 2025-12-11 05:07:37.517881 | controller | Thursday 11 December 2025 05:07:36 +0000 (0:00:00.490) 0:00:02.757 ***** 2025-12-11 05:07:37.517887 | controller | Thursday 11 December 2025 05:07:36 +0000 (0:00:00.490) 0:00:02.756 ***** 2025-12-11 05:07:37.517899 | controller | ok: [localhost] 2025-12-11 05:07:37.868754 | controller | 2025-12-11 05:07:37.868791 | 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-12-11 05:07:37.868800 | controller | Thursday 11 December 2025 05:07:37 +0000 (0:00:00.734) 0:00:03.492 ***** 2025-12-11 05:07:37.868807 | controller | Thursday 11 December 2025 05:07:37 +0000 (0:00:00.734) 0:00:03.490 ***** 2025-12-11 05:07:37.868825 | controller | changed: [localhost] 2025-12-11 05:07:45.342484 | controller | 2025-12-11 05:07:45.342525 | 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-12-11 05:07:45.342536 | controller | Thursday 11 December 2025 05:07:37 +0000 (0:00:00.350) 0:00:03.843 ***** 2025-12-11 05:07:45.342543 | controller | Thursday 11 December 2025 05:07:37 +0000 (0:00:00.350) 0:00:03.841 ***** 2025-12-11 05:07:45.342552 | controller | changed: [localhost] 2025-12-11 05:07:45.901503 | controller | 2025-12-11 05:07:45.901535 | 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-12-11 05:07:45.901546 | controller | Thursday 11 December 2025 05:07:45 +0000 (0:00:07.473) 0:00:11.316 ***** 2025-12-11 05:07:45.901553 | controller | Thursday 11 December 2025 05:07:45 +0000 (0:00:07.473) 0:00:11.315 ***** 2025-12-11 05:07:45.901562 | controller | changed: [localhost] 2025-12-11 05:07:45.920495 | controller | 2025-12-11 05:07:45.920516 | 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-12-11 05:07:45.920524 | controller | Thursday 11 December 2025 05:07:45 +0000 (0:00:00.558) 0:00:11.875 ***** 2025-12-11 05:07:45.920529 | controller | Thursday 11 December 2025 05:07:45 +0000 (0:00:00.558) 0:00:11.874 ***** 2025-12-11 05:07:45.920538 | controller | skipping: [localhost] 2025-12-11 05:07:46.664342 | controller | 2025-12-11 05:07:46.664376 | 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-12-11 05:07:46.664385 | controller | Thursday 11 December 2025 05:07:45 +0000 (0:00:00.019) 0:00:11.895 ***** 2025-12-11 05:07:46.664391 | controller | Thursday 11 December 2025 05:07:45 +0000 (0:00:00.019) 0:00:11.893 ***** 2025-12-11 05:07:46.664407 | controller | changed: [localhost] 2025-12-11 05:07:46.693220 | controller | 2025-12-11 05:07:46.693246 | 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-12-11 05:07:46.693256 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.743) 0:00:12.638 ***** 2025-12-11 05:07:46.693263 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.743) 0:00:12.637 ***** 2025-12-11 05:07:46.693275 | controller | skipping: [localhost] 2025-12-11 05:07:46.720669 | controller | 2025-12-11 05:07:46.720695 | 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-12-11 05:07:46.720704 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.028) 0:00:12.667 ***** 2025-12-11 05:07:46.720711 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.028) 0:00:12.666 ***** 2025-12-11 05:07:46.720721 | controller | skipping: [localhost] 2025-12-11 05:07:46.747477 | controller | 2025-12-11 05:07:46.747499 | 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-12-11 05:07:46.747507 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.027) 0:00:12.695 ***** 2025-12-11 05:07:46.747513 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.027) 0:00:12.694 ***** 2025-12-11 05:07:46.747524 | controller | skipping: [localhost] 2025-12-11 05:07:47.247780 | controller | 2025-12-11 05:07:47.247814 | 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-12-11 05:07:47.247823 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.026) 0:00:12.722 ***** 2025-12-11 05:07:47.247833 | controller | Thursday 11 December 2025 05:07:46 +0000 (0:00:00.026) 0:00:12.720 ***** 2025-12-11 05:07:47.247844 | controller | changed: [localhost] 2025-12-11 05:07:47.759149 | controller | 2025-12-11 05:07:47.759187 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file content={{ _repo_setup_json['full_hash'] }} 2025-12-11 05:07:47.759198 | controller | , dest={{ cifmw_repo_setup_basedir }}/artifacts/repositories/delorean.repo.md5, mode=0644] *** 2025-12-11 05:07:47.759211 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.500) 0:00:13.222 ***** 2025-12-11 05:07:47.759219 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.500) 0:00:13.221 ***** 2025-12-11 05:07:47.759231 | controller | changed: [localhost] 2025-12-11 05:07:47.777198 | controller | 2025-12-11 05:07:47.777218 | 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-12-11 05:07:47.777227 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.511) 0:00:13.733 ***** 2025-12-11 05:07:47.777240 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.511) 0:00:13.732 ***** 2025-12-11 05:07:47.777251 | controller | skipping: [localhost] 2025-12-11 05:07:47.794567 | controller | 2025-12-11 05:07:47.794587 | controller | TASK [repo_setup : Slurp current podified hash src={{ cifmw_repo_setup_basedir }}/artifacts/repositories/delorean.repo.md5] *** 2025-12-11 05:07:47.794594 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.018) 0:00:13.751 ***** 2025-12-11 05:07:47.794599 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.018) 0:00:13.750 ***** 2025-12-11 05:07:47.794608 | controller | skipping: [localhost] 2025-12-11 05:07:47.811205 | controller | 2025-12-11 05:07:47.811222 | controller | TASK [repo_setup : Update the value of full_hash _repo_setup_json={{ _repo_setup_json | combine({'full_hash': _hash}, recursive=true) }}] *** 2025-12-11 05:07:47.811229 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.017) 0:00:13.769 ***** 2025-12-11 05:07:47.811235 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.017) 0:00:13.768 ***** 2025-12-11 05:07:47.811245 | controller | skipping: [localhost] 2025-12-11 05:07:47.837582 | controller | 2025-12-11 05:07:47.837603 | 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-12-11 05:07:47.837611 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.016) 0:00:13.785 ***** 2025-12-11 05:07:47.837616 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.016) 0:00:13.784 ***** 2025-12-11 05:07:47.837625 | controller | ok: [localhost] 2025-12-11 05:07:47.853716 | controller | 2025-12-11 05:07:47.853733 | controller | TASK [repo_setup : Create download directory path={{ cifmw_repo_setup_rhos_release_path }}, state=directory, mode=0755] *** 2025-12-11 05:07:47.853740 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.026) 0:00:13.812 ***** 2025-12-11 05:07:47.853747 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.026) 0:00:13.811 ***** 2025-12-11 05:07:47.853756 | controller | skipping: [localhost] 2025-12-11 05:07:47.868324 | controller | 2025-12-11 05:07:47.868345 | controller | TASK [repo_setup : Print the URL to request msg={{ cifmw_repo_setup_rhos_release_rpm }}] *** 2025-12-11 05:07:47.868352 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.016) 0:00:13.828 ***** 2025-12-11 05:07:47.868358 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.016) 0:00:13.827 ***** 2025-12-11 05:07:47.868367 | controller | skipping: [localhost] 2025-12-11 05:07:47.882560 | controller | 2025-12-11 05:07:47.882583 | controller | TASK [Download the RPM name=krb_request] *************************************** 2025-12-11 05:07:47.882591 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.842 ***** 2025-12-11 05:07:47.882597 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.841 ***** 2025-12-11 05:07:47.882606 | controller | skipping: [localhost] 2025-12-11 05:07:47.897236 | controller | 2025-12-11 05:07:47.897259 | controller | TASK [repo_setup : Install RHOS Release tool name={{ 2025-12-11 05:07:47.897268 | controller | cifmw_repo_setup_rhos_release_rpm 2025-12-11 05:07:47.897274 | controller | if cifmw_repo_setup_rhos_release_rpm is not url 2025-12-11 05:07:47.897280 | controller | else cifmw_krb_request_out.path 2025-12-11 05:07:47.897285 | controller | }}, state=present, disable_gpg_check={{ cifmw_repo_setup_rhos_release_gpg_check | bool }}] *** 2025-12-11 05:07:47.897291 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.857 ***** 2025-12-11 05:07:47.897296 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.855 ***** 2025-12-11 05:07:47.897305 | controller | skipping: [localhost] 2025-12-11 05:07:47.912128 | controller | 2025-12-11 05:07:47.912148 | controller | TASK [repo_setup : Get rhos-release tool version _raw_params=rhos-release --version] *** 2025-12-11 05:07:47.912161 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.871 ***** 2025-12-11 05:07:47.912167 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.870 ***** 2025-12-11 05:07:47.912176 | controller | skipping: [localhost] 2025-12-11 05:07:47.928772 | controller | 2025-12-11 05:07:47.928795 | controller | TASK [repo_setup : Print rhos-release tool version msg={{ rr_version.stdout }}] *** 2025-12-11 05:07:47.928803 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.886 ***** 2025-12-11 05:07:47.928814 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.014) 0:00:13.885 ***** 2025-12-11 05:07:47.928824 | controller | skipping: [localhost] 2025-12-11 05:07:47.944665 | controller | 2025-12-11 05:07:47.944687 | 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-12-11 05:07:47.944696 | controller | -t {{ cifmw_repo_setup_output }}] *** 2025-12-11 05:07:47.944702 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.016) 0:00:13.903 ***** 2025-12-11 05:07:47.944707 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.016) 0:00:13.902 ***** 2025-12-11 05:07:47.944716 | controller | skipping: [localhost] 2025-12-11 05:07:48.090412 | controller | 2025-12-11 05:07:48.090444 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh path=/etc/ci/mirror_info.sh] *** 2025-12-11 05:07:48.090451 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.015) 0:00:13.919 ***** 2025-12-11 05:07:48.090457 | controller | Thursday 11 December 2025 05:07:47 +0000 (0:00:00.015) 0:00:13.918 ***** 2025-12-11 05:07:48.090466 | controller | ok: [localhost] 2025-12-11 05:07:48.260681 | controller | 2025-12-11 05:07:48.260709 | controller | TASK [repo_setup : Use RDO proxy mirrors chdir={{ cifmw_repo_setup_output }}, _raw_params=set -o pipefail 2025-12-11 05:07:48.260717 | controller | source /etc/ci/mirror_info.sh 2025-12-11 05:07:48.260724 | controller | sed -i -e "s|https://trunk.rdoproject.org|$NODEPOOL_RDO_PROXY|g" *.repo 2025-12-11 05:07:48.260729 | controller | ] *** 2025-12-11 05:07:48.260735 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.145) 0:00:14.064 ***** 2025-12-11 05:07:48.260740 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.145) 0:00:14.063 ***** 2025-12-11 05:07:48.260750 | controller | changed: [localhost] 2025-12-11 05:07:48.455493 | controller | 2025-12-11 05:07:48.455522 | 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-12-11 05:07:48.455530 | controller | source /etc/ci/mirror_info.sh 2025-12-11 05:07:48.455536 | controller | sed -i -e "s|http://mirror.stream.centos.org|$NODEPOOL_CENTOS_MIRROR|g" *.repo 2025-12-11 05:07:48.455541 | controller | ] *** 2025-12-11 05:07:48.455546 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.170) 0:00:14.235 ***** 2025-12-11 05:07:48.455551 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.170) 0:00:14.234 ***** 2025-12-11 05:07:48.455560 | controller | changed: [localhost] 2025-12-11 05:07:48.474674 | controller | 2025-12-11 05:07:48.474696 | controller | TASK [repo_setup : Check for gating.repo file on content provider url=http://{{ content_provider_registry_ip }}:8766/gating.repo] *** 2025-12-11 05:07:48.474704 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.194) 0:00:14.429 ***** 2025-12-11 05:07:48.474710 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.194) 0:00:14.428 ***** 2025-12-11 05:07:48.474719 | controller | skipping: [localhost] 2025-12-11 05:07:48.495744 | controller | 2025-12-11 05:07:48.495762 | controller | TASK [repo_setup : Populate gating repo from content provider ip content=[gating-repo] 2025-12-11 05:07:48.495769 | controller | baseurl=http://{{ content_provider_registry_ip }}:8766/ 2025-12-11 05:07:48.495775 | controller | enabled=1 2025-12-11 05:07:48.495780 | controller | gpgcheck=0 2025-12-11 05:07:48.495785 | controller | priority=1 2025-12-11 05:07:48.495790 | controller | , dest={{ cifmw_repo_setup_output }}/gating.repo, mode=0644] *** 2025-12-11 05:07:48.495795 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.019) 0:00:14.449 ***** 2025-12-11 05:07:48.495800 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.019) 0:00:14.448 ***** 2025-12-11 05:07:48.495815 | controller | skipping: [localhost] 2025-12-11 05:07:48.517199 | controller | 2025-12-11 05:07:48.517216 | controller | TASK [repo_setup : Check for DLRN repo at the destination path={{ cifmw_repo_setup_output }}/delorean.repo] *** 2025-12-11 05:07:48.517222 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.470 ***** 2025-12-11 05:07:48.517228 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.469 ***** 2025-12-11 05:07:48.517237 | controller | skipping: [localhost] 2025-12-11 05:07:48.538334 | controller | 2025-12-11 05:07:48.538350 | 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-12-11 05:07:48.538358 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.491 ***** 2025-12-11 05:07:48.538364 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.490 ***** 2025-12-11 05:07:48.538374 | controller | skipping: [localhost] 2025-12-11 05:07:48.559449 | controller | 2025-12-11 05:07:48.559465 | controller | TASK [repo_setup : Check for DLRN component repo path={{ cifmw_repo_setup_output }}/{{ _comp_repo }}] *** 2025-12-11 05:07:48.559472 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.512 ***** 2025-12-11 05:07:48.559479 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.511 ***** 2025-12-11 05:07:48.559488 | controller | skipping: [localhost] 2025-12-11 05:07:48.581540 | controller | 2025-12-11 05:07:48.581555 | 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-12-11 05:07:48.581561 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.534 ***** 2025-12-11 05:07:48.581566 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.532 ***** 2025-12-11 05:07:48.581574 | controller | skipping: [localhost] 2025-12-11 05:07:48.598760 | controller | 2025-12-11 05:07:48.598773 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory paths=/etc/yum.repos.d/, patterns=*.repo, recurse=False] *** 2025-12-11 05:07:48.598779 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.556 ***** 2025-12-11 05:07:48.598784 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.554 ***** 2025-12-11 05:07:48.598792 | controller | skipping: [localhost] 2025-12-11 05:07:48.619931 | controller | 2025-12-11 05:07:48.619956 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory path={{ item }}, state=absent] *** 2025-12-11 05:07:48.619964 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.017) 0:00:14.573 ***** 2025-12-11 05:07:48.619969 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.017) 0:00:14.572 ***** 2025-12-11 05:07:48.619978 | controller | skipping: [localhost] 2025-12-11 05:07:48.636825 | controller | 2025-12-11 05:07:48.636851 | controller | TASK [repo_setup : Cleanup existing metadata _raw_params=dnf clean metadata] *** 2025-12-11 05:07:48.636860 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.594 ***** 2025-12-11 05:07:48.636867 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.021) 0:00:14.593 ***** 2025-12-11 05:07:48.636878 | controller | skipping: [localhost] 2025-12-11 05:07:48.657036 | controller | 2025-12-11 05:07:48.657062 | 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-12-11 05:07:48.657072 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.016) 0:00:14.611 ***** 2025-12-11 05:07:48.657086 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.016) 0:00:14.610 ***** 2025-12-11 05:07:48.657097 | controller | skipping: [localhost] 2025-12-11 05:07:48.688858 | controller | 2025-12-11 05:07:48.688882 | controller | TASK [ci_setup : Gather variables for each operating system _raw_params={{ item }}] *** 2025-12-11 05:07:48.688889 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.020) 0:00:14.631 ***** 2025-12-11 05:07:48.688895 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.020) 0:00:14.630 ***** 2025-12-11 05:07:48.688911 | controller | ok: [localhost] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml) 2025-12-11 05:07:48.706035 | controller | 2025-12-11 05:07:48.706057 | controller | TASK [ci_setup : List packages to install var=cifmw_ci_setup_packages] ********* 2025-12-11 05:07:48.706064 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.031) 0:00:14.663 ***** 2025-12-11 05:07:48.706070 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.031) 0:00:14.662 ***** 2025-12-11 05:07:48.706079 | controller | ok: [localhost] => 2025-12-11 05:08:36.796243 | controller | cifmw_ci_setup_packages: 2025-12-11 05:08:36.796284 | controller | - bash-completion 2025-12-11 05:08:36.796292 | controller | - ca-certificates 2025-12-11 05:08:36.796298 | controller | - git-core 2025-12-11 05:08:36.796304 | controller | - make 2025-12-11 05:08:36.796310 | controller | - tar 2025-12-11 05:08:36.796315 | controller | - tmux 2025-12-11 05:08:36.796320 | controller | - python3-pip 2025-12-11 05:08:36.796326 | controller | 2025-12-11 05:08:36.796332 | controller | TASK [ci_setup : Install needed packages name={{ cifmw_ci_setup_packages }}, state=latest] *** 2025-12-11 05:08:36.796338 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.017) 0:00:14.680 ***** 2025-12-11 05:08:36.796345 | controller | Thursday 11 December 2025 05:07:48 +0000 (0:00:00.017) 0:00:14.679 ***** 2025-12-11 05:08:36.796356 | controller | changed: [localhost] 2025-12-11 05:08:36.953745 | controller | 2025-12-11 05:08:36.953768 | controller | TASK [ci_setup : Gather version of openshift client _raw_params=oc version --client -o yaml] *** 2025-12-11 05:08:36.953775 | controller | Thursday 11 December 2025 05:08:36 +0000 (0:00:48.090) 0:01:02.770 ***** 2025-12-11 05:08:36.953781 | controller | Thursday 11 December 2025 05:08:36 +0000 (0:00:48.090) 0:01:02.769 ***** 2025-12-11 05:08:36.953790 | controller | ok: [localhost] 2025-12-11 05:08:37.111254 | controller | 2025-12-11 05:08:37.111277 | controller | TASK [ci_setup : Ensure openshift client install path is present path={{ cifmw_ci_setup_oc_install_path }}, state=directory, mode=0755] *** 2025-12-11 05:08:37.111285 | controller | Thursday 11 December 2025 05:08:36 +0000 (0:00:00.157) 0:01:02.928 ***** 2025-12-11 05:08:37.111291 | controller | Thursday 11 December 2025 05:08:36 +0000 (0:00:00.157) 0:01:02.927 ***** 2025-12-11 05:08:37.111300 | controller | changed: [localhost] 2025-12-11 05:08:42.835931 | controller | 2025-12-11 05:08:42.835965 | 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-12-11 05:08:42.835977 | controller | Thursday 11 December 2025 05:08:37 +0000 (0:00:00.157) 0:01:03.085 ***** 2025-12-11 05:08:42.835983 | controller | Thursday 11 December 2025 05:08:37 +0000 (0:00:00.157) 0:01:03.084 ***** 2025-12-11 05:08:42.835993 | controller | changed: [localhost] 2025-12-11 05:08:42.858463 | controller | 2025-12-11 05:08:42.858489 | 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-12-11 05:08:42.858497 | controller | Thursday 11 December 2025 05:08:42 +0000 (0:00:05.724) 0:01:08.810 ***** 2025-12-11 05:08:42.858503 | controller | Thursday 11 December 2025 05:08:42 +0000 (0:00:05.724) 0:01:08.809 ***** 2025-12-11 05:08:42.858513 | controller | skipping: [localhost] 2025-12-11 05:08:43.075688 | controller | 2025-12-11 05:08:43.075733 | controller | TASK [ci_setup : Create completion file] *************************************** 2025-12-11 05:08:43.075741 | controller | Thursday 11 December 2025 05:08:42 +0000 (0:00:00.022) 0:01:08.833 ***** 2025-12-11 05:08:43.075747 | controller | Thursday 11 December 2025 05:08:42 +0000 (0:00:00.022) 0:01:08.831 ***** 2025-12-11 05:08:43.075758 | controller | changed: [localhost] 2025-12-11 05:08:43.296961 | controller | 2025-12-11 05:08:43.296994 | 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-12-11 05:08:43.297002 | controller | source ~/.oc_completion 2025-12-11 05:08:43.297014 | controller | fi] *** 2025-12-11 05:08:43.297020 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.217) 0:01:09.050 ***** 2025-12-11 05:08:43.297025 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.217) 0:01:09.048 ***** 2025-12-11 05:08:43.297035 | controller | changed: [localhost] 2025-12-11 05:08:43.312688 | controller | 2025-12-11 05:08:43.312710 | controller | TASK [ci_setup : Check rhsm status _raw_params=subscription-manager status] **** 2025-12-11 05:08:43.312718 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.221) 0:01:09.271 ***** 2025-12-11 05:08:43.312723 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.221) 0:01:09.270 ***** 2025-12-11 05:08:43.312732 | controller | skipping: [localhost] 2025-12-11 05:08:43.328377 | controller | 2025-12-11 05:08:43.328396 | controller | TASK [ci_setup : Gather the repos to be enabled _repos={{ 2025-12-11 05:08:43.328403 | controller | cifmw_ci_setup_rhel_rhsm_default_repos + 2025-12-11 05:08:43.328409 | controller | (cifmw_ci_setup_rhel_rhsm_extra_repos | default([])) 2025-12-11 05:08:43.328426 | controller | }}] *** 2025-12-11 05:08:43.328434 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.287 ***** 2025-12-11 05:08:43.328439 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.286 ***** 2025-12-11 05:08:43.328457 | controller | skipping: [localhost] 2025-12-11 05:08:43.344068 | controller | 2025-12-11 05:08:43.344087 | controller | TASK [ci_setup : Enabling the required repositories. name={{ item }}, state={{ rhsm_repo_state | default('enabled') }}] *** 2025-12-11 05:08:43.344093 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.302 ***** 2025-12-11 05:08:43.344099 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.301 ***** 2025-12-11 05:08:43.344107 | controller | skipping: [localhost] 2025-12-11 05:08:43.359735 | controller | 2025-12-11 05:08:43.359754 | controller | TASK [ci_setup : Get current /etc/redhat-release _raw_params=cat /etc/redhat-release] *** 2025-12-11 05:08:43.359766 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.318 ***** 2025-12-11 05:08:43.359772 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.317 ***** 2025-12-11 05:08:43.359781 | controller | skipping: [localhost] 2025-12-11 05:08:43.375358 | controller | 2025-12-11 05:08:43.375380 | controller | TASK [ci_setup : Print current /etc/redhat-release msg={{ _current_rh_release.stdout }}] *** 2025-12-11 05:08:43.375388 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.334 ***** 2025-12-11 05:08:43.375393 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.333 ***** 2025-12-11 05:08:43.375401 | controller | skipping: [localhost] 2025-12-11 05:08:43.394954 | controller | 2025-12-11 05:08:43.394973 | 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-12-11 05:08:43.394981 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.349 ***** 2025-12-11 05:08:43.394987 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.015) 0:01:09.348 ***** 2025-12-11 05:08:43.394995 | controller | skipping: [localhost] 2025-12-11 05:08:44.163959 | controller | 2025-12-11 05:08:44.163992 | controller | TASK [ci_setup : Manage directories path={{ item }}, state={{ directory_state }}, mode=0755, owner={{ ansible_user_id }}, group={{ ansible_user_id }}] *** 2025-12-11 05:08:44.164000 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.019) 0:01:09.369 ***** 2025-12-11 05:08:44.164006 | controller | Thursday 11 December 2025 05:08:43 +0000 (0:00:00.019) 0:01:09.368 ***** 2025-12-11 05:08:44.164016 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr) 2025-12-11 05:08:44.484021 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/logs) 2025-12-11 05:08:44.484054 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/tmp) 2025-12-11 05:08:44.484061 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/volumes) 2025-12-11 05:08:44.484067 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/parameters) 2025-12-11 05:08:44.484078 | controller | 2025-12-11 05:08:44.484084 | 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-12-11 05:08:44.484090 | controller | Thursday 11 December 2025 05:08:44 +0000 (0:00:00.768) 0:01:10.138 ***** 2025-12-11 05:08:44.484095 | controller | Thursday 11 December 2025 05:08:44 +0000 (0:00:00.768) 0:01:10.137 ***** 2025-12-11 05:08:44.484105 | controller | changed: [localhost] 2025-12-11 05:08:45.111752 | controller | 2025-12-11 05:08:45.111796 | controller | PLAY [Run ci/playbooks/edpm_build_images/edpm_image_builder.yml] *************** 2025-12-11 05:08:45.111805 | controller | 2025-12-11 05:08:45.111818 | controller | TASK [Gathering Facts ] ******************************************************** 2025-12-11 05:08:45.111824 | controller | Thursday 11 December 2025 05:08:44 +0000 (0:00:00.320) 0:01:10.458 ***** 2025-12-11 05:08:45.111830 | controller | Thursday 11 December 2025 05:08:44 +0000 (0:00:00.320) 0:01:10.457 ***** 2025-12-11 05:08:45.111841 | controller | ok: [controller] 2025-12-11 05:08:45.370174 | controller | 2025-12-11 05:08:45.370216 | controller | TASK [Read hash from delorean.repo.md5 file path={{ cifmw_basedir }}/artifacts/repositories/delorean.repo.md5] *** 2025-12-11 05:08:45.370224 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.627) 0:01:11.086 ***** 2025-12-11 05:08:45.370230 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.627) 0:01:11.085 ***** 2025-12-11 05:08:45.370242 | controller | ok: [controller] 2025-12-11 05:08:45.392760 | controller | 2025-12-11 05:08:45.392792 | controller | TASK [Set fact for cifmw_edpm_build_images_tag var cifmw_edpm_build_images_tag={{ file_content['content'] | b64decode | string | trim }}] *** 2025-12-11 05:08:45.392801 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.258) 0:01:11.344 ***** 2025-12-11 05:08:45.392807 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.258) 0:01:11.343 ***** 2025-12-11 05:08:45.392819 | controller | ok: [controller] 2025-12-11 05:08:45.414613 | controller | 2025-12-11 05:08:45.414637 | 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-12-11 05:08:45.414645 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.022) 0:01:11.367 ***** 2025-12-11 05:08:45.414651 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.022) 0:01:11.366 ***** 2025-12-11 05:08:45.414661 | controller | ok: [controller] 2025-12-11 05:10:28.316647 | controller | 2025-12-11 05:10:28.316680 | controller | TASK [edpm_build_images : Install required packages name={{ cifmw_edpm_build_images_host_packages }}, state=latest] *** 2025-12-11 05:10:28.316688 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.021) 0:01:11.389 ***** 2025-12-11 05:10:28.316694 | controller | Thursday 11 December 2025 05:08:45 +0000 (0:00:00.021) 0:01:11.388 ***** 2025-12-11 05:10:28.316704 | controller | changed: [controller] 2025-12-11 05:10:28.469110 | controller | 2025-12-11 05:10:28.469141 | controller | TASK [edpm_build_images : Ensure logs/edpm_images directory path={{ cifmw_edpm_build_images_basedir }}/logs/edpm_images, state=directory, mode=0755] *** 2025-12-11 05:10:28.469149 | controller | Thursday 11 December 2025 05:10:28 +0000 (0:01:42.902) 0:02:54.291 ***** 2025-12-11 05:10:28.469155 | controller | Thursday 11 December 2025 05:10:28 +0000 (0:01:42.902) 0:02:54.290 ***** 2025-12-11 05:10:28.469165 | controller | changed: [controller] 2025-12-11 05:10:30.256874 | controller | 2025-12-11 05:10:30.256910 | 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-12-11 05:10:30.256918 | controller | Thursday 11 December 2025 05:10:28 +0000 (0:00:00.152) 0:02:54.443 ***** 2025-12-11 05:10:30.256924 | controller | Thursday 11 December 2025 05:10:28 +0000 (0:00:00.152) 0:02:54.442 ***** 2025-12-11 05:10:30.256935 | controller | changed: [controller] 2025-12-11 05:10:30.286127 | controller | 2025-12-11 05:10:30.286168 | 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-12-11 05:10:30.286181 | controller | Thursday 11 December 2025 05:10:30 +0000 (0:00:01.787) 0:02:56.231 ***** 2025-12-11 05:10:30.286192 | controller | Thursday 11 December 2025 05:10:30 +0000 (0:00:01.787) 0:02:56.230 ***** 2025-12-11 05:10:30.286207 | controller | ok: [controller] 2025-12-11 05:10:50.133629 | controller | 2025-12-11 05:10:50.133664 | 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-12-11 05:10:50.133673 | controller | Thursday 11 December 2025 05:10:30 +0000 (0:00:00.029) 0:02:56.260 ***** 2025-12-11 05:10:50.133684 | controller | Thursday 11 December 2025 05:10:30 +0000 (0:00:00.029) 0:02:56.259 ***** 2025-12-11 05:10:50.133694 | controller | changed: [controller] 2025-12-11 05:10:50.149777 | controller | 2025-12-11 05:10:50.149799 | controller | TASK [edpm_build_images : Check if cert exits path={{ cifmw_edpm_build_images_cert_path }}] *** 2025-12-11 05:10:50.149808 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:19.847) 0:03:16.108 ***** 2025-12-11 05:10:50.149814 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:19.847) 0:03:16.106 ***** 2025-12-11 05:10:50.149824 | controller | skipping: [controller] 2025-12-11 05:10:50.165987 | controller | 2025-12-11 05:10:50.166006 | 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-12-11 05:10:50.166014 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.016) 0:03:16.124 ***** 2025-12-11 05:10:50.166020 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.016) 0:03:16.123 ***** 2025-12-11 05:10:50.166028 | controller | skipping: [controller] 2025-12-11 05:10:50.181651 | controller | 2025-12-11 05:10:50.181670 | controller | TASK [edpm_build_images : Dump the certificates dest={{ _cifmw_edpm_build_images_cert_source }}, content={{ _cifmw_edpm_build_images_certs.certs | join(' 2025-12-11 05:10:50.181678 | controller | ') }}, mode=0644] *** 2025-12-11 05:10:50.181683 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.016) 0:03:16.140 ***** 2025-12-11 05:10:50.181688 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.016) 0:03:16.139 ***** 2025-12-11 05:10:50.181697 | controller | skipping: [controller] 2025-12-11 05:10:50.197548 | controller | 2025-12-11 05:10:50.197567 | controller | TASK [edpm_build_images : Install libguestfs packages name=['libguestfs', 'libguestfs-tools', 'libguestfs-tools-c'], state=present] *** 2025-12-11 05:10:50.197584 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.015) 0:03:16.156 ***** 2025-12-11 05:10:50.197590 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.015) 0:03:16.155 ***** 2025-12-11 05:10:50.197599 | controller | skipping: [controller] 2025-12-11 05:10:50.213459 | controller | 2025-12-11 05:10:50.213481 | 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-12-11 05:10:50.213489 | controller | ] *** 2025-12-11 05:10:50.213495 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.015) 0:03:16.172 ***** 2025-12-11 05:10:50.213501 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.015) 0:03:16.171 ***** 2025-12-11 05:10:50.213510 | controller | skipping: [controller] 2025-12-11 05:17:26.315244 | controller | 2025-12-11 05:17:26.315587 | 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-12-11 05:17:26.315611 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.015) 0:03:16.188 ***** 2025-12-11 05:17:26.315627 | controller | Thursday 11 December 2025 05:10:50 +0000 (0:00:00.015) 0:03:16.186 ***** 2025-12-11 05:17:26.315638 | controller | changed: [controller] 2025-12-11 05:19:54.984243 | controller | 2025-12-11 05:19:54.984598 | 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-12-11 05:19:54.984614 | controller | Thursday 11 December 2025 05:17:26 +0000 (0:06:36.101) 0:09:52.289 ***** 2025-12-11 05:19:54.984621 | controller | Thursday 11 December 2025 05:17:26 +0000 (0:06:36.101) 0:09:52.288 ***** 2025-12-11 05:19:54.984632 | controller | changed: [controller] 2025-12-11 05:20:05.366383 | controller | 2025-12-11 05:20:05.366783 | 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-12-11 05:20:05.366798 | controller | Thursday 11 December 2025 05:19:54 +0000 (0:02:28.668) 0:12:20.958 ***** 2025-12-11 05:20:05.366805 | controller | Thursday 11 December 2025 05:19:54 +0000 (0:02:28.668) 0:12:20.957 ***** 2025-12-11 05:20:05.366817 | controller | changed: [controller] 2025-12-11 05:20:10.814055 | controller | 2025-12-11 05:20:10.814095 | 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-12-11 05:20:10.814104 | controller | Thursday 11 December 2025 05:20:05 +0000 (0:00:10.382) 0:12:31.340 ***** 2025-12-11 05:20:10.814110 | controller | Thursday 11 December 2025 05:20:05 +0000 (0:00:10.382) 0:12:31.339 ***** 2025-12-11 05:20:10.814121 | controller | changed: [controller] 2025-12-11 05:20:43.540729 | controller | 2025-12-11 05:20:43.540792 | controller | TASK [edpm_build_images : Push images to registry with tag 2e38c527ddf6e767040136ecf014e7b9 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-12-11 05:20:43.540802 | controller | Thursday 11 December 2025 05:20:10 +0000 (0:00:05.447) 0:12:36.788 ***** 2025-12-11 05:20:43.540808 | controller | Thursday 11 December 2025 05:20:10 +0000 (0:00:05.447) 0:12:36.787 ***** 2025-12-11 05:20:43.540819 | controller | changed: [controller] => (item=edpm-hardened-uefi) 2025-12-11 05:20:43.997495 | controller | changed: [controller] => (item=ironic-python-agent) 2025-12-11 05:20:43.997535 | controller | 2025-12-11 05:20:43.997543 | 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-12-11 05:20:43.997549 | controller | Thursday 11 December 2025 05:20:43 +0000 (0:00:32.726) 0:13:09.515 ***** 2025-12-11 05:20:43.997563 | controller | Thursday 11 December 2025 05:20:43 +0000 (0:00:32.726) 0:13:09.513 ***** 2025-12-11 05:20:43.997574 | controller | changed: [controller] => (item=edpm-hardened-uefi) 2025-12-11 05:20:47.740741 | controller | changed: [controller] => (item=ironic-python-agent) 2025-12-11 05:20:47.740775 | controller | 2025-12-11 05:20:47.740790 | 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-12-11 05:20:47.740797 | controller | Thursday 11 December 2025 05:20:43 +0000 (0:00:00.456) 0:13:09.971 ***** 2025-12-11 05:20:47.740803 | controller | Thursday 11 December 2025 05:20:43 +0000 (0:00:00.456) 0:13:09.970 ***** 2025-12-11 05:20:47.740813 | controller | changed: [controller] => (item=edpm-hardened-uefi) 2025-12-11 05:20:47.944505 | controller | changed: [controller] => (item=ironic-python-agent) 2025-12-11 05:20:47.944538 | controller | 2025-12-11 05:20:47.944546 | 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-12-11 05:20:47.944553 | controller | Thursday 11 December 2025 05:20:47 +0000 (0:00:03.743) 0:13:13.715 ***** 2025-12-11 05:20:47.944559 | controller | Thursday 11 December 2025 05:20:47 +0000 (0:00:03.743) 0:13:13.714 ***** 2025-12-11 05:20:47.944568 | controller | changed: [controller] 2025-12-11 05:20:47.998180 | controller | 2025-12-11 05:20:47.998234 | controller | PLAY RECAP ********************************************************************* 2025-12-11 05:20:47.998243 | controller | controller : ok=17 changed=12 unreachable=0 failed=0 skipped=5 rescued=0 ignored=0 2025-12-11 05:20:47.998249 | controller | localhost : ok=27 changed=17 unreachable=0 failed=0 skipped=34 rescued=0 ignored=0 2025-12-11 05:20:47.998254 | controller | 2025-12-11 05:20:47.998259 | controller | Thursday 11 December 2025 05:20:47 +0000 (0:00:00.203) 0:13:13.918 ***** 2025-12-11 05:20:47.998264 | controller | =============================================================================== 2025-12-11 05:20:47.998269 | controller | edpm_build_images : Build EDPM hardened uefi image -------------------- 396.10s 2025-12-11 05:20:47.998279 | controller | edpm_build_images : Build ironic-python-agent image ------------------- 148.67s 2025-12-11 05:20:47.998284 | controller | edpm_build_images : Install required packages ------------------------- 102.90s 2025-12-11 05:20:47.998290 | controller | ci_setup : Install needed packages ------------------------------------- 48.09s 2025-12-11 05:20:47.998295 | controller | edpm_build_images : Push images to registry with tag 2e38c527ddf6e767040136ecf014e7b9 -- 32.73s 2025-12-11 05:20:47.998300 | controller | edpm_build_images : Download TripleO source image ---------------------- 19.85s 2025-12-11 05:20:47.998305 | controller | edpm_build_images : Package edpm-hardened-uefi image inside container image -- 10.38s 2025-12-11 05:20:47.998310 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.47s 2025-12-11 05:20:47.998314 | controller | ci_setup : Install openshift client ------------------------------------- 5.72s 2025-12-11 05:20:47.998319 | controller | edpm_build_images : Package ironic-python-agent image inside container image --- 5.45s 2025-12-11 05:20:47.998324 | controller | edpm_build_images : Push images to registry with podified-ci-testing tag --- 3.74s 2025-12-11 05:20:47.998329 | controller | discover_latest_image : Get latest image -------------------------------- 1.79s 2025-12-11 05:20:47.998334 | controller | install_ca : Update ca bundle ------------------------------------------- 1.10s 2025-12-11 05:20:47.998339 | controller | ci_setup : Manage directories ------------------------------------------- 0.77s 2025-12-11 05:20:47.998344 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.74s 2025-12-11 05:20:47.998349 | controller | Gathering Facts --------------------------------------------------------- 0.74s 2025-12-11 05:20:47.998354 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.73s 2025-12-11 05:20:47.998365 | controller | Gathering Facts --------------------------------------------------------- 0.63s 2025-12-11 05:20:47.998370 | controller | repo_setup : Install repo-setup package --------------------------------- 0.56s 2025-12-11 05:20:47.998375 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.51s 2025-12-11 05:20:47.998380 | controller | Thursday 11 December 2025 05:20:47 +0000 (0:00:00.203) 0:13:13.918 ***** 2025-12-11 05:20:47.998385 | controller | =============================================================================== 2025-12-11 05:20:47.998390 | controller | edpm_build_images ----------------------------------------------------- 720.73s 2025-12-11 05:20:47.998395 | controller | ci_setup --------------------------------------------------------------- 55.51s 2025-12-11 05:20:47.998400 | controller | repo_setup ------------------------------------------------------------- 12.36s 2025-12-11 05:20:47.998405 | controller | discover_latest_image --------------------------------------------------- 1.82s 2025-12-11 05:20:47.998409 | controller | install_ca -------------------------------------------------------------- 1.43s 2025-12-11 05:20:47.998453 | controller | gather_facts ------------------------------------------------------------ 1.36s 2025-12-11 05:20:47.998458 | controller | cifmw_setup ------------------------------------------------------------- 0.39s 2025-12-11 05:20:47.998463 | controller | ansible.builtin.slurp --------------------------------------------------- 0.26s 2025-12-11 05:20:47.998468 | controller | ansible.builtin.set_fact ------------------------------------------------ 0.02s 2025-12-11 05:20:47.998473 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~ 2025-12-11 05:20:47.998478 | controller | total ----------------------------------------------------------------- 793.89s 2025-12-11 05:20:48.148830 | controller | changed 2025-12-11 05:20:48.167531 | 2025-12-11 05:20:48.167587 | PLAY RECAP 2025-12-11 05:20:48.167625 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-11 05:20:48.167690 | 2025-12-11 05:20:48.222039 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/edpm_build_images/run.yml@main] 2025-12-11 05:20:48.222912 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-12-11 05:20:48.699462 | 2025-12-11 05:20:48.699553 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-12-11 05:20:48.717523 | 2025-12-11 05:20:48.717613 | TASK [Filter out host if needed] 2025-12-11 05:20:48.726921 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-12-11 05:20:48.730977 | 2025-12-11 05:20:48.731037 | TASK [Ensure file is present] 2025-12-11 05:20:49.023734 | controller | ok 2025-12-11 05:20:49.028586 | 2025-12-11 05:20:49.028671 | TASK [Manage molecule report file] 2025-12-11 05:20:49.552552 | controller | skipping: Conditional result was False 2025-12-11 05:20:49.557138 | 2025-12-11 05:20:49.557199 | TASK [Check if we get ci-framework-data basedir] 2025-12-11 05:20:49.737565 | controller | ok 2025-12-11 05:20:49.742284 | 2025-12-11 05:20:49.742346 | TASK [Create ci-framework-data log directory for zuul] 2025-12-11 05:20:50.023966 | controller | changed 2025-12-11 05:20:50.028841 | 2025-12-11 05:20:50.028900 | TASK [Copy ci-framework interesting files] 2025-12-11 05:20:50.320864 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-12-11 05:20:50.553048 | controller | changed 2025-12-11 05:20:50.557935 | 2025-12-11 05:20:50.558001 | TASK [Get SELinux listing] 2025-12-11 05:20:51.082715 | controller | changed 2025-12-11 05:20:51.088191 | 2025-12-11 05:20:51.088256 | TASK [Generate log index] 2025-12-11 05:20:51.868322 | controller | changed 2025-12-11 05:20:51.872931 | 2025-12-11 05:20:51.872990 | TASK [Get some env related data] 2025-12-11 05:20:52.574542 | controller | /home/zuul/.local/bin/ansible 2025-12-11 05:20:53.400415 | controller | changed 2025-12-11 05:20:53.404817 | 2025-12-11 05:20:53.404874 | TASK [Generate list of logs to collect in home directory] 2025-12-11 05:20:53.706669 | controller | ok: All paths examined 2025-12-11 05:20:53.711380 | 2025-12-11 05:20:53.711440 | LOOP [Copy logs from home directory] 2025-12-11 05:20:54.117178 | controller | changed: 2025-12-11 05:20:54.117288 | controller | { 2025-12-11 05:20:54.117316 | controller | "atime": 1765429634.6229384, 2025-12-11 05:20:54.117335 | controller | "ctime": 1765430447.9424775, 2025-12-11 05:20:54.117351 | controller | "dev": 64513, 2025-12-11 05:20:54.117367 | controller | "gid": 1000, 2025-12-11 05:20:54.117383 | controller | "gr_name": "zuul", 2025-12-11 05:20:54.117399 | controller | "inode": 4330861, 2025-12-11 05:20:54.117414 | controller | "isblk": false, 2025-12-11 05:20:54.117429 | controller | "ischr": false, 2025-12-11 05:20:54.117444 | controller | "isdir": false, 2025-12-11 05:20:54.117458 | controller | "isfifo": false, 2025-12-11 05:20:54.117473 | controller | "isgid": false, 2025-12-11 05:20:54.117487 | controller | "islnk": false, 2025-12-11 05:20:54.117500 | controller | "isreg": true, 2025-12-11 05:20:54.117514 | controller | "issock": false, 2025-12-11 05:20:54.117527 | controller | "isuid": false, 2025-12-11 05:20:54.117541 | controller | "mode": "0644", 2025-12-11 05:20:54.117554 | controller | "mtime": 1765430447.9424775, 2025-12-11 05:20:54.117567 | controller | "nlink": 1, 2025-12-11 05:20:54.117581 | controller | "path": "/home/zuul/ansible.log", 2025-12-11 05:20:54.117596 | controller | "pw_name": "zuul", 2025-12-11 05:20:54.117610 | controller | "rgrp": true, 2025-12-11 05:20:54.117624 | controller | "roth": true, 2025-12-11 05:20:54.117638 | controller | "rusr": true, 2025-12-11 05:20:54.117691 | controller | "size": 62427, 2025-12-11 05:20:54.117709 | controller | "uid": 1000, 2025-12-11 05:20:54.117725 | controller | "wgrp": false, 2025-12-11 05:20:54.117741 | controller | "woth": false, 2025-12-11 05:20:54.117758 | controller | "wusr": true, 2025-12-11 05:20:54.117774 | controller | "xgrp": false, 2025-12-11 05:20:54.117788 | controller | "xoth": false, 2025-12-11 05:20:54.117802 | controller | "xusr": false 2025-12-11 05:20:54.117817 | controller | } 2025-12-11 05:20:54.130710 | 2025-12-11 05:20:54.130803 | TASK [Copy crio stats log file] 2025-12-11 05:20:54.143832 | controller | skipping: Conditional result was False 2025-12-11 05:20:54.149371 | 2025-12-11 05:20:54.149435 | TASK [Get SELinux related data] 2025-12-11 05:20:54.388071 | controller | 2025-12-11 05:20:54.675388 | controller | ERROR 2025-12-11 05:20:54.675504 | controller | { 2025-12-11 05:20:54.675537 | controller | "delta": "0:00:00.010936", 2025-12-11 05:20:54.675561 | controller | "end": "2025-12-11 05:20:54.388888", 2025-12-11 05:20:54.675580 | controller | "msg": "non-zero return code", 2025-12-11 05:20:54.675604 | controller | "rc": 1, 2025-12-11 05:20:54.675621 | controller | "start": "2025-12-11 05:20:54.377952" 2025-12-11 05:20:54.675649 | controller | } 2025-12-11 05:20:54.675699 | controller | ERROR: Ignoring Errors 2025-12-11 05:20:54.680314 | 2025-12-11 05:20:54.680373 | TASK [Create system configuration directory] 2025-12-11 05:20:54.880380 | controller | changed 2025-12-11 05:20:54.885075 | 2025-12-11 05:20:54.885137 | TASK [Get some of the system configurations] 2025-12-11 05:20:55.408847 | controller | changed 2025-12-11 05:20:55.413457 | 2025-12-11 05:20:55.413520 | TASK [Copy generated documentation if available] 2025-12-11 05:20:55.426197 | controller | skipping: Conditional result was False 2025-12-11 05:20:55.431207 | 2025-12-11 05:20:55.431272 | TASK [Copy generated AsciiDoc documentation if available] 2025-12-11 05:20:55.443842 | controller | skipping: Conditional result was False 2025-12-11 05:20:55.448674 | 2025-12-11 05:20:55.448732 | TASK [Compress logs bigger than 2MB] 2025-12-11 05:20:55.978450 | controller | changed 2025-12-11 05:20:55.983330 | 2025-12-11 05:20:55.983387 | TASK [Copy files from workspace on node] 2025-12-11 05:20:56.001862 | controller | ok 2025-12-11 05:20:56.021522 | 2025-12-11 05:20:56.021590 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-11 05:20:56.034919 | controller | skipping: Conditional result was False 2025-12-11 05:20:56.040142 | 2025-12-11 05:20:56.040206 | TASK [fetch-output : Set log path for single node] 2025-12-11 05:20:56.068453 | controller | ok 2025-12-11 05:20:56.072863 | 2025-12-11 05:20:56.072926 | LOOP [fetch-output : Ensure local output dirs] 2025-12-11 05:20:56.254421 | controller -> localhost | ok: "/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/logs" 2025-12-11 05:20:56.254669 | controller -> localhost | changed: All items complete 2025-12-11 05:20:56.254705 | 2025-12-11 05:20:56.423134 | controller -> localhost | changed: "/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/artifacts" 2025-12-11 05:20:56.588387 | controller -> localhost | changed: "/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/docs" 2025-12-11 05:20:56.600568 | 2025-12-11 05:20:56.600693 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-11 05:20:57.201137 | controller | changed: 2025-12-11 05:20:57.201298 | controller | .d..t...... ./ 2025-12-11 05:20:57.201325 | controller | >f+++++++++ README.html 2025-12-11 05:20:57.201346 | controller | >f+++++++++ ansible.log 2025-12-11 05:20:57.201366 | controller | >f+++++++++ dmesg.log 2025-12-11 05:20:57.201386 | controller | >f+++++++++ installed-pkgs.log 2025-12-11 05:20:57.201403 | controller | >f+++++++++ python.log 2025-12-11 05:20:57.201422 | controller | >f+++++++++ registries.conf 2025-12-11 05:20:57.201440 | controller | >f+++++++++ selinux-denials.log 2025-12-11 05:20:57.201456 | controller | >f+++++++++ selinux-listing.log 2025-12-11 05:20:57.201474 | controller | cd+++++++++ ci-framework-data/ 2025-12-11 05:20:57.201491 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-12-11 05:20:57.201508 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-12-11 05:20:57.201524 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/ 2025-12-11 05:20:57.201540 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/ 2025-12-11 05:20:57.201556 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/ 2025-12-11 05:20:57.201572 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-12-11 05:20:57.201587 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/custom-params.yml 2025-12-11 05:20:57.201602 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-12-11 05:20:57.201617 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/ 2025-12-11 05:20:57.201632 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5 2025-12-11 05:20:57.201681 | controller | cd+++++++++ ci-framework-data/logs/ 2025-12-11 05:20:57.201707 | controller | >f+++++++++ ci-framework-data/logs/containers-built.log 2025-12-11 05:20:57.201725 | controller | cd+++++++++ ci-framework-data/logs/edpm_images/ 2025-12-11 05:20:57.201742 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/edpm_hardened_uefi_container_package.log 2025-12-11 05:20:57.201758 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/edpm_hardened_uefi_image_build.log 2025-12-11 05:20:57.201774 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/edpm_hardened_uefi_image_build_err.log 2025-12-11 05:20:57.201790 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/ironic_python_agent_container_package.log 2025-12-11 05:20:57.201806 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/ironic_python_agent_image_build.log 2025-12-11 05:20:57.201822 | controller | >f+++++++++ ci-framework-data/logs/edpm_images/ironic_python_agent_image_build_err.log 2025-12-11 05:20:57.201837 | controller | cd+++++++++ registries.conf.d/ 2025-12-11 05:20:57.201853 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-12-11 05:20:57.201939 | controller | cd+++++++++ system-config/ 2025-12-11 05:20:57.201964 | controller | cd+++++++++ system-config/libvirt/ 2025-12-11 05:20:57.201982 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-12-11 05:20:57.201999 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-12-11 05:20:57.202015 | controller | >f+++++++++ system-config/libvirt/network.conf 2025-12-11 05:20:57.202030 | controller | >f+++++++++ system-config/libvirt/qemu-lockd.conf 2025-12-11 05:20:57.202045 | controller | >f+++++++++ system-config/libvirt/qemu.conf 2025-12-11 05:20:57.202060 | controller | >f+++++++++ system-config/libvirt/virtlogd.conf 2025-12-11 05:20:57.202075 | controller | >f+++++++++ system-config/libvirt/virtnetworkd.conf 2025-12-11 05:20:57.202091 | controller | >f+++++++++ system-config/libvirt/virtqemud.conf 2025-12-11 05:20:57.202106 | controller | >f+++++++++ system-config/libvirt/virtsecretd.conf 2025-12-11 05:20:57.202120 | controller | >f+++++++++ system-config/libvirt/virtstoraged.conf 2025-12-11 05:20:57.584239 | controller | changed: .d..t...... ./ 2025-12-11 05:20:57.951368 | controller | changed: .d..t...... ./ 2025-12-11 05:20:57.970118 | 2025-12-11 05:20:57.970180 | TASK [Return artifact to Zuul] 2025-12-11 05:20:57.984160 | controller | skipping: Conditional result was False 2025-12-11 05:20:58.004650 | 2025-12-11 05:20:58.004729 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-12-11 05:20:58.004816 | 2025-12-11 05:20:58.004841 | PLAY RECAP 2025-12-11 05:20:58.004875 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-12-11 05:20:58.004894 | 2025-12-11 05:20:58.073128 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-12-11 05:20:58.074024 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-12-11 05:20:58.536185 | 2025-12-11 05:20:58.536275 | PLAY [Report DLRN results after job run] 2025-12-11 05:20:58.555892 | 2025-12-11 05:20:58.555965 | TASK [Report job status to DLRN] 2025-12-11 05:20:58.574029 | controller | ok 2025-12-11 05:20:58.595235 | 2025-12-11 05:20:58.595310 | TASK [dlrn_report : Warning if DLRN is not running] 2025-12-11 05:20:58.628895 | controller | skipping: Conditional result was False 2025-12-11 05:20:58.634091 | 2025-12-11 05:20:58.634154 | TASK [dlrn_report : Install dlrnapi-client shyaml package] 2025-12-11 05:21:00.786303 | controller | changed 2025-12-11 05:21:00.791476 | 2025-12-11 05:21:00.791539 | TASK [dlrn_report : Install kinit related package] 2025-12-11 05:21:00.835509 | controller | skipping: Conditional result was False 2025-12-11 05:21:00.840666 | 2025-12-11 05:21:00.840732 | TASK [dlrn_report : Install dlrn kerberos related packages] 2025-12-11 05:21:00.883881 | controller | skipping: Conditional result was False 2025-12-11 05:21:00.888997 | 2025-12-11 05:21:00.889060 | TASK [Set zuul-log-path fact] 2025-12-11 05:21:00.936918 | controller | ok 2025-12-11 05:21:00.952485 | 2025-12-11 05:21:00.952550 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 05:21:01.001046 | controller | ok 2025-12-11 05:21:01.009586 | 2025-12-11 05:21:01.009671 | TASK [dlrn_report : Set the the value of cifmw_repo_setup_promotion when multiple dlrn tags are used] 2025-12-11 05:21:01.053094 | controller | skipping: Conditional result was False 2025-12-11 05:21:01.058188 | 2025-12-11 05:21:01.058249 | TASK [Get hash related data from repo_setup role] 2025-12-11 05:21:01.107010 | controller | ok 2025-12-11 05:21:01.200061 | 2025-12-11 05:21:01.200145 | LOOP [repo_setup : Ensure directories are present] 2025-12-11 05:21:01.512587 | controller | ok: "tmp" 2025-12-11 05:21:01.726670 | controller | ok: "artifacts/repositories" 2025-12-11 05:21:01.940559 | controller | ok: "venv/repo_setup" 2025-12-11 05:21:01.949217 | 2025-12-11 05:21:01.949318 | TASK [repo_setup : Make sure git-core package is installed] 2025-12-11 05:21:03.348767 | controller | ok: Nothing to do 2025-12-11 05:21:03.353862 | 2025-12-11 05:21:03.353924 | TASK [repo_setup : Get repo-setup repository] 2025-12-11 05:21:03.757960 | controller | ok 2025-12-11 05:21:03.762895 | 2025-12-11 05:21:03.762953 | TASK [repo_setup : Initialize python venv and install requirements] 2025-12-11 05:21:05.041413 | controller | ok 2025-12-11 05:21:05.047015 | 2025-12-11 05:21:05.047079 | TASK [repo_setup : Install repo-setup package] 2025-12-11 05:21:15.586318 | controller | ok: Did not run command since '/home/zuul/ci-framework-data/venv/repo-setup/bin/repo-setup' exists 2025-12-11 05:21:15.591813 | 2025-12-11 05:21:15.591877 | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] 2025-12-11 05:21:15.635396 | controller | skipping: Conditional result was False 2025-12-11 05:21:15.640438 | 2025-12-11 05:21:15.640504 | TASK [repo_setup : Run repo-setup] 2025-12-11 05:21:16.532155 | controller | Cache was expired 2025-12-11 05:21:16.573769 | controller | 189 files removed 2025-12-11 05:21:16.619070 | controller | Removed old repo "/etc/yum.repos.d/delorean.repo" 2025-12-11 05:21:16.635517 | controller | Removed old repo "/etc/yum.repos.d/delorean-master-testing.repo" 2025-12-11 05:21:16.635548 | controller | Removed old repo "/etc/yum.repos.d/repo-setup-centos-highavailability.repo" 2025-12-11 05:21:16.635557 | controller | Removed old repo "/etc/yum.repos.d/repo-setup-centos-powertools.repo" 2025-12-11 05:21:16.635564 | controller | Installed repo delorean to /etc/yum.repos.d/delorean.repo 2025-12-11 05:21:16.635571 | controller | Installed repo delorean-master-testing to /etc/yum.repos.d/delorean-master-testing.repo 2025-12-11 05:21:16.635578 | controller | Installed repo repo-setup-centos-highavailability to /etc/yum.repos.d/repo-setup-centos-highavailability.repo 2025-12-11 05:21:16.635585 | controller | Installed repo repo-setup-centos-powertools to /etc/yum.repos.d/repo-setup-centos-powertools.repo 2025-12-11 05:21:16.635591 | controller | Installed repo repo-setup-centos-appstream to /etc/yum.repos.d/repo-setup-centos-appstream.repo 2025-12-11 05:21:16.635598 | controller | Installed repo repo-setup-centos-baseos to /etc/yum.repos.d/repo-setup-centos-baseos.repo 2025-12-11 05:21:16.669177 | controller | changed 2025-12-11 05:21:16.674303 | 2025-12-11 05:21:16.674371 | TASK [repo_setup : Get component repo] 2025-12-11 05:21:16.718884 | controller | skipping: Conditional result was False 2025-12-11 05:21:16.724563 | 2025-12-11 05:21:16.724632 | TASK [repo_setup : Rename component repo] 2025-12-11 05:21:16.768522 | controller | skipping: Conditional result was False 2025-12-11 05:21:16.774351 | 2025-12-11 05:21:16.774418 | TASK [repo_setup : Disable component repo in current-podified dlrn repo] 2025-12-11 05:21:16.818579 | controller | skipping: Conditional result was False 2025-12-11 05:21:16.824629 | 2025-12-11 05:21:16.824733 | TASK [repo_setup : Run repo-setup-get-hash] 2025-12-11 05:21:17.384019 | controller | {"commit_hash": null, "distro_hash": null, "full_hash": "2e38c527ddf6e767040136ecf014e7b9", "extended_hash": null, "dlrn_url": "https://trunk.rdoproject.org/centos9-master/podified-ci-testing/delorean.repo.md5", "dlrn_api_url": "https://trunk.rdoproject.org/api-centos9-master-uc", "os_version": "centos9", "release": "master", "component": null, "tag": "podified-ci-testing"} 2025-12-11 05:21:17.852501 | controller | changed 2025-12-11 05:21:17.858456 | 2025-12-11 05:21:17.858526 | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] 2025-12-11 05:21:18.577675 | controller | ok 2025-12-11 05:21:18.582368 | 2025-12-11 05:21:18.582426 | TASK [repo_setup : Dump current-podified hash] 2025-12-11 05:21:18.626173 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.631875 | 2025-12-11 05:21:18.631948 | TASK [repo_setup : Slurp current podified hash] 2025-12-11 05:21:18.676127 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.681311 | 2025-12-11 05:21:18.681373 | TASK [repo_setup : Update the value of full_hash] 2025-12-11 05:21:18.725411 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.730570 | 2025-12-11 05:21:18.730633 | TASK [repo_setup : Export hashes facts for further use] 2025-12-11 05:21:18.790249 | controller | ok 2025-12-11 05:21:18.795142 | 2025-12-11 05:21:18.795207 | TASK [repo_setup : Create download directory] 2025-12-11 05:21:18.839186 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.845788 | 2025-12-11 05:21:18.845857 | TASK [repo_setup : Print the URL to request] 2025-12-11 05:21:18.889625 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.895385 | 2025-12-11 05:21:18.895444 | TASK [Download the RPM] 2025-12-11 05:21:18.939280 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.944629 | 2025-12-11 05:21:18.944730 | TASK [repo_setup : Install RHOS Release tool] 2025-12-11 05:21:18.988381 | controller | skipping: Conditional result was False 2025-12-11 05:21:18.993937 | 2025-12-11 05:21:18.993998 | TASK [repo_setup : Get rhos-release tool version] 2025-12-11 05:21:19.522358 | controller | skipping: Conditional result was False 2025-12-11 05:21:19.527757 | 2025-12-11 05:21:19.527821 | TASK [repo_setup : Print rhos-release tool version] 2025-12-11 05:21:19.571625 | controller | skipping: Conditional result was False 2025-12-11 05:21:19.578793 | 2025-12-11 05:21:19.578864 | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] 2025-12-11 05:21:20.106426 | controller | skipping: Conditional result was False 2025-12-11 05:21:20.112268 | 2025-12-11 05:21:20.112333 | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] 2025-12-11 05:21:20.364744 | controller | ok 2025-12-11 05:21:20.369831 | 2025-12-11 05:21:20.369892 | TASK [repo_setup : Use RDO proxy mirrors] 2025-12-11 05:21:20.915159 | controller | changed 2025-12-11 05:21:20.919859 | 2025-12-11 05:21:20.919915 | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] 2025-12-11 05:21:21.446194 | controller | changed 2025-12-11 05:21:21.451695 | 2025-12-11 05:21:21.451759 | TASK [repo_setup : Check for gating.repo file on content provider] 2025-12-11 05:21:21.497194 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.502826 | 2025-12-11 05:21:21.502892 | TASK [repo_setup : Populate gating repo from content provider ip] 2025-12-11 05:21:21.547093 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.552949 | 2025-12-11 05:21:21.553012 | TASK [repo_setup : Check for DLRN repo at the destination] 2025-12-11 05:21:21.607283 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.614379 | 2025-12-11 05:21:21.614443 | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] 2025-12-11 05:21:21.669564 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.675807 | 2025-12-11 05:21:21.675877 | TASK [repo_setup : Check for DLRN component repo] 2025-12-11 05:21:21.722550 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.729669 | 2025-12-11 05:21:21.729743 | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] 2025-12-11 05:21:21.775482 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.781830 | 2025-12-11 05:21:21.781903 | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] 2025-12-11 05:21:21.827706 | controller | skipping: Conditional result was False 2025-12-11 05:21:21.833662 | 2025-12-11 05:21:21.833732 | LOOP [repo_setup : Remove existing repos from /etc/yum.repos.d directory] 2025-12-11 05:21:21.896450 | 2025-12-11 05:21:21.896594 | TASK [repo_setup : Cleanup existing metadata] 2025-12-11 05:21:22.426855 | controller | skipping: Conditional result was False 2025-12-11 05:21:22.432787 | 2025-12-11 05:21:22.432853 | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] 2025-12-11 05:21:22.488122 | controller | skipping: Conditional result was False 2025-12-11 05:21:22.497728 | 2025-12-11 05:21:22.497794 | TASK [dlrn_report : Perform kinit for DLRN kerberos authentication] 2025-12-11 05:21:23.023588 | controller | skipping: Conditional result was False 2025-12-11 05:21:23.029814 | 2025-12-11 05:21:23.029885 | TASK [dlrn_report : Set empty value for dlrnapi password] 2025-12-11 05:21:23.074561 | controller | skipping: Conditional result was False 2025-12-11 05:21:23.080466 | 2025-12-11 05:21:23.080532 | TASK [dlrn_report : Report results to dlrn for the tested hash] 2025-12-11 05:21:23.315287 | controller | REPORTING SUCCESS TO DLRN API 2025-12-11 05:21:23.857753 | controller | { 2025-12-11 05:21:23.871984 | controller | "aggregate_hash": "2e38c527ddf6e767040136ecf014e7b9", 2025-12-11 05:21:23.872003 | controller | "commit_hash": null, 2025-12-11 05:21:23.872011 | controller | "component": null, 2025-12-11 05:21:23.872017 | controller | "distro_hash": null, 2025-12-11 05:21:23.872022 | controller | "extended_hash": null, 2025-12-11 05:21:23.872028 | controller | "in_progress": false, 2025-12-11 05:21:23.872033 | controller | "job_id": "periodic-edpm-build-push-images-centos-9-master", 2025-12-11 05:21:23.872039 | controller | "notes": "", 2025-12-11 05:21:23.872045 | controller | "success": true, 2025-12-11 05:21:23.872050 | controller | "timestamp": 1765430483, 2025-12-11 05:21:23.872055 | controller | "url": "https://logserver.rdoproject.org/2b0/rdoproject.org/2b04894328cf478ebeac1f004357ce88" 2025-12-11 05:21:23.872062 | controller | } 2025-12-11 05:21:24.107735 | controller | changed 2025-12-11 05:21:24.128374 | 2025-12-11 05:21:24.128434 | PLAY RECAP 2025-12-11 05:21:24.128482 | controller | ok: 15 changed: 6 unreachable: 0 failed: 0 skipped: 30 rescued: 0 ignored: 0 2025-12-11 05:21:24.128510 | 2025-12-11 05:21:24.205476 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-12-11 05:21:24.206432 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-11 05:21:24.687779 | 2025-12-11 05:21:24.687897 | PLAY [all] 2025-12-11 05:21:24.706467 | 2025-12-11 05:21:24.706550 | TASK [include_role : fetch-output] 2025-12-11 05:21:24.735882 | controller | ok 2025-12-11 05:21:24.751221 | 2025-12-11 05:21:24.751304 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-11 05:21:24.785416 | controller | skipping: Conditional result was False 2025-12-11 05:21:24.790707 | 2025-12-11 05:21:24.790780 | TASK [fetch-output : Set log path for single node] 2025-12-11 05:21:24.818628 | controller | ok 2025-12-11 05:21:24.823146 | 2025-12-11 05:21:24.823207 | LOOP [fetch-output : Ensure local output dirs] 2025-12-11 05:21:25.119800 | controller -> localhost | ok: "/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/logs" 2025-12-11 05:21:25.288280 | controller -> localhost | ok: "/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/artifacts" 2025-12-11 05:21:25.457506 | controller -> localhost | ok: "/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/docs" 2025-12-11 05:21:25.470400 | 2025-12-11 05:21:25.470493 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-11 05:21:26.012525 | controller | ok 2025-12-11 05:21:26.012739 | controller | ok: All items complete 2025-12-11 05:21:26.012773 | 2025-12-11 05:21:26.394706 | controller | ok 2025-12-11 05:21:26.776939 | controller | ok 2025-12-11 05:21:26.790028 | 2025-12-11 05:21:26.790127 | TASK [include_role : fetch-output-openshift] 2025-12-11 05:21:26.803338 | controller | skipping: Conditional result was False 2025-12-11 05:21:26.809335 | 2025-12-11 05:21:26.809402 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-11 05:21:26.830481 | controller | skipping: Conditional result was False 2025-12-11 05:21:26.837308 | controller | skipping: Conditional result was False 2025-12-11 05:21:26.865855 | 2025-12-11 05:21:26.865918 | PLAY [all] 2025-12-11 05:21:26.878261 | 2025-12-11 05:21:26.878321 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-11 05:21:27.311228 | controller | changed 2025-12-11 05:21:27.333188 | 2025-12-11 05:21:27.333258 | PLAY RECAP 2025-12-11 05:21:27.333297 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-12-11 05:21:27.333318 | 2025-12-11 05:21:27.400079 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-12-11 05:21:27.401046 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-12-11 05:21:27.917070 | 2025-12-11 05:21:27.917166 | PLAY [localhost] 2025-12-11 05:21:27.934215 | 2025-12-11 05:21:27.934293 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-11 05:21:28.225149 | localhost | changed 2025-12-11 05:21:28.229477 | 2025-12-11 05:21:28.229552 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-11 05:21:28.247120 | localhost | ok 2025-12-11 05:21:28.254626 | 2025-12-11 05:21:28.254719 | TASK [add-fileserver : Create SSH private key tempfile] 2025-12-11 05:21:28.535817 | localhost | changed 2025-12-11 05:21:28.540499 | 2025-12-11 05:21:28.540573 | TASK [add-fileserver : Create SSH private key from secret] 2025-12-11 05:21:29.063855 | localhost | changed 2025-12-11 05:21:29.068601 | 2025-12-11 05:21:29.068694 | TASK [add-fileserver : Add fileserver ssh key] 2025-12-11 05:21:29.386807 | localhost | Identity added: /var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/tmp/ansible.ndgt6by0 (/var/lib/zuul/builds/2b04894328cf478ebeac1f004357ce88/work/tmp/ansible.ndgt6by0) 2025-12-11 05:21:29.386965 | localhost | ok: Runtime: 0:00:00.005452 2025-12-11 05:21:29.391117 | 2025-12-11 05:21:29.391185 | TASK [add-fileserver : Remove SSH private key from disk] 2025-12-11 05:21:29.600338 | localhost | ok: Runtime: 0:00:00.003866 2025-12-11 05:21:29.604716 | 2025-12-11 05:21:29.604775 | TASK [add-fileserver : Add fileserver to inventory] 2025-12-11 05:21:29.653307 | localhost | changed 2025-12-11 05:21:29.657464 | 2025-12-11 05:21:29.657532 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-12-11 05:21:29.960211 | localhost | changed 2025-12-11 05:21:29.979431 | 2025-12-11 05:21:29.979488 | PLAY [localhost] 2025-12-11 05:21:29.990225 | 2025-12-11 05:21:29.990284 | TASK [Generate bulk log download script] 2025-12-11 05:21:30.008598 | localhost | ok 2025-12-11 05:21:30.019649 | 2025-12-11 05:21:30.019732 | TASK [local-log-download : Check API endpoint is defined] 2025-12-11 05:21:30.046442 | localhost | ok: All assertions passed 2025-12-11 05:21:30.050637 | 2025-12-11 05:21:30.050723 | TASK [local-log-download : Create download script] 2025-12-11 05:21:30.377732 | localhost -> localhost | changed 2025-12-11 05:21:30.385535 | 2025-12-11 05:21:30.385595 | TASK [Register quick-download link] 2025-12-11 05:21:30.402215 | localhost | ok 2025-12-11 05:21:30.432728 | 2025-12-11 05:21:30.432786 | PLAY [logserver.rdoproject.org] 2025-12-11 05:21:30.441597 | 2025-12-11 05:21:30.441673 | TASK [Set zuul-log-path fact] 2025-12-11 05:21:30.456972 | logserver.rdoproject.org | ok 2025-12-11 05:21:30.465442 | 2025-12-11 05:21:30.465507 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 05:21:30.480593 | logserver.rdoproject.org | ok 2025-12-11 05:21:30.485441 | 2025-12-11 05:21:30.485501 | TASK [upload-logs : Create log directories] 2025-12-11 05:21:32.289965 | logserver.rdoproject.org | changed 2025-12-11 05:21:32.292835 | 2025-12-11 05:21:32.292892 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-11 05:21:32.498672 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.003618 2025-12-11 05:21:32.502543 | 2025-12-11 05:21:32.502601 | TASK [upload-logs : Upload logs to log server] 2025-12-11 05:21:33.966168 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-12-11 05:21:33.968887 | 2025-12-11 05:21:33.968946 | LOOP [upload-logs : Compress console log and json output] 2025-12-11 05:21:34.002871 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-11 05:21:34.010246 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-11 05:21:34.015195 | 2025-12-11 05:21:34.015281 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-11 05:21:34.046586 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-11 05:21:34.046786 | 2025-12-11 05:21:34.049739 | logserver.rdoproject.org | skipping: Conditional result was False 2025-12-11 05:21:34.061983 | 2025-12-11 05:21:34.062046 | LOOP [upload-logs : Upload console log and json output]