2025-10-14 06:54:08.940367 | Job console starting...
2025-10-14 06:54:08.950610 | Updating repositories
2025-10-14 06:54:09.133882 | Preparing job workspace
2025-10-14 06:54:26.242559 | Running Ansible setup...
2025-10-14 06:54:30.108874 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-14 06:54:30.726060 | 
2025-10-14 06:54:30.726187 | PLAY [localhost]
2025-10-14 06:54:30.735628 | 
2025-10-14 06:54:30.735736 | TASK [Gathering Facts]
2025-10-14 06:54:31.795943 | localhost | ok
2025-10-14 06:54:31.813648 | 
2025-10-14 06:54:31.813813 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-14 06:54:32.186574 | localhost -> localhost | changed
2025-10-14 06:54:32.192225 | 
2025-10-14 06:54:32.192301 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-14 06:54:33.116536 | localhost -> localhost | changed
2025-10-14 06:54:33.125773 | 
2025-10-14 06:54:33.125910 | TASK [Setup log path fact]
2025-10-14 06:54:33.145633 | localhost | ok
2025-10-14 06:54:33.160545 | 
2025-10-14 06:54:33.160691 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-14 06:54:33.200355 | localhost | ok
2025-10-14 06:54:33.218588 | 
2025-10-14 06:54:33.218713 | TASK [emit-job-header : Print job information]
2025-10-14 06:54:33.267766 | # Job Information
2025-10-14 06:54:33.268010 | Ansible Version: 2.15.12
2025-10-14 06:54:33.268058 | Job: openstack-k8s-operators-content-provider
2025-10-14 06:54:33.268080 | Pipeline: github-check
2025-10-14 06:54:33.268100 | Executor: ze01.softwarefactory-project.io
2025-10-14 06:54:33.268118 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237
2025-10-14 06:54:33.268138 | Log URL (when completed): https://logserver.rdoproject.org/2ba/rdoproject.org/2ba89f0ce8c840aeb438f0983c752329/
2025-10-14 06:54:33.268173 | Event ID: c940b7c0-a8c9-11f0-80da-b48bf6033ab5
2025-10-14 06:54:33.273402 | 
2025-10-14 06:54:33.273466 | LOOP [emit-job-header : Print node information]
2025-10-14 06:54:33.381454 | localhost | ok:
2025-10-14 06:54:33.381645 | localhost | # Node Information
2025-10-14 06:54:33.381686 | localhost | Inventory Hostname: controller
2025-10-14 06:54:33.381718 | localhost | Hostname: np0005486857
2025-10-14 06:54:33.381742 | localhost | Username: zuul
2025-10-14 06:54:33.381764 | localhost | Distro: CentOS 9
2025-10-14 06:54:33.381782 | localhost | Provider: vexxhost-nodepool-tripleo
2025-10-14 06:54:33.381799 | localhost | Region: RegionOne
2025-10-14 06:54:33.381815 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost
2025-10-14 06:54:33.381831 | localhost | Product Name: OpenStack Nova
2025-10-14 06:54:33.381847 | localhost | Interface IP: 38.102.83.75
2025-10-14 06:54:33.408708 | 
2025-10-14 06:54:33.408864 | PLAY [all]
2025-10-14 06:54:33.415745 | 
2025-10-14 06:54:33.415810 | TASK [Gather network facts]
2025-10-14 06:54:33.872792 | controller | ok
2025-10-14 06:54:33.908010 | 
2025-10-14 06:54:33.908176 | TASK [include_role : start-zuul-console]
2025-10-14 06:54:33.928096 | controller | ok
2025-10-14 06:54:33.942665 | 
2025-10-14 06:54:33.942777 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-14 06:54:34.308468 | controller | ok
2025-10-14 06:54:34.319950 | 
2025-10-14 06:54:34.320051 | TASK [include_role : add-build-sshkey]
2025-10-14 06:54:34.340418 | controller | ok
2025-10-14 06:54:34.353595 | 
2025-10-14 06:54:34.353666 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-14 06:54:34.631430 | controller -> localhost | ok
2025-10-14 06:54:34.639942 | 
2025-10-14 06:54:34.640046 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-14 06:54:34.668764 | controller | ok
2025-10-14 06:54:34.681158 | controller | included: /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-14 06:54:34.686704 | 
2025-10-14 06:54:34.686765 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-14 06:54:35.698651 | controller -> localhost | Generating public/private rsa key pair.
2025-10-14 06:54:35.698873 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/2ba89f0ce8c840aeb438f0983c752329_id_rsa.
2025-10-14 06:54:35.698904 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/2ba89f0ce8c840aeb438f0983c752329_id_rsa.pub.
2025-10-14 06:54:35.698926 | controller -> localhost | The key fingerprint is:
2025-10-14 06:54:35.698946 | controller -> localhost | SHA256:rjWYrKJBNCl/nLo5hykBz//y0GS+hrRcvTjx/4vmJIY zuul-build-sshkey
2025-10-14 06:54:35.698965 | controller -> localhost | The key's randomart image is:
2025-10-14 06:54:35.698984 | controller -> localhost | +---[RSA 3072]----+
2025-10-14 06:54:35.699001 | controller -> localhost | |                 |
2025-10-14 06:54:35.699043 | controller -> localhost | |  .              |
2025-10-14 06:54:35.699064 | controller -> localhost | |.+               |
2025-10-14 06:54:35.699082 | controller -> localhost | |+... .           |
2025-10-14 06:54:35.699099 | controller -> localhost | |.+. + o.S        |
2025-10-14 06:54:35.699116 | controller -> localhost | |o oo.*o=.        |
2025-10-14 06:54:35.699133 | controller -> localhost | |...*.+E+*..      |
2025-10-14 06:54:35.699151 | controller -> localhost | |..=oBo+=o+..     |
2025-10-14 06:54:35.699168 | controller -> localhost | |.oo+.==. ++.o.   |
2025-10-14 06:54:35.699185 | controller -> localhost | +----[SHA256]-----+
2025-10-14 06:54:35.699228 | controller -> localhost | ok: Runtime: 0:00:00.585332
2025-10-14 06:54:35.704776 | 
2025-10-14 06:54:35.704853 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-14 06:54:35.725145 | controller | ok
2025-10-14 06:54:35.734560 | controller | included: /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-14 06:54:35.742521 | 
2025-10-14 06:54:35.742582 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-14 06:54:35.756979 | controller | skipping: Conditional result was False
2025-10-14 06:54:35.762780 | 
2025-10-14 06:54:35.762846 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-14 06:54:36.215662 | controller | changed
2025-10-14 06:54:36.226832 | 
2025-10-14 06:54:36.226974 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-14 06:54:36.489505 | controller | ok
2025-10-14 06:54:36.502274 | 
2025-10-14 06:54:36.502418 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-14 06:54:37.397313 | controller | changed
2025-10-14 06:54:37.408508 | 
2025-10-14 06:54:37.408656 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-14 06:54:38.293106 | controller | changed
2025-10-14 06:54:38.303805 | 
2025-10-14 06:54:38.303937 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-14 06:54:38.330714 | controller | skipping: Conditional result was False
2025-10-14 06:54:38.344530 | 
2025-10-14 06:54:38.344705 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-14 06:54:38.760671 | controller -> localhost | changed
2025-10-14 06:54:38.783671 | 
2025-10-14 06:54:38.783861 | TASK [add-build-sshkey : Add back temp key]
2025-10-14 06:54:39.054831 | controller -> localhost | Identity added: /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/2ba89f0ce8c840aeb438f0983c752329_id_rsa (zuul-build-sshkey)
2025-10-14 06:54:39.055188 | controller -> localhost | ok: Runtime: 0:00:00.009364
2025-10-14 06:54:39.067280 | 
2025-10-14 06:54:39.067420 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-14 06:54:39.492902 | controller | ok
2025-10-14 06:54:39.504959 | 
2025-10-14 06:54:39.505190 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-14 06:54:39.533262 | controller | skipping: Conditional result was False
2025-10-14 06:54:39.547201 | 
2025-10-14 06:54:39.547339 | TASK [include_role : validate-host]
2025-10-14 06:54:39.569582 | controller | ok
2025-10-14 06:54:39.601156 | 
2025-10-14 06:54:39.601305 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-14 06:54:39.724129 | controller | ok
2025-10-14 06:54:39.730890 | 
2025-10-14 06:54:39.730988 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-14 06:54:40.010785 | controller -> localhost | ok
2025-10-14 06:54:40.016875 | 
2025-10-14 06:54:40.016946 | TASK [validate-host : Collect information about the host]
2025-10-14 06:54:40.777221 | controller | ok
2025-10-14 06:54:40.797149 | 
2025-10-14 06:54:40.797328 | TASK [validate-host : Sanitize hostname]
2025-10-14 06:54:40.874403 | controller | ok
2025-10-14 06:54:40.884857 | 
2025-10-14 06:54:40.885062 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-14 06:54:41.391178 | controller -> localhost | changed
2025-10-14 06:54:41.396983 | 
2025-10-14 06:54:41.397070 | TASK [validate-host : Collect information about zuul worker]
2025-10-14 06:54:41.831240 | controller | ok
2025-10-14 06:54:41.845089 | 
2025-10-14 06:54:41.845305 | TASK [validate-host : Write out all zuul information for each host]
2025-10-14 06:54:42.332295 | controller -> localhost | changed
2025-10-14 06:54:42.355164 | 
2025-10-14 06:54:42.355325 | TASK [include_role : prepare-workspace-openshift]
2025-10-14 06:54:42.372143 | controller | skipping: Conditional result was False
2025-10-14 06:54:42.383743 | 
2025-10-14 06:54:42.383886 | TASK [include_role : remove-zuul-sshkey]
2025-10-14 06:54:42.410828 | controller | skipping: Conditional result was False
2025-10-14 06:54:42.422820 | 
2025-10-14 06:54:42.422983 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-14 06:54:42.682642 | controller | ok: "logs"
2025-10-14 06:54:42.682933 | controller | ok: All items complete
2025-10-14 06:54:42.682973 | 
2025-10-14 06:54:42.936874 | controller | ok: "artifacts"
2025-10-14 06:54:43.173086 | controller | ok: "docs"
2025-10-14 06:54:43.185235 | 
2025-10-14 06:54:43.185385 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-14 06:54:43.439739 | controller | changed: "logs"
2025-10-14 06:54:43.747102 | controller | changed: "artifacts"
2025-10-14 06:54:44.008573 | controller | changed: "docs"
2025-10-14 06:54:44.043089 | 
2025-10-14 06:54:44.043223 | PLAY RECAP
2025-10-14 06:54:44.043279 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-14 06:54:44.043315 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-14 06:54:44.043342 | 
2025-10-14 06:54:44.156443 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-14 06:54:44.158270 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-14 06:54:44.808915 | 
2025-10-14 06:54:44.809099 | PLAY [all]
2025-10-14 06:54:44.830082 | 
2025-10-14 06:54:44.830198 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-14 06:54:44.891986 | controller | ok
2025-10-14 06:54:44.897047 | 
2025-10-14 06:54:44.897120 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-14 06:54:45.362706 | controller | changed
2025-10-14 06:54:45.375330 | 
2025-10-14 06:54:45.375485 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-14 06:54:46.718923 | controller | changed
2025-10-14 06:54:46.729440 | 
2025-10-14 06:54:46.729557 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-14 06:54:47.253568 | controller | changed:
2025-10-14 06:54:47.253743 | controller | {
2025-10-14 06:54:47.253773 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-14 06:54:47.253802 | controller | }
2025-10-14 06:54:47.571040 | controller | changed:
2025-10-14 06:54:47.571254 | controller | {
2025-10-14 06:54:47.571292 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-14 06:54:47.571313 | controller | }
2025-10-14 06:54:47.909679 | controller | changed:
2025-10-14 06:54:47.909788 | controller | {
2025-10-14 06:54:47.909812 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-14 06:54:47.909830 | controller | }
2025-10-14 06:54:48.226585 | controller | changed:
2025-10-14 06:54:48.226701 | controller | {
2025-10-14 06:54:48.226725 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-14 06:54:48.226744 | controller | }
2025-10-14 06:54:48.526259 | controller | changed:
2025-10-14 06:54:48.526417 | controller | {
2025-10-14 06:54:48.526468 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-14 06:54:48.526508 | controller | }
2025-10-14 06:54:48.803175 | controller | changed:
2025-10-14 06:54:48.803341 | controller | {
2025-10-14 06:54:48.803396 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-14 06:54:48.803440 | controller | }
2025-10-14 06:54:49.101097 | controller | changed:
2025-10-14 06:54:49.101250 | controller | {
2025-10-14 06:54:49.101303 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-10-14 06:54:49.101345 | controller | }
2025-10-14 06:54:49.430599 | controller | changed:
2025-10-14 06:54:49.430757 | controller | {
2025-10-14 06:54:49.430809 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-10-14 06:54:49.430851 | controller | }
2025-10-14 06:54:49.690105 | controller | changed:
2025-10-14 06:54:49.690277 | controller | {
2025-10-14 06:54:49.690329 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-14 06:54:49.690370 | controller | }
2025-10-14 06:54:49.974426 | controller | changed:
2025-10-14 06:54:49.974585 | controller | {
2025-10-14 06:54:49.974636 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-14 06:54:49.974676 | controller | }
2025-10-14 06:54:50.223510 | controller | changed:
2025-10-14 06:54:50.223686 | controller | {
2025-10-14 06:54:50.223757 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-14 06:54:50.223813 | controller | }
2025-10-14 06:54:50.471914 | controller | changed:
2025-10-14 06:54:50.472091 | controller | {
2025-10-14 06:54:50.472145 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-14 06:54:50.472185 | controller | }
2025-10-14 06:54:50.791595 | controller | changed:
2025-10-14 06:54:50.791757 | controller | {
2025-10-14 06:54:50.791808 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-14 06:54:50.791848 | controller | }
2025-10-14 06:54:51.107225 | controller | changed:
2025-10-14 06:54:51.107369 | controller | {
2025-10-14 06:54:51.107422 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-14 06:54:51.107488 | controller | }
2025-10-14 06:54:51.378641 | controller | changed:
2025-10-14 06:54:51.378797 | controller | {
2025-10-14 06:54:51.378859 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-14 06:54:51.378909 | controller | }
2025-10-14 06:54:51.686968 | controller | changed:
2025-10-14 06:54:51.687152 | controller | {
2025-10-14 06:54:51.687196 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-14 06:54:51.687225 | controller | }
2025-10-14 06:54:52.010350 | controller | changed:
2025-10-14 06:54:52.010489 | controller | {
2025-10-14 06:54:52.010543 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-10-14 06:54:52.010585 | controller | }
2025-10-14 06:54:52.343547 | controller | changed:
2025-10-14 06:54:52.343730 | controller | {
2025-10-14 06:54:52.343760 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-10-14 06:54:52.343789 | controller | }
2025-10-14 06:54:52.653167 | controller | changed:
2025-10-14 06:54:52.653341 | controller | {
2025-10-14 06:54:52.653381 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-14 06:54:52.653409 | controller | }
2025-10-14 06:54:52.935304 | controller | changed:
2025-10-14 06:54:52.935473 | controller | {
2025-10-14 06:54:52.935531 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-14 06:54:52.935575 | controller | }
2025-10-14 06:54:53.248969 | controller | changed:
2025-10-14 06:54:53.249152 | controller | {
2025-10-14 06:54:53.249202 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-14 06:54:53.249242 | controller | }
2025-10-14 06:54:53.529113 | controller | changed:
2025-10-14 06:54:53.529221 | controller | {
2025-10-14 06:54:53.529253 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-14 06:54:53.529278 | controller | }
2025-10-14 06:54:53.804874 | controller | changed:
2025-10-14 06:54:53.805100 | controller | {
2025-10-14 06:54:53.805162 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-10-14 06:54:53.805203 | controller | }
2025-10-14 06:54:54.117354 | controller | changed:
2025-10-14 06:54:54.117486 | controller | {
2025-10-14 06:54:54.117517 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-14 06:54:54.117542 | controller | }
2025-10-14 06:54:54.421771 | controller | changed:
2025-10-14 06:54:54.421885 | controller | {
2025-10-14 06:54:54.421909 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-14 06:54:54.421929 | controller | }
2025-10-14 06:54:54.734913 | controller | changed:
2025-10-14 06:54:54.735073 | controller | {
2025-10-14 06:54:54.735113 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-14 06:54:54.735140 | controller | }
2025-10-14 06:54:54.752920 | 
2025-10-14 06:54:54.753048 | TASK [Set timezone to UTC]
2025-10-14 06:54:55.415603 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-14 06:54:55.435979 | 
2025-10-14 06:54:55.436145 | TASK [Create nodepool directory]
2025-10-14 06:54:55.765435 | controller | changed
2025-10-14 06:54:55.773968 | 
2025-10-14 06:54:55.774092 | TASK [Create nodepool sub_nodes file]
2025-10-14 06:54:56.588865 | controller | changed
2025-10-14 06:54:56.597068 | 
2025-10-14 06:54:56.597175 | TASK [Create nodepool sub_nodes_private file]
2025-10-14 06:54:57.423175 | controller | changed
2025-10-14 06:54:57.434599 | 
2025-10-14 06:54:57.434741 | LOOP [Populate nodepool sub_nodes file]
2025-10-14 06:54:57.473949 | 
2025-10-14 06:54:57.474259 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-14 06:54:57.512450 | 
2025-10-14 06:54:57.512730 | TASK [Create nodepool primary file]
2025-10-14 06:54:57.540658 | controller | skipping: Conditional result was False
2025-10-14 06:54:57.553201 | 
2025-10-14 06:54:57.553367 | TASK [Create nodepool node_private for this node]
2025-10-14 06:54:58.495321 | controller | changed
2025-10-14 06:54:58.504280 | 
2025-10-14 06:54:58.504426 | LOOP [Copy ssh keys to nodepool directory]
2025-10-14 06:54:58.981313 | controller | ok: Item: id_rsa Runtime: 0:00:00.011015
2025-10-14 06:54:58.981680 | 
2025-10-14 06:54:59.241547 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.009825
2025-10-14 06:54:59.264457 | 
2025-10-14 06:54:59.264668 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-14 06:55:00.267385 | controller | changed
2025-10-14 06:55:00.283517 | 
2025-10-14 06:55:00.283711 | TASK [Validate sudoers config after edits]
2025-10-14 06:55:00.634504 | controller | /etc/sudoers: parsed OK
2025-10-14 06:55:00.634749 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-14 06:55:00.634778 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-14 06:55:00.634841 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-14 06:55:00.839649 | controller | ok: Runtime: 0:00:00.011094
2025-10-14 06:55:00.848350 | 
2025-10-14 06:55:00.848493 | TASK [Show the environment passed in to job shell scripts]
2025-10-14 06:55:01.146055 | controller | SHELL=/bin/bash
2025-10-14 06:55:01.146183 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-14 06:55:01.146207 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-14 06:55:01.146222 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/04/3404/9f142a3066b32ef704ae4f0d5fc5f7189e41a1f8^openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/2f8c81ac66bb5746ceb3bd299e433353061ca719
2025-10-14 06:55:01.146241 | controller | PWD=/home/zuul
2025-10-14 06:55:01.146255 | controller | ZUUL_PIPELINE=github-check
2025-10-14 06:55:01.146269 | controller | LOGNAME=zuul
2025-10-14 06:55:01.146282 | controller | XDG_SESSION_TYPE=tty
2025-10-14 06:55:01.146296 | controller | _=/usr/bin/env
2025-10-14 06:55:01.146309 | controller | MOTD_SHOWN=pam
2025-10-14 06:55:01.146322 | controller | HOME=/home/zuul
2025-10-14 06:55:01.146335 | controller | LANG=en_US.UTF-8
2025-10-14 06:55:01.146348 | controller | SSH_CONNECTION=38.102.83.114 40630 38.102.83.75 22
2025-10-14 06:55:01.146363 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-10-14 06:55:01.146377 | controller | ZUUL_CHANGE_IDS=3404,9f142a3066b32ef704ae4f0d5fc5f7189e41a1f8 3237,2f8c81ac66bb5746ceb3bd299e433353061ca719
2025-10-14 06:55:01.146458 | controller | WORKSPACE=/home/zuul/workspace
2025-10-14 06:55:01.146475 | controller | XDG_SESSION_CLASS=user
2025-10-14 06:55:01.146489 | controller | SELINUX_ROLE_REQUESTED=
2025-10-14 06:55:01.146502 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-14 06:55:01.146516 | controller | USER=zuul
2025-10-14 06:55:01.146529 | controller | ZUUL_VOTING=True
2025-10-14 06:55:01.146542 | controller | BUILD_TIMEOUT=1800000
2025-10-14 06:55:01.146555 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-14 06:55:01.146571 | controller | SHLVL=1
2025-10-14 06:55:01.146589 | controller | ZUUL_PATCHSET=2f8c81ac66bb5746ceb3bd299e433353061ca719
2025-10-14 06:55:01.146607 | controller | XDG_SESSION_ID=1
2025-10-14 06:55:01.146624 | controller | ZUUL_BRANCH=main
2025-10-14 06:55:01.146641 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-14 06:55:01.146657 | controller | SSH_CLIENT=38.102.83.114 40630 22
2025-10-14 06:55:01.146675 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-14 06:55:01.146692 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-14 06:55:01.146709 | controller | which_declare=declare -f
2025-10-14 06:55:01.146724 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-14 06:55:01.146738 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-14 06:55:01.146751 | controller | ZUUL_CHANGE=3237
2025-10-14 06:55:01.146764 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-14 06:55:01.146778 | controller | ZUUL_UUID=2ba89f0ce8c840aeb438f0983c752329
2025-10-14 06:55:01.146791 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-14 06:55:01.146805 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-14 06:55:01.146818 | controller | }
2025-10-14 06:55:01.391550 | controller | ok: Runtime: 0:00:00.013585
2025-10-14 06:55:01.399932 | 
2025-10-14 06:55:01.400061 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-14 06:55:01.415660 | controller | skipping: Conditional result was False
2025-10-14 06:55:01.429167 | 
2025-10-14 06:55:01.429353 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-14 06:55:02.003316 | controller | skipping: Conditional result was False
2025-10-14 06:55:02.010394 | 
2025-10-14 06:55:02.010478 | TASK [Ensure legacy workspace directory]
2025-10-14 06:55:02.310743 | controller | changed
2025-10-14 06:55:02.340344 | 
2025-10-14 06:55:02.340441 | PLAY RECAP
2025-10-14 06:55:02.340484 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-14 06:55:02.340505 | 
2025-10-14 06:55:02.450327 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-14 06:55:02.451111 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main]
2025-10-14 06:55:03.079205 | 
2025-10-14 06:55:03.079325 | PLAY [Get all repos on all hosts]
2025-10-14 06:55:03.101188 | 
2025-10-14 06:55:03.101309 | TASK [Clone repos in the job workspace]
2025-10-14 06:55:03.121911 | controller | ok
2025-10-14 06:55:03.138240 | 
2025-10-14 06:55:03.138348 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-14 06:55:03.533673 | controller | ok
2025-10-14 06:55:03.540612 | 
2025-10-14 06:55:03.540714 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-14 06:55:23.209662 | controller | Output suppressed because no_log was given
2025-10-14 06:55:23.237146 | 
2025-10-14 06:55:23.237230 | PLAY [Run ci/playbooks/e2e-prepare.yml]
2025-10-14 06:55:23.275517 | 
2025-10-14 06:55:23.275646 | TASK [Read group_vars]
2025-10-14 06:55:23.295606 | controller | ok
2025-10-14 06:55:23.316861 | 
2025-10-14 06:55:23.317005 | TASK [cifmw_helpers : Check directory is available]
2025-10-14 06:55:23.751187 | controller | ok
2025-10-14 06:55:23.759355 | 
2025-10-14 06:55:23.759499 | TASK [cifmw_helpers : Print var]
2025-10-14 06:55:23.801937 | controller | ok:
2025-10-14 06:55:23.802158 | controller | provide_var is /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars
2025-10-14 06:55:23.802193 | controller |  and registered one is {'changed': False, 'stat': {'exists': True, 'path': '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars', 'mode': '0755', 'isdir': True, 'ischr': False, 'isblk': False, 'isreg': False, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 1000, 'gid': 1000, 'size': 37, 'inode': 92274958, 'dev': 64513, 'nlink': 3, 'atime': 1760424922.1914527, 'mtime': 1760424860.1448014, 'ctime': 1760424922.6374404, 'wusr': True, 'rusr': True, 'xusr': True, 'wgrp': False, 'rgrp': True, 'xgrp': True, 'woth': False, 'roth': True, 'xoth': True, 'isuid': False, 'isgid': False, 'blocks': 0, 'block_size': 4096, 'device_type': 0, 'readable': True, 'writeable': True, 'executable': True, 'pw_name': 'zuul', 'gr_name': 'zuul', 'mimetype': 'inode/directory', 'charset': 'binary', 'version': '206784214', 'attributes': [], 'attr_flags': ''}, 'failed': False}
2025-10-14 06:55:23.808934 | 
2025-10-14 06:55:23.809035 | TASK [cifmw_helpers : List dir in ansible user home]
2025-10-14 06:55:24.257042 | controller | drwxr-xr-x. 3 zuul zuul 37 Oct 14 06:54 /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars
2025-10-14 06:55:24.261364 | controller | all.yml
2025-10-14 06:55:24.265232 | controller | molecule
2025-10-14 06:55:24.265289 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied
2025-10-14 06:55:24.269508 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-14 06:55:24.372944 | controller | ERROR
2025-10-14 06:55:24.373121 | controller | {
2025-10-14 06:55:24.373170 | controller |   "delta": "0:00:00.030905",
2025-10-14 06:55:24.373205 | controller |   "end": "2025-10-14 06:55:24.270518",
2025-10-14 06:55:24.373233 | controller |   "msg": "non-zero return code",
2025-10-14 06:55:24.373261 | controller |   "rc": 2,
2025-10-14 06:55:24.373285 | controller |   "start": "2025-10-14 06:55:24.239613"
2025-10-14 06:55:24.373309 | controller | }
2025-10-14 06:55:24.373344 | controller | ERROR: Ignoring Errors
2025-10-14 06:55:24.381362 | 
2025-10-14 06:55:24.381510 | TASK [cifmw_helpers : Find yaml files]
2025-10-14 06:55:24.862671 | controller | ok: All paths examined
2025-10-14 06:55:24.884359 | 
2025-10-14 06:55:24.884607 | TASK [cifmw_helpers : Print available yaml files]
2025-10-14 06:55:24.969890 | controller | ok: Found yaml files to parse: ['/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars/all.yml']
2025-10-14 06:55:24.978252 | 
2025-10-14 06:55:24.978354 | LOOP [cifmw_helpers : Read vars]
2025-10-14 06:55:25.394853 | controller | Output suppressed because no_log was given
2025-10-14 06:55:25.408584 | 
2025-10-14 06:55:25.408796 | LOOP [cifmw_helpers : Call task to parse all files as fact]
2025-10-14 06:55:25.455423 | controller | Output suppressed because no_log was given
2025-10-14 06:55:25.475230 | controller | included: /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/untrusted/project_0/github.com/openstack-k8s-operators/ci-framework/roles/cifmw_helpers/tasks/set_dir_facts.yml
2025-10-14 06:55:25.492981 | 
2025-10-14 06:55:25.493223 | LOOP [cifmw_helpers : Set files as fact]
2025-10-14 06:55:25.609708 | controller | Output suppressed because no_log was given
2025-10-14 06:55:25.625598 | 
2025-10-14 06:55:25.625742 | TASK [Create zuul-output directory]
2025-10-14 06:55:26.133569 | controller | ok
2025-10-14 06:55:26.147847 | 
2025-10-14 06:55:26.147988 | TASK [Install required packages]
2025-10-14 06:56:47.310620 | controller | changed
2025-10-14 06:56:47.320438 | 
2025-10-14 06:56:47.320563 | TASK [Output pip related things]
2025-10-14 06:56:48.042825 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9)
2025-10-14 06:56:48.402914 | controller | changed
2025-10-14 06:56:48.408876 | 
2025-10-14 06:56:48.408955 | TASK [Install requirements]
2025-10-14 06:56:48.799118 | controller | ERROR
2025-10-14 06:56:48.799403 | controller | {
2025-10-14 06:56:48.799434 | controller |   "msg": "gmake: *** No rule to make target 'setup_molecule'.  Stop.",
2025-10-14 06:56:48.799454 | controller |   "rc": 2
2025-10-14 06:56:48.799490 | controller | }
failure
2025-10-14 06:56:48.801549 | 
2025-10-14 06:56:48.801631 | PLAY RECAP
2025-10-14 06:56:48.801674 | controller | ok: 13 changed: 4 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 1
2025-10-14 06:56:48.801697 | 
2025-10-14 06:56:48.930573 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main]
2025-10-14 06:56:48.931425 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-14 06:56:49.514759 | 
2025-10-14 06:56:49.514869 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-14 06:56:49.535425 | 
2025-10-14 06:56:49.535506 | TASK [Filter out host if needed]
2025-10-14 06:56:49.544275 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-14 06:56:49.549517 | 
2025-10-14 06:56:49.549584 | TASK [Ensure file is present]
2025-10-14 06:56:49.936652 | controller | ok
2025-10-14 06:56:49.943380 | 
2025-10-14 06:56:49.943464 | TASK [Manage molecule report file]
2025-10-14 06:56:50.479465 | controller | skipping: Conditional result was False
2025-10-14 06:56:50.491875 | 
2025-10-14 06:56:50.493408 | TASK [Check if we get ci-framework-data basedir]
2025-10-14 06:56:50.726947 | controller | ok
2025-10-14 06:56:50.743248 | 
2025-10-14 06:56:50.743373 | TASK [Create ci-framework-data log directory for zuul]
2025-10-14 06:56:50.759102 | controller | skipping: Conditional result was False
2025-10-14 06:56:50.766509 | 
2025-10-14 06:56:50.766594 | TASK [Copy ci-framework interesting files]
2025-10-14 06:56:51.304605 | controller | skipping: Conditional result was False
2025-10-14 06:56:51.310885 | 
2025-10-14 06:56:51.310979 | TASK [Get SELinux listing]
2025-10-14 06:56:51.846450 | controller | skipping: Conditional result was False
2025-10-14 06:56:51.852803 | 
2025-10-14 06:56:51.852873 | TASK [Generate log index]
2025-10-14 06:56:51.866628 | controller | skipping: Conditional result was False
2025-10-14 06:56:51.875473 | 
2025-10-14 06:56:51.875580 | TASK [Get some env related data]
2025-10-14 06:56:53.415570 | controller | changed
2025-10-14 06:56:53.421912 | 
2025-10-14 06:56:53.421986 | TASK [Generate list of logs to collect in home directory]
2025-10-14 06:56:53.772487 | controller | ok: All paths examined
2025-10-14 06:56:53.780149 | 
2025-10-14 06:56:53.780283 | LOOP [Copy logs from home directory]
2025-10-14 06:56:53.802455 | 
2025-10-14 06:56:53.802725 | TASK [Copy crio stats log file]
2025-10-14 06:56:53.829453 | controller | skipping: Conditional result was False
2025-10-14 06:56:53.836298 | 
2025-10-14 06:56:53.836416 | TASK [Get SELinux related data]
2025-10-14 06:56:54.079549 | controller | <no matches>
2025-10-14 06:56:54.369356 | controller | ERROR
2025-10-14 06:56:54.369635 | controller | {
2025-10-14 06:56:54.369699 | controller |   "delta": "0:00:00.012537",
2025-10-14 06:56:54.369743 | controller |   "end": "2025-10-14 06:56:54.080710",
2025-10-14 06:56:54.369781 | controller |   "msg": "non-zero return code",
2025-10-14 06:56:54.369816 | controller |   "rc": 1,
2025-10-14 06:56:54.369895 | controller |   "start": "2025-10-14 06:56:54.068173"
2025-10-14 06:56:54.369933 | controller | }
2025-10-14 06:56:54.369981 | controller | ERROR: Ignoring Errors
2025-10-14 06:56:54.382378 | 
2025-10-14 06:56:54.382615 | TASK [Create system configuration directory]
2025-10-14 06:56:54.748009 | controller | changed
2025-10-14 06:56:54.757196 | 
2025-10-14 06:56:54.757298 | TASK [Get some of the system configurations]
2025-10-14 06:56:55.016996 | controller | cp: cannot stat '/etc/libvirt/*.conf': No such file or directory
2025-10-14 06:56:55.292655 | controller | changed
2025-10-14 06:56:55.298246 | 
2025-10-14 06:56:55.298309 | TASK [Copy generated documentation if available]
2025-10-14 06:56:55.322386 | controller | skipping: Conditional result was False
2025-10-14 06:56:55.328115 | 
2025-10-14 06:56:55.328181 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-14 06:56:55.352369 | controller | skipping: Conditional result was False
2025-10-14 06:56:55.358087 | 
2025-10-14 06:56:55.358282 | TASK [Compress logs bigger than 2MB]
2025-10-14 06:56:55.888319 | controller | changed
2025-10-14 06:56:55.894075 | 
2025-10-14 06:56:55.894288 | TASK [Copy files from workspace on node]
2025-10-14 06:56:55.913350 | controller | ok
2025-10-14 06:56:55.941310 | 
2025-10-14 06:56:55.941446 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-14 06:56:55.966946 | controller | skipping: Conditional result was False
2025-10-14 06:56:55.973879 | 
2025-10-14 06:56:55.973965 | TASK [fetch-output : Set log path for single node]
2025-10-14 06:56:56.005630 | controller | ok
2025-10-14 06:56:56.012595 | 
2025-10-14 06:56:56.012706 | LOOP [fetch-output : Ensure local output dirs]
2025-10-14 06:56:56.285078 | controller -> localhost | ok: "/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/logs"
2025-10-14 06:56:56.285344 | 
2025-10-14 06:56:56.506650 | controller -> localhost | changed: "/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/artifacts"
2025-10-14 06:56:56.728606 | controller -> localhost | changed: "/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/docs"
2025-10-14 06:56:56.740973 | 
2025-10-14 06:56:56.741124 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-14 06:56:57.434072 | controller | changed:
2025-10-14 06:56:57.434272 | controller | .d..t...... ./
2025-10-14 06:56:57.434301 | controller | >f+++++++++ dmesg.log
2025-10-14 06:56:57.434504 | controller | >f+++++++++ installed-pkgs.log
2025-10-14 06:56:57.434532 | controller | >f+++++++++ python.log
2025-10-14 06:56:57.434551 | controller | >f+++++++++ registries.conf
2025-10-14 06:56:57.434569 | controller | >f+++++++++ selinux-denials.log
2025-10-14 06:56:57.434587 | controller | cd+++++++++ registries.conf.d/
2025-10-14 06:56:57.434604 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-14 06:56:57.434620 | controller | cd+++++++++ system-config/
2025-10-14 06:56:57.434637 | controller | cd+++++++++ system-config/libvirt/
2025-10-14 06:56:57.869085 | controller | changed: .d..t...... ./
2025-10-14 06:56:58.301896 | controller | changed: .d..t...... ./
2025-10-14 06:56:58.329167 | 
2025-10-14 06:56:58.329304 | TASK [Return artifact to Zuul]
2025-10-14 06:56:58.354659 | controller | skipping: Conditional result was False
2025-10-14 06:56:58.387568 | 
2025-10-14 06:56:58.387670 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-14 06:56:58.387807 | 
2025-10-14 06:56:58.387845 | PLAY RECAP
2025-10-14 06:56:58.387896 | controller | ok: 11 changed: 7 unreachable: 0 failed: 0 skipped: 11 rescued: 0 ignored: 1
2025-10-14 06:56:58.387925 | 
2025-10-14 06:56:58.521398 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-14 06:56:58.522152 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-14 06:56:59.151945 | 
2025-10-14 06:56:59.152063 | PLAY [all]
2025-10-14 06:56:59.171607 | 
2025-10-14 06:56:59.171688 | TASK [include_role : fetch-output]
2025-10-14 06:56:59.220852 | controller | ok
2025-10-14 06:56:59.237329 | 
2025-10-14 06:56:59.237417 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-14 06:56:59.291818 | controller | skipping: Conditional result was False
2025-10-14 06:56:59.297938 | 
2025-10-14 06:56:59.298056 | TASK [fetch-output : Set log path for single node]
2025-10-14 06:56:59.341210 | controller | ok
2025-10-14 06:56:59.346346 | 
2025-10-14 06:56:59.346415 | LOOP [fetch-output : Ensure local output dirs]
2025-10-14 06:56:59.718199 | controller -> localhost | ok: "/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/logs"
2025-10-14 06:56:59.954784 | controller -> localhost | ok: "/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/artifacts"
2025-10-14 06:57:00.212814 | controller -> localhost | ok: "/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/docs"
2025-10-14 06:57:00.227533 | 
2025-10-14 06:57:00.227658 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-14 06:57:00.861001 | controller | ok
2025-10-14 06:57:00.861287 | controller | ok: All items complete
2025-10-14 06:57:00.861316 | 
2025-10-14 06:57:01.331909 | controller | ok
2025-10-14 06:57:01.827257 | controller | ok
2025-10-14 06:57:01.864485 | 
2025-10-14 06:57:01.864668 | TASK [include_role : fetch-output-openshift]
2025-10-14 06:57:01.881168 | controller | skipping: Conditional result was False
2025-10-14 06:57:01.894508 | 
2025-10-14 06:57:01.894699 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-14 06:57:02.340069 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013987
2025-10-14 06:57:02.617842 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.014395
2025-10-14 06:57:02.676988 | 
2025-10-14 06:57:02.677152 | PLAY [all]
2025-10-14 06:57:02.699699 | 
2025-10-14 06:57:02.699874 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-14 06:57:03.180820 | controller | changed
2025-10-14 06:57:03.205951 | 
2025-10-14 06:57:03.206097 | PLAY RECAP
2025-10-14 06:57:03.206154 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-14 06:57:03.206175 | 
2025-10-14 06:57:03.308821 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-14 06:57:03.309813 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-14 06:57:04.001938 | 
2025-10-14 06:57:04.002081 | PLAY [localhost]
2025-10-14 06:57:04.020744 | 
2025-10-14 06:57:04.020901 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-14 06:57:04.375557 | localhost | changed
2025-10-14 06:57:04.380679 | 
2025-10-14 06:57:04.380766 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-14 06:57:04.442635 | localhost | ok
2025-10-14 06:57:04.452077 | 
2025-10-14 06:57:04.452146 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-14 06:57:04.880916 | localhost | changed
2025-10-14 06:57:04.885915 | 
2025-10-14 06:57:04.885989 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-14 06:57:05.636064 | localhost | changed
2025-10-14 06:57:05.642211 | 
2025-10-14 06:57:05.642278 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-14 06:57:06.048058 | localhost | Identity added: /var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/tmp/ansible.iud2nbnb (/var/lib/zuul/builds/2ba89f0ce8c840aeb438f0983c752329/work/tmp/ansible.iud2nbnb)
2025-10-14 06:57:06.048272 | localhost | ok: Runtime: 0:00:00.017904
2025-10-14 06:57:06.052683 | 
2025-10-14 06:57:06.052746 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-14 06:57:06.335353 | localhost | ok: Runtime: 0:00:00.009704
2025-10-14 06:57:06.340365 | 
2025-10-14 06:57:06.340429 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-14 06:57:06.400879 | localhost | changed
2025-10-14 06:57:06.409346 | 
2025-10-14 06:57:06.409498 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-14 06:57:06.875598 | localhost | changed
2025-10-14 06:57:06.914230 | 
2025-10-14 06:57:06.914369 | PLAY [localhost]
2025-10-14 06:57:06.932604 | 
2025-10-14 06:57:06.932769 | TASK [Generate bulk log download script]
2025-10-14 06:57:06.954872 | localhost | ok
2025-10-14 06:57:06.971923 | 
2025-10-14 06:57:06.972042 | TASK [local-log-download : Check API endpoint is defined]
2025-10-14 06:57:07.024861 | localhost | ok: All assertions passed
2025-10-14 06:57:07.032291 | 
2025-10-14 06:57:07.032390 | TASK [local-log-download : Create download script]
2025-10-14 06:57:07.518103 | localhost -> localhost | changed
2025-10-14 06:57:07.549912 | 
2025-10-14 06:57:07.550045 | TASK [Register quick-download link]
2025-10-14 06:57:07.567673 | localhost | ok
2025-10-14 06:57:07.583198 | 
2025-10-14 06:57:07.583297 | PLAY [logserver.rdoproject.org]
2025-10-14 06:57:07.593416 | 
2025-10-14 06:57:07.593514 | TASK [Set zuul-log-path fact]
2025-10-14 06:57:07.609437 | logserver.rdoproject.org | ok
2025-10-14 06:57:07.618499 | 
2025-10-14 06:57:07.618575 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-14 06:57:07.645143 | logserver.rdoproject.org | ok
2025-10-14 06:57:07.650596 | 
2025-10-14 06:57:07.650660 | TASK [upload-logs : Create log directories]
2025-10-14 06:57:09.293724 | logserver.rdoproject.org | changed
2025-10-14 06:57:09.298639 | 
2025-10-14 06:57:09.298733 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-14 06:57:09.608271 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006981
2025-10-14 06:57:09.614692 | 
2025-10-14 06:57:09.614785 | TASK [upload-logs : Upload logs to log server]
2025-10-14 06:57:10.376380 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-14 06:57:10.384187 | 
2025-10-14 06:57:10.384362 | LOOP [upload-logs : Compress console log and json output]
2025-10-14 06:57:10.453004 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 06:57:10.461576 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 06:57:10.471998 | 
2025-10-14 06:57:10.472454 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-14 06:57:10.510425 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 06:57:10.510835 | 
2025-10-14 06:57:10.514010 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 06:57:10.529547 | 
2025-10-14 06:57:10.529704 | LOOP [upload-logs : Upload console log and json output]