2025-11-22 03:34:19.342255 | Job console starting...
2025-11-22 03:34:19.352327 | Updating repositories
2025-11-22 03:34:19.549573 | Preparing job workspace
2025-11-22 03:34:35.670036 | Running Ansible setup...
2025-11-22 03:34:39.708629 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-11-22 03:34:40.309993 | 
2025-11-22 03:34:40.310120 | PLAY [localhost]
2025-11-22 03:34:40.319824 | 
2025-11-22 03:34:40.319911 | TASK [Gathering Facts]
2025-11-22 03:34:41.338185 | localhost | ok
2025-11-22 03:34:41.351382 | 
2025-11-22 03:34:41.351471 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-11-22 03:34:41.855339 | localhost -> localhost | changed
2025-11-22 03:34:41.861704 | 
2025-11-22 03:34:41.861783 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-11-22 03:34:42.738721 | localhost -> localhost | changed
2025-11-22 03:34:42.757381 | 
2025-11-22 03:34:42.757529 | TASK [Setup log path fact]
2025-11-22 03:34:42.783010 | localhost | ok
2025-11-22 03:34:42.806815 | 
2025-11-22 03:34:42.806919 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-22 03:34:42.849243 | localhost | ok
2025-11-22 03:34:42.865523 | 
2025-11-22 03:34:42.865656 | TASK [emit-job-header : Print job information]
2025-11-22 03:34:42.918068 | # Job Information
2025-11-22 03:34:42.918326 | Ansible Version: 2.15.12
2025-11-22 03:34:42.918352 | Job: openstack-k8s-operators-content-provider
2025-11-22 03:34:42.918372 | Pipeline: github-check
2025-11-22 03:34:42.918390 | Executor: ze04.softwarefactory-project.io
2025-11-22 03:34:42.918408 | Triggered by: https://github.com/openstack-k8s-operators/infra-operator/pull/506
2025-11-22 03:34:42.918426 | Log URL (when completed): https://logserver.rdoproject.org/a4e/rdoproject.org/a4e05e8b45564fd7b2be6be741e33e94/
2025-11-22 03:34:42.918445 | Event ID: fe8e5880-c753-11f0-9cdd-5ff423988177
2025-11-22 03:34:42.922314 | 
2025-11-22 03:34:42.922379 | LOOP [emit-job-header : Print node information]
2025-11-22 03:34:43.045994 | localhost | ok:
2025-11-22 03:34:43.046583 | localhost | # Node Information
2025-11-22 03:34:43.046654 | localhost | Inventory Hostname: controller
2025-11-22 03:34:43.046752 | localhost | Hostname: np0005531706
2025-11-22 03:34:43.046820 | localhost | Username: zuul
2025-11-22 03:34:43.046880 | localhost | Distro: CentOS 9
2025-11-22 03:34:43.046922 | localhost | Provider: vexxhost-nodepool-tripleo
2025-11-22 03:34:43.046959 | localhost | Region: RegionOne
2025-11-22 03:34:43.046996 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost
2025-11-22 03:34:43.047033 | localhost | Product Name: OpenStack Nova
2025-11-22 03:34:43.047079 | localhost | Interface IP: 38.102.83.236
2025-11-22 03:34:43.094866 | 
2025-11-22 03:34:43.095091 | PLAY [all]
2025-11-22 03:34:43.111284 | 
2025-11-22 03:34:43.111426 | TASK [Gather network facts]
2025-11-22 03:34:43.656722 | controller | ok
2025-11-22 03:34:43.691373 | 
2025-11-22 03:34:43.691510 | TASK [include_role : start-zuul-console]
2025-11-22 03:34:43.729260 | controller | ok
2025-11-22 03:34:43.756931 | 
2025-11-22 03:34:43.757015 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-11-22 03:34:44.232221 | controller | ok
2025-11-22 03:34:44.252841 | 
2025-11-22 03:34:44.252972 | TASK [include_role : add-build-sshkey]
2025-11-22 03:34:44.292113 | controller | ok
2025-11-22 03:34:44.320216 | 
2025-11-22 03:34:44.320307 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-11-22 03:34:44.632895 | controller -> localhost | ok
2025-11-22 03:34:44.645380 | 
2025-11-22 03:34:44.645516 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-11-22 03:34:44.678883 | controller | ok
2025-11-22 03:34:44.692156 | controller | included: /var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-11-22 03:34:44.698232 | 
2025-11-22 03:34:44.698298 | TASK [add-build-sshkey : Create Temp SSH key]
2025-11-22 03:34:45.572613 | controller -> localhost | Generating public/private rsa key pair.
2025-11-22 03:34:45.573069 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/a4e05e8b45564fd7b2be6be741e33e94_id_rsa.
2025-11-22 03:34:45.573134 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/a4e05e8b45564fd7b2be6be741e33e94_id_rsa.pub.
2025-11-22 03:34:45.573181 | controller -> localhost | The key fingerprint is:
2025-11-22 03:34:45.573224 | controller -> localhost | SHA256:JnA2pKGebK2lqkOAG9cuyLRXDvgQ5/KCSeZlCEUjOxA zuul-build-sshkey
2025-11-22 03:34:45.573265 | controller -> localhost | The key's randomart image is:
2025-11-22 03:34:45.573305 | controller -> localhost | +---[RSA 3072]----+
2025-11-22 03:34:45.573344 | controller -> localhost | |E++ . .          |
2025-11-22 03:34:45.573384 | controller -> localhost | |o+ + +           |
2025-11-22 03:34:45.573422 | controller -> localhost | |= B.o +          |
2025-11-22 03:34:45.573461 | controller -> localhost | |+%.B.= .         |
2025-11-22 03:34:45.573500 | controller -> localhost | |O*&.* . S        |
2025-11-22 03:34:45.573537 | controller -> localhost | |=B.B.. o         |
2025-11-22 03:34:45.573575 | controller -> localhost | |. =.             |
2025-11-22 03:34:45.573618 | controller -> localhost | |..               |
2025-11-22 03:34:45.573656 | controller -> localhost | |+.               |
2025-11-22 03:34:45.573732 | controller -> localhost | +----[SHA256]-----+
2025-11-22 03:34:45.573829 | controller -> localhost | ok: Runtime: 0:00:00.390233
2025-11-22 03:34:45.586412 | 
2025-11-22 03:34:45.586567 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-11-22 03:34:45.623816 | controller | ok
2025-11-22 03:34:45.645084 | controller | included: /var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-11-22 03:34:45.659549 | 
2025-11-22 03:34:45.659636 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-11-22 03:34:45.684898 | controller | skipping: Conditional result was False
2025-11-22 03:34:45.694230 | 
2025-11-22 03:34:45.694358 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-11-22 03:34:46.205103 | controller | changed
2025-11-22 03:34:46.211792 | 
2025-11-22 03:34:46.211877 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-11-22 03:34:46.563876 | controller | ok
2025-11-22 03:34:46.574673 | 
2025-11-22 03:34:46.574887 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-11-22 03:34:47.530228 | controller | changed
2025-11-22 03:34:47.541526 | 
2025-11-22 03:34:47.541729 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-11-22 03:34:48.476730 | controller | changed
2025-11-22 03:34:48.487638 | 
2025-11-22 03:34:48.487806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-11-22 03:34:48.514325 | controller | skipping: Conditional result was False
2025-11-22 03:34:48.528990 | 
2025-11-22 03:34:48.529143 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-11-22 03:34:48.934118 | controller -> localhost | changed
2025-11-22 03:34:48.945473 | 
2025-11-22 03:34:48.945586 | TASK [add-build-sshkey : Add back temp key]
2025-11-22 03:34:49.254012 | controller -> localhost | Identity added: /var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/a4e05e8b45564fd7b2be6be741e33e94_id_rsa (zuul-build-sshkey)
2025-11-22 03:34:49.254319 | controller -> localhost | ok: Runtime: 0:00:00.013646
2025-11-22 03:34:49.262075 | 
2025-11-22 03:34:49.262169 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-11-22 03:34:49.723417 | controller | ok
2025-11-22 03:34:49.733948 | 
2025-11-22 03:34:49.734082 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-11-22 03:34:49.771184 | controller | skipping: Conditional result was False
2025-11-22 03:34:49.791843 | 
2025-11-22 03:34:49.791989 | TASK [include_role : validate-host]
2025-11-22 03:34:49.828117 | controller | ok
2025-11-22 03:34:49.893534 | 
2025-11-22 03:34:49.893656 | TASK [validate-host : Define zuul_info_dir fact]
2025-11-22 03:34:49.932055 | controller | ok
2025-11-22 03:34:49.936752 | 
2025-11-22 03:34:49.936815 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-11-22 03:34:50.234959 | controller -> localhost | ok
2025-11-22 03:34:50.240617 | 
2025-11-22 03:34:50.240702 | TASK [validate-host : Collect information about the host]
2025-11-22 03:34:51.094788 | controller | ok
2025-11-22 03:34:51.113827 | 
2025-11-22 03:34:51.113969 | TASK [validate-host : Sanitize hostname]
2025-11-22 03:34:51.191809 | controller | ok
2025-11-22 03:34:51.203366 | 
2025-11-22 03:34:51.203509 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-11-22 03:34:51.680300 | controller -> localhost | changed
2025-11-22 03:34:51.692426 | 
2025-11-22 03:34:51.692565 | TASK [validate-host : Collect information about zuul worker]
2025-11-22 03:34:52.191985 | controller | ok
2025-11-22 03:34:52.203630 | 
2025-11-22 03:34:52.203814 | TASK [validate-host : Write out all zuul information for each host]
2025-11-22 03:34:52.742877 | controller -> localhost | changed
2025-11-22 03:34:52.766191 | 
2025-11-22 03:34:52.766386 | TASK [include_role : prepare-workspace-openshift]
2025-11-22 03:34:52.785329 | controller | skipping: Conditional result was False
2025-11-22 03:34:52.796755 | 
2025-11-22 03:34:52.796890 | TASK [include_role : remove-zuul-sshkey]
2025-11-22 03:34:52.825710 | controller | skipping: Conditional result was False
2025-11-22 03:34:52.836556 | 
2025-11-22 03:34:52.836728 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-11-22 03:34:53.130850 | controller | ok: "logs"
2025-11-22 03:34:53.131335 | controller | ok: All items complete
2025-11-22 03:34:53.131394 | 
2025-11-22 03:34:53.388504 | controller | ok: "artifacts"
2025-11-22 03:34:53.645768 | controller | ok: "docs"
2025-11-22 03:34:53.668990 | 
2025-11-22 03:34:53.669199 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-11-22 03:34:53.940416 | controller | changed: "logs"
2025-11-22 03:34:54.173176 | controller | changed: "artifacts"
2025-11-22 03:34:54.440468 | controller | changed: "docs"
2025-11-22 03:34:54.493008 | 
2025-11-22 03:34:54.493222 | PLAY RECAP
2025-11-22 03:34:54.493315 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-11-22 03:34:54.493368 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-22 03:34:54.493406 | 
2025-11-22 03:34:54.709146 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-11-22 03:34:54.710820 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-11-22 03:34:55.350491 | 
2025-11-22 03:34:55.350618 | PLAY [all]
2025-11-22 03:34:55.370488 | 
2025-11-22 03:34:55.370576 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-11-22 03:34:55.468499 | controller | ok
2025-11-22 03:34:55.479590 | 
2025-11-22 03:34:55.479786 | TASK [mirror-info-fork : Create /etc/ci]
2025-11-22 03:34:55.969510 | controller | changed
2025-11-22 03:34:55.982007 | 
2025-11-22 03:34:55.982173 | TASK [mirror-info-fork : Install ci_mirror script]
2025-11-22 03:34:57.217064 | controller | changed
2025-11-22 03:34:57.235325 | 
2025-11-22 03:34:57.235423 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-11-22 03:34:57.709075 | controller | changed:
2025-11-22 03:34:57.709284 | controller | {
2025-11-22 03:34:57.709321 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-11-22 03:34:57.709375 | controller | }
2025-11-22 03:34:58.032451 | controller | changed:
2025-11-22 03:34:58.032576 | controller | {
2025-11-22 03:34:58.032602 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-11-22 03:34:58.032622 | controller | }
2025-11-22 03:34:58.333095 | controller | changed:
2025-11-22 03:34:58.333416 | controller | {
2025-11-22 03:34:58.333525 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-11-22 03:34:58.333589 | controller | }
2025-11-22 03:34:58.592839 | controller | changed:
2025-11-22 03:34:58.593039 | controller | {
2025-11-22 03:34:58.593096 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-11-22 03:34:58.593139 | controller | }
2025-11-22 03:34:58.877462 | controller | changed:
2025-11-22 03:34:58.877654 | controller | {
2025-11-22 03:34:58.877762 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-11-22 03:34:58.877811 | controller | }
2025-11-22 03:34:59.170044 | controller | changed:
2025-11-22 03:34:59.170228 | controller | {
2025-11-22 03:34:59.170281 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-11-22 03:34:59.170321 | controller | }
2025-11-22 03:34:59.460025 | controller | changed:
2025-11-22 03:34:59.460182 | controller | {
2025-11-22 03:34:59.460232 | 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-11-22 03:34:59.460274 | controller | }
2025-11-22 03:34:59.736727 | controller | changed:
2025-11-22 03:34:59.736885 | controller | {
2025-11-22 03:34:59.736939 | 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-11-22 03:34:59.736980 | controller | }
2025-11-22 03:35:00.011106 | controller | changed:
2025-11-22 03:35:00.011264 | controller | {
2025-11-22 03:35:00.011316 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-11-22 03:35:00.011358 | controller | }
2025-11-22 03:35:00.282032 | controller | changed:
2025-11-22 03:35:00.282174 | controller | {
2025-11-22 03:35:00.282224 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-11-22 03:35:00.282265 | controller | }
2025-11-22 03:35:00.582904 | controller | changed:
2025-11-22 03:35:00.583051 | controller | {
2025-11-22 03:35:00.583100 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-11-22 03:35:00.583139 | controller | }
2025-11-22 03:35:00.883639 | controller | changed:
2025-11-22 03:35:00.883851 | controller | {
2025-11-22 03:35:00.883914 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-11-22 03:35:00.883955 | controller | }
2025-11-22 03:35:01.152491 | controller | changed:
2025-11-22 03:35:01.152633 | controller | {
2025-11-22 03:35:01.152729 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-11-22 03:35:01.152779 | controller | }
2025-11-22 03:35:01.469588 | controller | changed:
2025-11-22 03:35:01.469751 | controller | {
2025-11-22 03:35:01.469803 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-11-22 03:35:01.469844 | controller | }
2025-11-22 03:35:01.771456 | controller | changed:
2025-11-22 03:35:01.771605 | controller | {
2025-11-22 03:35:01.771655 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-11-22 03:35:01.771735 | controller | }
2025-11-22 03:35:02.091324 | controller | changed:
2025-11-22 03:35:02.091430 | controller | {
2025-11-22 03:35:02.091481 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-11-22 03:35:02.091521 | controller | }
2025-11-22 03:35:02.387453 | controller | changed:
2025-11-22 03:35:02.387560 | controller | {
2025-11-22 03:35:02.387611 | 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-11-22 03:35:02.387654 | controller | }
2025-11-22 03:35:02.656577 | controller | changed:
2025-11-22 03:35:02.656710 | controller | {
2025-11-22 03:35:02.656769 | 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-11-22 03:35:02.656826 | controller | }
2025-11-22 03:35:02.948556 | controller | changed:
2025-11-22 03:35:02.948665 | controller | {
2025-11-22 03:35:02.948760 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-11-22 03:35:02.948804 | controller | }
2025-11-22 03:35:03.280207 | controller | changed:
2025-11-22 03:35:03.280311 | controller | {
2025-11-22 03:35:03.280361 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-11-22 03:35:03.280402 | controller | }
2025-11-22 03:35:03.553281 | controller | changed:
2025-11-22 03:35:03.553385 | controller | {
2025-11-22 03:35:03.553435 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-11-22 03:35:03.553475 | controller | }
2025-11-22 03:35:03.891419 | controller | changed:
2025-11-22 03:35:03.891535 | controller | {
2025-11-22 03:35:03.891585 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-11-22 03:35:03.891625 | controller | }
2025-11-22 03:35:04.231933 | controller | changed:
2025-11-22 03:35:04.232039 | controller | {
2025-11-22 03:35:04.232089 | 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-11-22 03:35:04.232130 | controller | }
2025-11-22 03:35:04.522398 | controller | changed:
2025-11-22 03:35:04.522541 | controller | {
2025-11-22 03:35:04.522593 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-11-22 03:35:04.522640 | controller | }
2025-11-22 03:35:04.834212 | controller | changed:
2025-11-22 03:35:04.834374 | controller | {
2025-11-22 03:35:04.834423 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-11-22 03:35:04.834463 | controller | }
2025-11-22 03:35:05.169526 | controller | changed:
2025-11-22 03:35:05.169748 | controller | {
2025-11-22 03:35:05.169843 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-11-22 03:35:05.169902 | controller | }
2025-11-22 03:35:05.215378 | 
2025-11-22 03:35:05.215569 | TASK [Set timezone to UTC]
2025-11-22 03:35:05.921588 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-11-22 03:35:05.933953 | 
2025-11-22 03:35:05.934089 | TASK [Create nodepool directory]
2025-11-22 03:35:06.277857 | controller | changed
2025-11-22 03:35:06.290089 | 
2025-11-22 03:35:06.290222 | TASK [Create nodepool sub_nodes file]
2025-11-22 03:35:07.194331 | controller | changed
2025-11-22 03:35:07.206435 | 
2025-11-22 03:35:07.206580 | TASK [Create nodepool sub_nodes_private file]
2025-11-22 03:35:08.102150 | controller | changed
2025-11-22 03:35:08.113709 | 
2025-11-22 03:35:08.113852 | LOOP [Populate nodepool sub_nodes file]
2025-11-22 03:35:08.163361 | 
2025-11-22 03:35:08.163612 | LOOP [Populate nodepool sub_nodes_private file]
2025-11-22 03:35:08.213066 | 
2025-11-22 03:35:08.213417 | TASK [Create nodepool primary file]
2025-11-22 03:35:08.250419 | controller | skipping: Conditional result was False
2025-11-22 03:35:08.262421 | 
2025-11-22 03:35:08.262577 | TASK [Create nodepool node_private for this node]
2025-11-22 03:35:09.271082 | controller | changed
2025-11-22 03:35:09.282925 | 
2025-11-22 03:35:09.283055 | LOOP [Copy ssh keys to nodepool directory]
2025-11-22 03:35:09.786589 | controller | ok: Item: id_rsa Runtime: 0:00:00.065599
2025-11-22 03:35:09.786950 | 
2025-11-22 03:35:10.103498 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.021045
2025-11-22 03:35:10.119260 | 
2025-11-22 03:35:10.119514 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-11-22 03:35:11.015250 | controller | changed
2025-11-22 03:35:11.026148 | 
2025-11-22 03:35:11.026279 | TASK [Validate sudoers config after edits]
2025-11-22 03:35:11.378022 | controller | /etc/sudoers: parsed OK
2025-11-22 03:35:11.378144 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-11-22 03:35:11.378163 | controller | /etc/sudoers.d/zuul: parsed OK
2025-11-22 03:35:11.378178 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-11-22 03:35:11.576511 | controller | ok: Runtime: 0:00:00.010506
2025-11-22 03:35:11.583628 | 
2025-11-22 03:35:11.583729 | TASK [Show the environment passed in to job shell scripts]
2025-11-22 03:35:11.883628 | controller | SHELL=/bin/bash
2025-11-22 03:35:11.883820 | controller | ZUUL_PROJECT=openstack-k8s-operators/infra-operator
2025-11-22 03:35:11.883842 | controller | ZUUL_SHORT_PROJECT_NAME=infra-operator
2025-11-22 03:35:11.883858 | controller | ZUUL_CHANGES=openstack-k8s-operators/infra-operator:18.0-fr4:refs/changes/06/506/f5244c0f6ac7d5ca26fe6a5d6b72b726a5ad3904
2025-11-22 03:35:11.883982 | controller | PWD=/home/zuul
2025-11-22 03:35:11.884047 | controller | ZUUL_PIPELINE=github-check
2025-11-22 03:35:11.884068 | controller | LOGNAME=zuul
2025-11-22 03:35:11.884083 | controller | XDG_SESSION_TYPE=tty
2025-11-22 03:35:11.884098 | controller | _=/usr/bin/env
2025-11-22 03:35:11.884112 | controller | MOTD_SHOWN=pam
2025-11-22 03:35:11.884127 | controller | HOME=/home/zuul
2025-11-22 03:35:11.884141 | controller | LANG=en_US.UTF-8
2025-11-22 03:35:11.884156 | controller | SSH_CONNECTION=38.102.83.114 37506 38.102.83.236 22
2025-11-22 03:35:11.884171 | 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-11-22 03:35:11.884194 | controller | ZUUL_CHANGE_IDS=506,f5244c0f6ac7d5ca26fe6a5d6b72b726a5ad3904
2025-11-22 03:35:11.884209 | controller | WORKSPACE=/home/zuul/workspace
2025-11-22 03:35:11.884224 | controller | XDG_SESSION_CLASS=user
2025-11-22 03:35:11.884239 | controller | SELINUX_ROLE_REQUESTED=
2025-11-22 03:35:11.884253 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-11-22 03:35:11.884268 | controller | USER=zuul
2025-11-22 03:35:11.884282 | controller | ZUUL_VOTING=True
2025-11-22 03:35:11.884297 | controller | BUILD_TIMEOUT=1800000
2025-11-22 03:35:11.884311 | controller | SELINUX_USE_CURRENT_RANGE=
2025-11-22 03:35:11.884326 | controller | SHLVL=1
2025-11-22 03:35:11.884340 | controller | ZUUL_PATCHSET=f5244c0f6ac7d5ca26fe6a5d6b72b726a5ad3904
2025-11-22 03:35:11.884355 | controller | XDG_SESSION_ID=1
2025-11-22 03:35:11.884370 | controller | ZUUL_BRANCH=18.0-fr4
2025-11-22 03:35:11.884384 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-11-22 03:35:11.884398 | controller | SSH_CLIENT=38.102.83.114 37506 22
2025-11-22 03:35:11.884413 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-11-22 03:35:11.884427 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-11-22 03:35:11.884442 | controller | which_declare=declare -f
2025-11-22 03:35:11.884457 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-11-22 03:35:11.884472 | controller | SELINUX_LEVEL_REQUESTED=
2025-11-22 03:35:11.884487 | controller | ZUUL_CHANGE=506
2025-11-22 03:35:11.884501 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-11-22 03:35:11.884516 | controller | ZUUL_UUID=a4e05e8b45564fd7b2be6be741e33e94
2025-11-22 03:35:11.884530 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-11-22 03:35:11.884548 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-11-22 03:35:11.884563 | controller | }
2025-11-22 03:35:12.121291 | controller | ok: Runtime: 0:00:00.015368
2025-11-22 03:35:12.132885 | 
2025-11-22 03:35:12.133007 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-11-22 03:35:12.159108 | controller | skipping: Conditional result was False
2025-11-22 03:35:12.171064 | 
2025-11-22 03:35:12.171203 | TASK [Symlink /home/zuul-worker/workspace]
2025-11-22 03:35:12.748731 | controller | skipping: Conditional result was False
2025-11-22 03:35:12.754703 | 
2025-11-22 03:35:12.754773 | TASK [Ensure legacy workspace directory]
2025-11-22 03:35:13.074814 | controller | changed
2025-11-22 03:35:13.122134 | 
2025-11-22 03:35:13.122260 | PLAY RECAP
2025-11-22 03:35:13.122321 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-11-22 03:35:13.122350 | 
2025-11-22 03:35:13.235294 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-11-22 03:35:13.236156 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main]
2025-11-22 03:35:13.877065 | 
2025-11-22 03:35:13.877182 | PLAY [Run ci/playbooks/e2e-prepare.yml]
2025-11-22 03:35:13.898289 | 
2025-11-22 03:35:13.898364 | TASK [Clone repos in the job workspace]
2025-11-22 03:35:13.917784 | controller | ok
2025-11-22 03:35:13.934193 | 
2025-11-22 03:35:13.934265 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-11-22 03:35:14.336414 | controller | ok
2025-11-22 03:35:14.349927 | 
2025-11-22 03:35:14.350075 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-11-22 03:35:30.948265 | controller | Output suppressed because no_log was given
2025-11-22 03:35:30.957853 | 
2025-11-22 03:35:30.957986 | TASK [Create zuul-output directory]
2025-11-22 03:35:31.432200 | controller | ok
2025-11-22 03:35:31.444146 | 
2025-11-22 03:35:31.444279 | TASK [Install required packages]
2025-11-22 03:36:38.720937 | controller | changed
2025-11-22 03:36:38.732981 | 
2025-11-22 03:36:38.733111 | TASK [Output pip related things]
2025-11-22 03:36:40.581419 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9)
2025-11-22 03:36:40.785150 | controller | changed
2025-11-22 03:36:40.796568 | 
2025-11-22 03:36:40.796729 | TASK [Install requirements]
2025-11-22 03:38:06.848327 | controller | changed
2025-11-22 03:38:06.877484 | 
2025-11-22 03:38:06.877643 | TASK [Add cronjob to trigger job stats]
2025-11-22 03:38:06.947211 | controller | skipping: Conditional result was False
2025-11-22 03:38:06.960090 | 
2025-11-22 03:38:06.960227 | LOOP [Construct project change list]
2025-11-22 03:38:07.041843 | controller | ok:
2025-11-22 03:38:07.042267 | controller | {
2025-11-22 03:38:07.042343 | controller |   "branch": "18.0-fr4",
2025-11-22 03:38:07.042396 | controller |   "change": "506",
2025-11-22 03:38:07.042447 | controller |   "change_message": "openstack-k8s-operators dependency bump branch: 18.0-fr4\n\nAutomated changes by [create-pull-request](https://github.com/peter-evans/create-pull-request) GitHub action",
2025-11-22 03:38:07.042500 | controller |   "change_url": "https://github.com/openstack-k8s-operators/infra-operator/pull/506",
2025-11-22 03:38:07.042548 | controller |   "commit_id": "f5244c0f6ac7d5ca26fe6a5d6b72b726a5ad3904",
2025-11-22 03:38:07.042594 | controller |   "patchset": "f5244c0f6ac7d5ca26fe6a5d6b72b726a5ad3904",
2025-11-22 03:38:07.042638 | controller |   "project": {
2025-11-22 03:38:07.042706 | controller |     "canonical_hostname": "github.com",
2025-11-22 03:38:07.042760 | controller |     "canonical_name": "github.com/openstack-k8s-operators/infra-operator",
2025-11-22 03:38:07.042805 | controller |     "name": "openstack-k8s-operators/infra-operator",
2025-11-22 03:38:07.043023 | controller |     "short_name": "infra-operator",
2025-11-22 03:38:07.043074 | controller |     "src_dir": "src/github.com/openstack-k8s-operators/infra-operator"
2025-11-22 03:38:07.043112 | controller |   },
2025-11-22 03:38:07.043150 | controller |   "topic": null
2025-11-22 03:38:07.043184 | controller | }
2025-11-22 03:38:07.131170 | 
2025-11-22 03:38:07.131293 | PLAY [Run ci/playbooks/build_runner_image.yml]
2025-11-22 03:38:07.150294 | 
2025-11-22 03:38:07.150371 | TASK [Filter out host if needed]
2025-11-22 03:38:07.162482 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-11-22 03:38:07.166897 | 
2025-11-22 03:38:07.166949 | TASK [Get git tag for image tagging]
2025-11-22 03:38:07.700460 | controller | skipping: Conditional result was False
2025-11-22 03:38:07.712657 | 
2025-11-22 03:38:07.712838 | TASK [Set openstack-runner image]
2025-11-22 03:38:07.731058 | controller | skipping: Conditional result was False
2025-11-22 03:38:07.743397 | 
2025-11-22 03:38:07.743523 | TASK [Build openstack-runner image]
2025-11-22 03:38:07.770476 | controller | skipping: Conditional result was False
2025-11-22 03:38:07.783323 | 
2025-11-22 03:38:07.783456 | TASK [Push openstack-runner image]
2025-11-22 03:38:07.810767 | controller | skipping: Conditional result was False
2025-11-22 03:38:07.863666 | 
2025-11-22 03:38:07.863840 | TASK [Make sure ci-framework directory exists]
2025-11-22 03:38:07.890360 | controller | skipping: Conditional result was False
2025-11-22 03:38:07.899321 | 
2025-11-22 03:38:07.899408 | TASK [Create EDPM ansible var file]
2025-11-22 03:38:07.935106 | controller | skipping: Conditional result was False
2025-11-22 03:38:07.971743 | 
2025-11-22 03:38:07.971812 | PLAY RECAP
2025-11-22 03:38:07.971863 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2025-11-22 03:38:07.971890 | 
2025-11-22 03:38:08.093150 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main]
2025-11-22 03:38:08.096477 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-11-22 03:38:08.626553 | 
2025-11-22 03:38:08.626742 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-11-22 03:38:08.649533 | 
2025-11-22 03:38:08.649646 | TASK [Create zuul-output directory]
2025-11-22 03:38:09.061660 | controller | changed
2025-11-22 03:38:09.074083 | 
2025-11-22 03:38:09.074244 | TASK [Slurp Zuul inventory test]
2025-11-22 03:38:09.488726 | controller -> localhost | ok
2025-11-22 03:38:09.502375 | 
2025-11-22 03:38:09.502512 | TASK [Save zuul inventory]
2025-11-22 03:38:10.786825 | controller | changed
2025-11-22 03:38:10.797635 | 
2025-11-22 03:38:10.797819 | TASK [Save zuul vars without the change_message]
2025-11-22 03:38:11.895562 | controller | changed
2025-11-22 03:38:11.935093 | 
2025-11-22 03:38:11.935164 | PLAY RECAP
2025-11-22 03:38:11.935218 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-22 03:38:11.935245 | 
2025-11-22 03:38:12.040326 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-11-22 03:38:12.041133 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/pre.yml@main]
2025-11-22 03:38:12.624479 | 
2025-11-22 03:38:12.624594 | PLAY [Run ci/playbooks/content_provider/pre.yml]
2025-11-22 03:38:12.645540 | 
2025-11-22 03:38:12.645648 | TASK [Filter out host if needed]
2025-11-22 03:38:12.654509 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-11-22 03:38:12.659022 | 
2025-11-22 03:38:12.659085 | TASK [Clone repos in the job workspace]
2025-11-22 03:38:12.678387 | controller | ok
2025-11-22 03:38:12.694880 | 
2025-11-22 03:38:12.694946 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-11-22 03:38:13.347151 | controller | ok
2025-11-22 03:38:13.360416 | 
2025-11-22 03:38:13.360564 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-11-22 03:38:15.146004 | controller | Output suppressed because no_log was given
2025-11-22 03:38:15.162839 | 
2025-11-22 03:38:15.162932 | TASK [Install ansible-core]
2025-11-22 03:38:21.401962 | controller | changed
2025-11-22 03:38:21.414033 | 
2025-11-22 03:38:21.414173 | TASK [Discover an IPv4 for provider job]
2025-11-22 03:38:21.474998 | controller | ok
2025-11-22 03:38:21.512531 | 
2025-11-22 03:38:21.512625 | PLAY RECAP
2025-11-22 03:38:21.512731 | controller | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-11-22 03:38:21.512781 | 
2025-11-22 03:38:21.634792 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/pre.yml@main]
2025-11-22 03:38:21.635921 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/run.yml@main]
2025-11-22 03:38:22.183202 | 
2025-11-22 03:38:22.183312 | PLAY [Run ci/playbooks/content_provider/run.yml]
2025-11-22 03:38:22.209164 | 
2025-11-22 03:38:22.209248 | TASK [Filter out host if needed]
2025-11-22 03:38:22.218657 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-11-22 03:38:22.223475 | 
2025-11-22 03:38:22.223539 | TASK [Deploy content provider]
2025-11-22 03:38:23.573301 | controller |
2025-11-22 03:38:24.723934 | controller | PLAY [Bootstrap playbook] ******************************************************
2025-11-22 03:38:24.724071 | controller |
2025-11-22 03:38:24.724083 | controller | TASK [Gathering Facts ] ********************************************************
2025-11-22 03:38:24.724092 | controller | Saturday 22 November 2025  03:38:23 +0000 (0:00:00.046)       0:00:00.046 *****
2025-11-22 03:38:24.724100 | controller | Saturday 22 November 2025  03:38:23 +0000 (0:00:00.044)       0:00:00.044 *****
2025-11-22 03:38:24.724125 | controller | ok: [localhost]
2025-11-22 03:38:24.765693 | controller |
2025-11-22 03:38:24.765815 | 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-11-22 03:38:24.765831 | controller | Saturday 22 November 2025  03:38:24 +0000 (0:00:01.152)       0:00:01.198 *****
2025-11-22 03:38:24.765840 | controller | Saturday 22 November 2025  03:38:24 +0000 (0:00:01.152)       0:00:01.197 *****
2025-11-22 03:38:24.765866 | controller | ok: [localhost]
2025-11-22 03:38:24.825609 | controller |
2025-11-22 03:38:24.825706 | controller | TASK [cifmw_setup : Get customized parameters ci_framework_params={{
2025-11-22 03:38:24.825718 | controller |   hostvars[inventory_hostname] |
2025-11-22 03:38:24.825727 | controller |   dict2items |
2025-11-22 03:38:24.825735 | controller |   selectattr("key", "match",
2025-11-22 03:38:24.825743 | controller |              "^(cifmw|pre|post)_(?!install_yamls|openshift_token|openshift_login|openshift_kubeconfig).*") |
2025-11-22 03:38:24.825749 | controller |   list | items2dict
2025-11-22 03:38:24.825755 | controller | }}] ***
2025-11-22 03:38:24.825761 | controller | Saturday 22 November 2025  03:38:24 +0000 (0:00:00.041)       0:00:01.240 *****
2025-11-22 03:38:24.825767 | controller | Saturday 22 November 2025  03:38:24 +0000 (0:00:00.041)       0:00:01.239 *****
2025-11-22 03:38:24.825788 | controller | ok: [localhost]
2025-11-22 03:38:25.191466 | controller |
2025-11-22 03:38:25.191543 | controller | TASK [install_ca : Ensure target directory exists path={{ cifmw_install_ca_trust_dir }}, state=directory, mode=0755] ***
2025-11-22 03:38:25.191552 | controller | Saturday 22 November 2025  03:38:24 +0000 (0:00:00.059)       0:00:01.300 *****
2025-11-22 03:38:25.191558 | controller | Saturday 22 November 2025  03:38:24 +0000 (0:00:00.059)       0:00:01.299 *****
2025-11-22 03:38:25.191572 | controller | ok: [localhost]
2025-11-22 03:38:25.245685 | controller |
2025-11-22 03:38:25.245801 | 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-11-22 03:38:25.245815 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.365)       0:00:01.665 *****
2025-11-22 03:38:25.245826 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.365)       0:00:01.664 *****
2025-11-22 03:38:25.245869 | controller | skipping: [localhost]
2025-11-22 03:38:25.294543 | controller |
2025-11-22 03:38:25.294660 | 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-11-22 03:38:25.294678 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.054)       0:00:01.719 *****
2025-11-22 03:38:25.294693 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.054)       0:00:01.718 *****
2025-11-22 03:38:25.294725 | controller | skipping: [localhost]
2025-11-22 03:38:25.341425 | controller |
2025-11-22 03:38:25.341523 | 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-11-22 03:38:25.341538 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.049)       0:00:01.769 *****
2025-11-22 03:38:25.341546 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.049)       0:00:01.768 *****
2025-11-22 03:38:25.341566 | controller | skipping: [localhost]
2025-11-22 03:38:27.125918 | controller |
2025-11-22 03:38:27.126046 | controller | TASK [install_ca : Update ca bundle _raw_params=update-ca-trust] ***************
2025-11-22 03:38:27.126061 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.046)       0:00:01.816 *****
2025-11-22 03:38:27.126089 | controller | Saturday 22 November 2025  03:38:25 +0000 (0:00:00.046)       0:00:01.814 *****
2025-11-22 03:38:27.126120 | controller | changed: [localhost]
2025-11-22 03:38:27.793440 | controller |
2025-11-22 03:38:27.793504 | controller | TASK [repo_setup : Ensure directories are present path={{ cifmw_repo_setup_basedir }}/{{ item }}, state=directory, mode=0755] ***
2025-11-22 03:38:27.793515 | controller | Saturday 22 November 2025  03:38:27 +0000 (0:00:01.784)       0:00:03.600 *****
2025-11-22 03:38:27.793524 | controller | Saturday 22 November 2025  03:38:27 +0000 (0:00:01.784)       0:00:03.599 *****
2025-11-22 03:38:27.793541 | controller | changed: [localhost] => (item=tmp)
2025-11-22 03:38:28.822796 | controller | changed: [localhost] => (item=artifacts/repositories)
2025-11-22 03:38:28.822891 | controller | changed: [localhost] => (item=venv/repo_setup)
2025-11-22 03:38:28.822913 | controller |
2025-11-22 03:38:28.822930 | controller | TASK [repo_setup : Make sure git-core package is installed name=git-core, state=present] ***
2025-11-22 03:38:28.822944 | controller | Saturday 22 November 2025  03:38:27 +0000 (0:00:00.667)       0:00:04.267 *****
2025-11-22 03:38:28.822959 | controller | Saturday 22 November 2025  03:38:27 +0000 (0:00:00.667)       0:00:04.266 *****
2025-11-22 03:38:28.822985 | controller | ok: [localhost]
2025-11-22 03:38:30.019515 | controller |
2025-11-22 03:38:30.019616 | 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-11-22 03:38:30.019635 | controller | Saturday 22 November 2025  03:38:28 +0000 (0:00:01.028)       0:00:05.296 *****
2025-11-22 03:38:30.019649 | controller | Saturday 22 November 2025  03:38:28 +0000 (0:00:01.028)       0:00:05.295 *****
2025-11-22 03:38:30.019691 | controller | changed: [localhost]
2025-11-22 03:38:38.462662 | controller |
2025-11-22 03:38:38.462740 | 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-11-22 03:38:38.462770 | controller | Saturday 22 November 2025  03:38:30 +0000 (0:00:01.196)       0:00:06.493 *****
2025-11-22 03:38:38.462787 | controller | Saturday 22 November 2025  03:38:30 +0000 (0:00:01.196)       0:00:06.492 *****
2025-11-22 03:38:38.462815 | controller | changed: [localhost]
2025-11-22 03:38:39.286097 | controller |
2025-11-22 03:38:39.286200 | 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-11-22 03:38:39.286228 | controller | Saturday 22 November 2025  03:38:38 +0000 (0:00:08.443)       0:00:14.937 *****
2025-11-22 03:38:39.286242 | controller | Saturday 22 November 2025  03:38:38 +0000 (0:00:08.443)       0:00:14.935 *****
2025-11-22 03:38:39.286267 | controller | changed: [localhost]
2025-11-22 03:38:39.334970 | controller |
2025-11-22 03:38:39.335114 | 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-11-22 03:38:39.335134 | controller | Saturday 22 November 2025  03:38:39 +0000 (0:00:00.824)       0:00:15.761 *****
2025-11-22 03:38:39.335149 | controller | Saturday 22 November 2025  03:38:39 +0000 (0:00:00.824)       0:00:15.759 *****
2025-11-22 03:38:39.335180 | controller | skipping: [localhost]
2025-11-22 03:38:40.272482 | controller |
2025-11-22 03:38:40.272575 | 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-11-22 03:38:40.272587 | controller | Saturday 22 November 2025  03:38:39 +0000 (0:00:00.048)       0:00:15.809 *****
2025-11-22 03:38:40.272595 | controller | Saturday 22 November 2025  03:38:39 +0000 (0:00:00.048)       0:00:15.808 *****
2025-11-22 03:38:40.272629 | controller | changed: [localhost]
2025-11-22 03:38:40.327784 | controller |
2025-11-22 03:38:40.327938 | 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-11-22 03:38:40.327957 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.936)       0:00:16.746 *****
2025-11-22 03:38:40.327972 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.936)       0:00:16.745 *****
2025-11-22 03:38:40.328058 | controller | skipping: [localhost]
2025-11-22 03:38:40.406754 | controller |
2025-11-22 03:38:40.406890 | 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-11-22 03:38:40.406912 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.054)       0:00:16.801 *****
2025-11-22 03:38:40.406927 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.054)       0:00:16.800 *****
2025-11-22 03:38:40.406958 | controller | skipping: [localhost]
2025-11-22 03:38:40.474488 | controller |
2025-11-22 03:38:40.474616 | 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-11-22 03:38:40.474635 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.079)       0:00:16.880 *****
2025-11-22 03:38:40.474649 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.079)       0:00:16.879 *****
2025-11-22 03:38:40.474684 | controller | skipping: [localhost]
2025-11-22 03:38:51.021269 | controller |
2025-11-22 03:38:51.021400 | 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-11-22 03:38:51.021415 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.068)       0:00:16.948 *****
2025-11-22 03:38:51.021431 | controller | Saturday 22 November 2025  03:38:40 +0000 (0:00:00.068)       0:00:16.947 *****
2025-11-22 03:38:51.021462 | controller | task path: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/repo_setup/tasks/artifacts.yml:2
2025-11-22 03:38:51.021471 | controller | fatal: [localhost]: FAILED! =>
2025-11-22 03:38:51.021481 | controller |     changed: true
2025-11-22 03:38:51.021489 | controller |     cmd:
2025-11-22 03:38:51.021506 | controller |     - /home/zuul/ci-framework-data/venv/repo-setup/bin/repo-setup-get-hash
2025-11-22 03:38:51.021516 | controller |     - --dlrn-url
2025-11-22 03:38:51.021524 | controller |     - https://trunk.rdoproject.org
2025-11-22 03:38:51.021533 | controller |     - --os-version
2025-11-22 03:38:51.021541 | controller |     - centos9
2025-11-22 03:38:51.021549 | controller |     - --release
2025-11-22 03:38:51.021558 | controller |     - antelope
2025-11-22 03:38:51.021566 | controller |     - --tag
2025-11-22 03:38:51.021574 | controller |     - current-podified
2025-11-22 03:38:51.021583 | controller |     - --json
2025-11-22 03:38:51.021592 | controller |     delta: '0:00:10.308005'
2025-11-22 03:38:51.021603 | controller |     end: '2025-11-22 03:38:50.976116'
2025-11-22 03:38:51.021614 | controller |     msg: non-zero return code
2025-11-22 03:38:51.021625 | controller |     rc: 1
2025-11-22 03:38:51.021636 | controller |     start: '2025-11-22 03:38:40.668111'
2025-11-22 03:38:51.021660 | controller |     stderr: |-
2025-11-22 03:38:51.021671 | controller |       Traceback (most recent call last):
2025-11-22 03:38:51.021682 | controller |         File "/home/zuul/ci-framework-data/venv/repo-setup/bin/repo-setup-get-hash", line 10, in <module>
2025-11-22 03:38:51.021693 | controller |           sys.exit(cli_entrypoint())
2025-11-22 03:38:51.021704 | controller |         File "/home/zuul/ci-framework-data/venv/repo-setup/lib64/python3.9/site-packages/repo_setup/get_hash/__main__.py", line 117, in cli_entrypoint
2025-11-22 03:38:51.021715 | controller |           main()
2025-11-22 03:38:51.021725 | controller |         File "/home/zuul/ci-framework-data/venv/repo-setup/lib64/python3.9/site-packages/repo_setup/get_hash/__main__.py", line 89, in main
2025-11-22 03:38:51.021736 | controller |           repo_setup_hash_info = HashInfo(
2025-11-22 03:38:51.021746 | controller |         File "/home/zuul/ci-framework-data/venv/repo-setup/lib64/python3.9/site-packages/repo_setup/get_hash/hash_info.py", line 153, in __init__
2025-11-22 03:38:51.021757 | controller |           raise HashInvalidDLRNResponse(error_str)
2025-11-22 03:38:51.021773 | controller |       repo_setup.get_hash.exceptions.HashInvalidDLRNResponse: Invalid response received from the delorean server. Queried URL: https://trunk.rdoproject.org/centos9-antelope/current-podified/delorean.repo.md5. Response code: -1. Response text: The read operation timed out. Failed to create HashInfo object.
2025-11-22 03:38:51.021785 | controller |     stderr_lines:
2025-11-22 03:38:51.021795 | controller |     - 'Traceback (most recent call last):'
2025-11-22 03:38:51.021806 | controller |     - '  File "/home/zuul/ci-framework-data/venv/repo-setup/bin/repo-setup-get-hash",
2025-11-22 03:38:51.021817 | controller |       line 10, in <module>'
2025-11-22 03:38:51.021828 | controller |     - '    sys.exit(cli_entrypoint())'
2025-11-22 03:38:51.021839 | controller |     - '  File "/home/zuul/ci-framework-data/venv/repo-setup/lib64/python3.9/site-packages/repo_setup/get_hash/__main__.py",
2025-11-22 03:38:51.021849 | controller |       line 117, in cli_entrypoint'
2025-11-22 03:38:51.021858 | controller |     - '    main()'
2025-11-22 03:38:51.021867 | controller |     - '  File "/home/zuul/ci-framework-data/venv/repo-setup/lib64/python3.9/site-packages/repo_setup/get_hash/__main__.py",
2025-11-22 03:38:51.021875 | controller |       line 89, in main'
2025-11-22 03:38:51.021883 | controller |     - '    repo_setup_hash_info = HashInfo('
2025-11-22 03:38:51.021891 | controller |     - '  File "/home/zuul/ci-framework-data/venv/repo-setup/lib64/python3.9/site-packages/repo_setup/get_hash/hash_info.py",
2025-11-22 03:38:51.021899 | controller |       line 153, in __init__'
2025-11-22 03:38:51.021909 | controller |     - '    raise HashInvalidDLRNResponse(error_str)'
2025-11-22 03:38:51.021920 | controller |     - 'repo_setup.get_hash.exceptions.HashInvalidDLRNResponse: Invalid response received
2025-11-22 03:38:51.021931 | controller |       from the delorean server. Queried URL: https://trunk.rdoproject.org/centos9-antelope/current-podified/delorean.repo.md5.
2025-11-22 03:38:51.021942 | controller |       Response code: -1. Response text: The read operation timed out. Failed to create
2025-11-22 03:38:51.021953 | controller |       HashInfo object.'
2025-11-22 03:38:51.021964 | controller |     stdout: '2025-11-22 03:38:50,925 - repo-setup-get-hash - ERROR - Invalid response
2025-11-22 03:38:51.021974 | controller |       received from the delorean server. Queried URL: https://trunk.rdoproject.org/centos9-antelope/current-podified/delorean.repo.md5.
2025-11-22 03:38:51.021985 | controller |       Response code: -1. Response text: The read operation timed out. Failed to create
2025-11-22 03:38:51.022057 | controller |       HashInfo object.'
2025-11-22 03:38:51.022074 | controller |     stdout_lines:
2025-11-22 03:38:51.022083 | controller |     - '2025-11-22 03:38:50,925 - repo-setup-get-hash - ERROR - Invalid response received
2025-11-22 03:38:51.022091 | controller |       from the delorean server. Queried URL: https://trunk.rdoproject.org/centos9-antelope/current-podified/delorean.repo.md5.
2025-11-22 03:38:51.022099 | controller |       Response code: -1. Response text: The read operation timed out. Failed to create
2025-11-22 03:38:51.022108 | controller |       HashInfo object.'
2025-11-22 03:38:51.022116 | controller |
2025-11-22 03:38:51.022127 | controller | NO MORE HOSTS LEFT *************************************************************
2025-11-22 03:38:51.022143 | controller |
2025-11-22 03:38:51.022152 | controller | PLAY RECAP *********************************************************************
2025-11-22 03:38:51.022160 | controller | localhost                  : ok=11   changed=6    unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2025-11-22 03:38:51.022168 | controller |
2025-11-22 03:38:51.022177 | controller | Saturday 22 November 2025  03:38:51 +0000 (0:00:10.546)       0:00:27.494 *****
2025-11-22 03:38:51.022185 | controller | ===============================================================================
2025-11-22 03:38:51.022193 | controller | repo_setup : Run repo-setup-get-hash ----------------------------------- 10.55s
2025-11-22 03:38:51.022202 | controller | repo_setup : Initialize python venv and install requirements ------------ 8.44s
2025-11-22 03:38:51.022210 | controller | install_ca : Update ca bundle ------------------------------------------- 1.78s
2025-11-22 03:38:51.022226 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.20s
2025-11-22 03:38:51.160328 | controller | Gathering Facts --------------------------------------------------------- 1.15s
2025-11-22 03:38:51.160430 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.03s
2025-11-22 03:38:51.160438 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.94s
2025-11-22 03:38:51.160445 | controller | repo_setup : Install repo-setup package --------------------------------- 0.82s
2025-11-22 03:38:51.160451 | controller | repo_setup : Ensure directories are present ----------------------------- 0.67s
2025-11-22 03:38:51.160457 | controller | install_ca : Ensure target directory exists ----------------------------- 0.37s
2025-11-22 03:38:51.160463 | controller | repo_setup : Rename component repo -------------------------------------- 0.08s
2025-11-22 03:38:51.160469 | controller | repo_setup : Disable component repo in current-podified dlrn repo ------- 0.07s
2025-11-22 03:38:51.160475 | controller | cifmw_setup : Get customized parameters --------------------------------- 0.06s
2025-11-22 03:38:51.160481 | controller | repo_setup : Get component repo ----------------------------------------- 0.05s
2025-11-22 03:38:51.160487 | controller | install_ca : Install internal CA from url ------------------------------- 0.05s
2025-11-22 03:38:51.160493 | controller | install_ca : Install custom CA bundle from inline ----------------------- 0.05s
2025-11-22 03:38:51.160499 | controller | repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider --- 0.05s
2025-11-22 03:38:51.160535 | controller | install_ca : Install custom CA bundle from file ------------------------- 0.05s
2025-11-22 03:38:51.160545 | controller | cifmw_setup : Set custom cifmw PATH reusable fact ----------------------- 0.04s
2025-11-22 03:38:51.160553 | controller | Saturday 22 November 2025  03:38:51 +0000 (0:00:10.547)       0:00:27.495 *****
2025-11-22 03:38:51.160560 | controller | ===============================================================================
2025-11-22 03:38:51.160568 | controller | repo_setup ------------------------------------------------------------- 23.90s
2025-11-22 03:38:51.160575 | controller | install_ca -------------------------------------------------------------- 2.30s
2025-11-22 03:38:51.160582 | controller | gather_facts ------------------------------------------------------------ 1.15s
2025-11-22 03:38:51.160590 | controller | cifmw_setup ------------------------------------------------------------- 0.10s
2025-11-22 03:38:51.160597 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~
2025-11-22 03:38:51.160603 | controller | total ------------------------------------------------------------------ 27.45s
2025-11-22 03:38:51.330101 | controller | ERROR
2025-11-22 03:38:51.330392 | controller | {
2025-11-22 03:38:51.330456 | controller |   "delta": "0:00:28.502125",
2025-11-22 03:38:51.330498 | controller |   "end": "2025-11-22 03:38:51.161428",
2025-11-22 03:38:51.330537 | controller |   "msg": "non-zero return code",
2025-11-22 03:38:51.330601 | controller |   "rc": 2,
2025-11-22 03:38:51.330653 | controller |   "start": "2025-11-22 03:38:22.659303"
2025-11-22 03:38:51.330744 | controller | }
failure
2025-11-22 03:38:51.337402 | 
2025-11-22 03:38:51.337504 | PLAY RECAP
2025-11-22 03:38:51.337581 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2025-11-22 03:38:51.337624 | 
2025-11-22 03:38:51.448017 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/content_provider/run.yml@main]
2025-11-22 03:38:51.448890 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-11-22 03:38:52.001009 | 
2025-11-22 03:38:52.001115 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-11-22 03:38:52.021397 | 
2025-11-22 03:38:52.021539 | TASK [Filter out host if needed]
2025-11-22 03:38:52.030214 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-11-22 03:38:52.035293 | 
2025-11-22 03:38:52.035357 | TASK [Ensure file is present]
2025-11-22 03:38:52.477594 | controller | ok
2025-11-22 03:38:52.489561 | 
2025-11-22 03:38:52.489740 | TASK [Manage molecule report file]
2025-11-22 03:38:53.036853 | controller | skipping: Conditional result was False
2025-11-22 03:38:53.048951 | 
2025-11-22 03:38:53.049095 | TASK [Check if we get ci-framework-data basedir]
2025-11-22 03:38:53.374768 | controller | ok
2025-11-22 03:38:53.386558 | 
2025-11-22 03:38:53.386721 | TASK [Create ci-framework-data log directory for zuul]
2025-11-22 03:38:53.849478 | controller | changed
2025-11-22 03:38:53.862283 | 
2025-11-22 03:38:53.862424 | TASK [Copy ci-framework interesting files]
2025-11-22 03:38:54.336855 | controller | cp: cannot stat '/home/zuul/ci-framework-data/logs': No such file or directory
2025-11-22 03:38:54.350431 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-11-22 03:38:54.419549 | controller | changed
2025-11-22 03:38:54.431214 | 
2025-11-22 03:38:54.431352 | TASK [Get SELinux listing]
2025-11-22 03:38:54.981496 | controller | changed
2025-11-22 03:38:54.994532 | 
2025-11-22 03:38:54.994670 | TASK [Generate log index]
2025-11-22 03:38:56.067041 | controller | changed
2025-11-22 03:38:56.078645 | 
2025-11-22 03:38:56.078819 | TASK [Get some env related data]
2025-11-22 03:38:56.812115 | controller | /home/zuul/.local/bin/ansible
2025-11-22 03:38:57.631756 | controller | changed
2025-11-22 03:38:57.644278 | 
2025-11-22 03:38:57.644413 | TASK [Generate list of logs to collect in home directory]
2025-11-22 03:38:58.094776 | controller | ok: All paths examined
2025-11-22 03:38:58.101922 | 
2025-11-22 03:38:58.102006 | LOOP [Copy logs from home directory]
2025-11-22 03:38:58.632947 | controller | changed:
2025-11-22 03:38:58.633310 | controller | {
2025-11-22 03:38:58.633383 | controller |   "atime": 1763782666.7590683,
2025-11-22 03:38:58.633444 | controller |   "ctime": 1763782731.019564,
2025-11-22 03:38:58.633484 | controller |   "dev": 64513,
2025-11-22 03:38:58.633540 | controller |   "gid": 1000,
2025-11-22 03:38:58.633579 | controller |   "gr_name": "zuul",
2025-11-22 03:38:58.633615 | controller |   "inode": 4333611,
2025-11-22 03:38:58.633654 | controller |   "isblk": false,
2025-11-22 03:38:58.633732 | controller |   "ischr": false,
2025-11-22 03:38:58.633772 | controller |   "isdir": false,
2025-11-22 03:38:58.633807 | controller |   "isfifo": false,
2025-11-22 03:38:58.633841 | controller |   "isgid": false,
2025-11-22 03:38:58.633876 | controller |   "islnk": false,
2025-11-22 03:38:58.633909 | controller |   "isreg": true,
2025-11-22 03:38:58.633942 | controller |   "issock": false,
2025-11-22 03:38:58.633975 | controller |   "isuid": false,
2025-11-22 03:38:58.634007 | controller |   "mode": "0644",
2025-11-22 03:38:58.634039 | controller |   "mtime": 1763782731.019564,
2025-11-22 03:38:58.634073 | controller |   "nlink": 1,
2025-11-22 03:38:58.634113 | controller |   "path": "/home/zuul/ansible.log",
2025-11-22 03:38:58.634150 | controller |   "pw_name": "zuul",
2025-11-22 03:38:58.634186 | controller |   "rgrp": true,
2025-11-22 03:38:58.634223 | controller |   "roth": true,
2025-11-22 03:38:58.634259 | controller |   "rusr": true,
2025-11-22 03:38:58.634295 | controller |   "size": 26485,
2025-11-22 03:38:58.634328 | controller |   "uid": 1000,
2025-11-22 03:38:58.634362 | controller |   "wgrp": false,
2025-11-22 03:38:58.634400 | controller |   "woth": false,
2025-11-22 03:38:58.634458 | controller |   "wusr": true,
2025-11-22 03:38:58.634496 | controller |   "xgrp": false,
2025-11-22 03:38:58.634532 | controller |   "xoth": false,
2025-11-22 03:38:58.634565 | controller |   "xusr": false
2025-11-22 03:38:58.634599 | controller | }
2025-11-22 03:38:58.649802 | 
2025-11-22 03:38:58.649944 | TASK [Copy crio stats log file]
2025-11-22 03:38:58.697959 | controller | skipping: Conditional result was False
2025-11-22 03:38:58.711495 | 
2025-11-22 03:38:58.711631 | TASK [Get SELinux related data]
2025-11-22 03:38:58.997976 | controller | <no matches>
2025-11-22 03:38:59.260820 | controller | ERROR
2025-11-22 03:38:59.261179 | controller | {
2025-11-22 03:38:59.261249 | controller |   "delta": "0:00:00.016210",
2025-11-22 03:38:59.261294 | controller |   "end": "2025-11-22 03:38:58.999584",
2025-11-22 03:38:59.261334 | controller |   "msg": "non-zero return code",
2025-11-22 03:38:59.261371 | controller |   "rc": 1,
2025-11-22 03:38:59.261408 | controller |   "start": "2025-11-22 03:38:58.983374"
2025-11-22 03:38:59.261444 | controller | }
2025-11-22 03:38:59.261494 | controller | ERROR: Ignoring Errors
2025-11-22 03:38:59.274585 | 
2025-11-22 03:38:59.274750 | TASK [Create system configuration directory]
2025-11-22 03:38:59.565849 | controller | changed
2025-11-22 03:38:59.578539 | 
2025-11-22 03:38:59.578709 | TASK [Get some of the system configurations]
2025-11-22 03:39:00.133964 | controller | changed
2025-11-22 03:39:00.146031 | 
2025-11-22 03:39:00.146167 | TASK [Copy generated documentation if available]
2025-11-22 03:39:00.186064 | controller | skipping: Conditional result was False
2025-11-22 03:39:00.200222 | 
2025-11-22 03:39:00.200453 | TASK [Copy generated AsciiDoc documentation if available]
2025-11-22 03:39:00.229566 | controller | skipping: Conditional result was False
2025-11-22 03:39:00.242326 | 
2025-11-22 03:39:00.242463 | TASK [Compress logs bigger than 2MB]
2025-11-22 03:39:00.790973 | controller | changed
2025-11-22 03:39:00.803520 | 
2025-11-22 03:39:00.803673 | TASK [Copy files from workspace on node]
2025-11-22 03:39:00.833179 | controller | ok
2025-11-22 03:39:00.878033 | 
2025-11-22 03:39:00.878152 | TASK [fetch-output : Set log path for multiple nodes]
2025-11-22 03:39:00.904593 | controller | skipping: Conditional result was False
2025-11-22 03:39:00.913624 | 
2025-11-22 03:39:00.913737 | TASK [fetch-output : Set log path for single node]
2025-11-22 03:39:00.955295 | controller | ok
2025-11-22 03:39:00.962190 | 
2025-11-22 03:39:00.962275 | LOOP [fetch-output : Ensure local output dirs]
2025-11-22 03:39:01.224830 | controller -> localhost | ok: "/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/logs"
2025-11-22 03:39:01.225277 | controller -> localhost | changed: All items complete
2025-11-22 03:39:01.225338 | 
2025-11-22 03:39:01.438539 | controller -> localhost | changed: "/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/artifacts"
2025-11-22 03:39:01.671169 | controller -> localhost | changed: "/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/docs"
2025-11-22 03:39:01.701128 | 
2025-11-22 03:39:01.701304 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-11-22 03:39:02.426019 | controller | changed:
2025-11-22 03:39:02.426531 | controller | .d..t...... ./
2025-11-22 03:39:02.426602 | controller | >f+++++++++ README.html
2025-11-22 03:39:02.426648 | controller | >f+++++++++ ansible.log
2025-11-22 03:39:02.426733 | controller | >f+++++++++ dmesg.log
2025-11-22 03:39:02.426778 | controller | >f+++++++++ installed-pkgs.log
2025-11-22 03:39:02.426822 | controller | >f+++++++++ python.log
2025-11-22 03:39:02.426862 | controller | >f+++++++++ registries.conf
2025-11-22 03:39:02.426899 | controller | >f+++++++++ selinux-denials.log
2025-11-22 03:39:02.426940 | controller | >f+++++++++ selinux-listing.log
2025-11-22 03:39:02.426978 | controller | cd+++++++++ ci-framework-data/
2025-11-22 03:39:02.427015 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-11-22 03:39:02.427053 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-11-22 03:39:02.427101 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-11-22 03:39:02.427140 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-11-22 03:39:02.427177 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2025-11-22 03:39:02.427214 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean-antelope-testing.repo
2025-11-22 03:39:02.427251 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo
2025-11-22 03:39:02.427287 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-appstream.repo
2025-11-22 03:39:02.427323 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-baseos.repo
2025-11-22 03:39:02.427360 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-highavailability.repo
2025-11-22 03:39:02.427395 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-powertools.repo
2025-11-22 03:39:02.427432 | controller | cd+++++++++ registries.conf.d/
2025-11-22 03:39:02.427468 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-11-22 03:39:02.427504 | controller | cd+++++++++ system-config/
2025-11-22 03:39:02.427539 | controller | cd+++++++++ system-config/libvirt/
2025-11-22 03:39:02.427575 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-11-22 03:39:02.427611 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-11-22 03:39:02.950731 | controller | changed: .d..t...... ./
2025-11-22 03:39:03.477746 | controller | changed: .d..t...... ./
2025-11-22 03:39:03.515487 | 
2025-11-22 03:39:03.515665 | TASK [Return artifact to Zuul]
2025-11-22 03:39:03.544627 | controller | skipping: Conditional result was False
2025-11-22 03:39:03.573502 | 
2025-11-22 03:39:03.573621 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-11-22 03:39:03.573780 | 
2025-11-22 03:39:03.573824 | PLAY RECAP
2025-11-22 03:39:03.573875 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1
2025-11-22 03:39:03.573902 | 
2025-11-22 03:39:03.689521 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-11-22 03:39:03.691302 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-11-22 03:39:04.282944 | 
2025-11-22 03:39:04.283050 | PLAY [all]
2025-11-22 03:39:04.301885 | 
2025-11-22 03:39:04.301956 | TASK [include_role : fetch-output]
2025-11-22 03:39:04.340605 | controller | ok
2025-11-22 03:39:04.364937 | 
2025-11-22 03:39:04.365034 | TASK [fetch-output : Set log path for multiple nodes]
2025-11-22 03:39:04.442641 | controller | skipping: Conditional result was False
2025-11-22 03:39:04.452148 | 
2025-11-22 03:39:04.452583 | TASK [fetch-output : Set log path for single node]
2025-11-22 03:39:04.523646 | controller | ok
2025-11-22 03:39:04.539485 | 
2025-11-22 03:39:04.539643 | LOOP [fetch-output : Ensure local output dirs]
2025-11-22 03:39:04.915418 | controller -> localhost | ok: "/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/logs"
2025-11-22 03:39:05.136905 | controller -> localhost | ok: "/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/artifacts"
2025-11-22 03:39:05.371377 | controller -> localhost | ok: "/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/docs"
2025-11-22 03:39:05.402267 | 
2025-11-22 03:39:05.402473 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-11-22 03:39:06.098516 | controller | ok
2025-11-22 03:39:06.098878 | controller | ok: All items complete
2025-11-22 03:39:06.098943 | 
2025-11-22 03:39:06.568754 | controller | ok
2025-11-22 03:39:07.064289 | controller | ok
2025-11-22 03:39:07.077954 | 
2025-11-22 03:39:07.078168 | TASK [include_role : fetch-output-openshift]
2025-11-22 03:39:07.092197 | controller | skipping: Conditional result was False
2025-11-22 03:39:07.098488 | 
2025-11-22 03:39:07.098554 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-11-22 03:39:07.530527 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007198
2025-11-22 03:39:07.789248 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007852
2025-11-22 03:39:07.822581 | 
2025-11-22 03:39:07.822716 | PLAY [all]
2025-11-22 03:39:07.837143 | 
2025-11-22 03:39:07.837206 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-11-22 03:39:08.350996 | controller | changed
2025-11-22 03:39:08.404252 | 
2025-11-22 03:39:08.404405 | PLAY RECAP
2025-11-22 03:39:08.404491 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-11-22 03:39:08.404535 | 
2025-11-22 03:39:08.514045 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-11-22 03:39:08.514869 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-11-22 03:39:09.132398 | 
2025-11-22 03:39:09.132514 | PLAY [localhost]
2025-11-22 03:39:09.149480 | 
2025-11-22 03:39:09.149554 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-11-22 03:39:09.508619 | localhost | changed
2025-11-22 03:39:09.522932 | 
2025-11-22 03:39:09.523133 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-11-22 03:39:09.557834 | localhost | ok
2025-11-22 03:39:09.577042 | 
2025-11-22 03:39:09.577184 | TASK [add-fileserver : Create SSH private key tempfile]
2025-11-22 03:39:09.931633 | localhost | changed
2025-11-22 03:39:09.939169 | 
2025-11-22 03:39:09.939237 | TASK [add-fileserver : Create SSH private key from secret]
2025-11-22 03:39:10.624081 | localhost | changed
2025-11-22 03:39:10.629270 | 
2025-11-22 03:39:10.629334 | TASK [add-fileserver : Add fileserver ssh key]
2025-11-22 03:39:11.063854 | localhost | Identity added: /var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/tmp/ansible.c5m75_dz (/var/lib/zuul/builds/a4e05e8b45564fd7b2be6be741e33e94/work/tmp/ansible.c5m75_dz)
2025-11-22 03:39:11.064088 | localhost | ok: Runtime: 0:00:00.012887
2025-11-22 03:39:11.069477 | 
2025-11-22 03:39:11.069553 | TASK [add-fileserver : Remove SSH private key from disk]
2025-11-22 03:39:11.364164 | localhost | ok: Runtime: 0:00:00.017113
2025-11-22 03:39:11.369319 | 
2025-11-22 03:39:11.369392 | TASK [add-fileserver : Add fileserver to inventory]
2025-11-22 03:39:11.443494 | localhost | changed
2025-11-22 03:39:11.453909 | 
2025-11-22 03:39:11.454061 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-11-22 03:39:11.883554 | localhost | changed
2025-11-22 03:39:11.929056 | 
2025-11-22 03:39:11.929256 | PLAY [localhost]
2025-11-22 03:39:11.948247 | 
2025-11-22 03:39:11.948352 | TASK [Generate bulk log download script]
2025-11-22 03:39:11.970400 | localhost | ok
2025-11-22 03:39:11.988806 | 
2025-11-22 03:39:11.988917 | TASK [local-log-download : Check API endpoint is defined]
2025-11-22 03:39:12.028989 | localhost | ok: All assertions passed
2025-11-22 03:39:12.045498 | 
2025-11-22 03:39:12.045629 | TASK [local-log-download : Create download script]
2025-11-22 03:39:12.482484 | localhost -> localhost | changed
2025-11-22 03:39:12.533262 | 
2025-11-22 03:39:12.533409 | TASK [Register quick-download link]
2025-11-22 03:39:12.555613 | localhost | ok
2025-11-22 03:39:12.576759 | 
2025-11-22 03:39:12.576832 | PLAY [logserver.rdoproject.org]
2025-11-22 03:39:12.590208 | 
2025-11-22 03:39:12.590288 | TASK [Set zuul-log-path fact]
2025-11-22 03:39:12.607096 | logserver.rdoproject.org | ok
2025-11-22 03:39:12.616402 | 
2025-11-22 03:39:12.616462 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-11-22 03:39:12.643006 | logserver.rdoproject.org | ok
2025-11-22 03:39:12.648213 | 
2025-11-22 03:39:12.648275 | TASK [upload-logs : Create log directories]
2025-11-22 03:39:13.550032 | logserver.rdoproject.org | changed
2025-11-22 03:39:13.558011 | 
2025-11-22 03:39:13.558146 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-11-22 03:39:13.903638 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.018301
2025-11-22 03:39:13.911717 | 
2025-11-22 03:39:13.911841 | TASK [upload-logs : Upload logs to log server]
2025-11-22 03:39:14.692791 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-11-22 03:39:14.697817 | 
2025-11-22 03:39:14.697912 | LOOP [upload-logs : Compress console log and json output]
2025-11-22 03:39:14.740397 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-22 03:39:14.749803 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-22 03:39:14.759425 | 
2025-11-22 03:39:14.759543 | LOOP [upload-logs : Upload compressed console log and json output]
2025-11-22 03:39:14.798814 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-22 03:39:14.799056 | 
2025-11-22 03:39:14.802964 | logserver.rdoproject.org | skipping: Conditional result was False
2025-11-22 03:39:14.813020 | 
2025-11-22 03:39:14.813125 | LOOP [upload-logs : Upload console log and json output]