2026-06-09 18:49:21.169530 | Job console starting
2026-06-09 18:49:21.311534 | Updating git repos
2026-06-09 18:49:21.373299 | Cloning repos into workspace
2026-06-09 18:49:23.785171 | Restoring repo states
2026-06-09 18:49:23.803745 | Merging changes
2026-06-09 18:49:24.846751 | Checking out repos
2026-06-09 18:49:25.495016 | Preparing playbooks
2026-06-09 18:49:30.314352 | Running Ansible setup
2026-06-09 18:49:35.358725 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-09 18:49:35.974448 | 
2026-06-09 18:49:35.974563 | PLAY [localhost]
2026-06-09 18:49:35.982119 | 
2026-06-09 18:49:35.982186 | TASK [Gathering Facts]
2026-06-09 18:49:36.924251 | localhost | ok
2026-06-09 18:49:36.938425 | 
2026-06-09 18:49:36.938661 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-09 18:49:37.402585 | localhost -> localhost | changed
2026-06-09 18:49:37.411124 | 
2026-06-09 18:49:37.411268 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-09 18:49:38.386702 | localhost -> localhost | changed
2026-06-09 18:49:38.394681 | 
2026-06-09 18:49:38.394775 | TASK [Setup log path fact]
2026-06-09 18:49:38.414351 | localhost | ok
2026-06-09 18:49:38.426555 | 
2026-06-09 18:49:38.426649 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-09 18:49:38.465525 | localhost | ok
2026-06-09 18:49:38.483493 | 
2026-06-09 18:49:38.483622 | TASK [emit-job-header : Print job information]
2026-06-09 18:49:38.532413 | # Job Information
2026-06-09 18:49:38.532593 | Ansible Version: 2.16.18
2026-06-09 18:49:38.532630 | Job: cifmw-molecule-ci_local_storage
2026-06-09 18:49:38.532657 | Pipeline: github-check
2026-06-09 18:49:38.532683 | Executor: 38.129.56.84
2026-06-09 18:49:38.532707 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3868
2026-06-09 18:49:38.532734 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/de6/rdoproject.org/de60de31b1af430fb8671de6adb16f19/
2026-06-09 18:49:38.532761 | Event ID: aad8f150-6433-11f1-8c03-28670ac22e47
2026-06-09 18:49:38.536631 | 
2026-06-09 18:49:38.536824 | LOOP [emit-job-header : Print node information]
2026-06-09 18:49:38.629416 | localhost | ok:
2026-06-09 18:49:38.630010 | localhost | # Node Information
2026-06-09 18:49:38.630078 | localhost | Inventory Hostname: controller
2026-06-09 18:49:38.630127 | localhost | Hostname: np0000068980
2026-06-09 18:49:38.630167 | localhost | Username: zuul
2026-06-09 18:49:38.630217 | localhost | Distro: CentOS 9
2026-06-09 18:49:38.630263 | localhost | Provider: vexxhost-nodepool-tripleo
2026-06-09 18:49:38.630300 | localhost | Region: RegionOne
2026-06-09 18:49:38.630336 | localhost | Label: centos-9-stream-crc-2-56-0-xl
2026-06-09 18:49:38.630371 | localhost | Product Name: OpenStack Nova
2026-06-09 18:49:38.630406 | localhost | Interface IP: 38.102.83.5
2026-06-09 18:49:38.641675 | 
2026-06-09 18:49:38.641830 | PLAY [all]
2026-06-09 18:49:38.652759 | 
2026-06-09 18:49:38.652923 | TASK [Gather network facts]
2026-06-09 18:49:39.255332 | controller | ok
2026-06-09 18:49:39.268985 | 
2026-06-09 18:49:39.269134 | TASK [include_role : start-zuul-console]
2026-06-09 18:49:39.290663 | controller | ok
2026-06-09 18:49:39.303964 | 
2026-06-09 18:49:39.304130 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-09 18:49:39.857984 | controller | ok
2026-06-09 18:49:39.872418 | 
2026-06-09 18:49:39.872563 | TASK [include_role : add-build-sshkey]
2026-06-09 18:49:39.905416 | controller | ok
2026-06-09 18:49:39.934077 | 
2026-06-09 18:49:39.934270 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-09 18:49:40.234967 | controller -> localhost | ok
2026-06-09 18:49:40.244655 | 
2026-06-09 18:49:40.244829 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-09 18:49:40.270609 | controller | ok
2026-06-09 18:49:40.303237 | controller | included: /var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-09 18:49:40.309590 | 
2026-06-09 18:49:40.309705 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-09 18:49:40.889668 | controller -> localhost | Generating public/private rsa key pair.
2026-06-09 18:49:40.889996 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/de60de31b1af430fb8671de6adb16f19_id_rsa
2026-06-09 18:49:40.890070 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/de60de31b1af430fb8671de6adb16f19_id_rsa.pub
2026-06-09 18:49:40.890122 | controller -> localhost | The key fingerprint is:
2026-06-09 18:49:40.890169 | controller -> localhost | SHA256:+GUePB72MnS5AoeQljPDnEO6UGi5HooymRwHzpy0tm4 zuul-build-sshkey
2026-06-09 18:49:40.890214 | controller -> localhost | The key's randomart image is:
2026-06-09 18:49:40.890257 | controller -> localhost | +---[RSA 3072]----+
2026-06-09 18:49:40.890297 | controller -> localhost | |   o. .          |
2026-06-09 18:49:40.890340 | controller -> localhost | | o+. = +         |
2026-06-09 18:49:40.890405 | controller -> localhost | |=.=.. &          |
2026-06-09 18:49:40.890453 | controller -> localhost | | Ooo o B o   .   |
2026-06-09 18:49:40.890494 | controller -> localhost | |+=+.. . S @ o    |
2026-06-09 18:49:40.890536 | controller -> localhost | |Bo.    . X * .   |
2026-06-09 18:49:40.890577 | controller -> localhost | |o.      . * o    |
2026-06-09 18:49:40.890624 | controller -> localhost | | E         +     |
2026-06-09 18:49:40.890664 | controller -> localhost | |.                |
2026-06-09 18:49:40.890703 | controller -> localhost | +----[SHA256]-----+
2026-06-09 18:49:40.890787 | controller -> localhost | ok: Runtime: 0:00:00.103495
2026-06-09 18:49:40.898731 | 
2026-06-09 18:49:40.898913 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-09 18:49:40.933757 | controller | ok
2026-06-09 18:49:40.950543 | controller | included: /var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-09 18:49:40.964720 | 
2026-06-09 18:49:40.964846 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-09 18:49:40.991152 | controller | skipping: Conditional result was False
2026-06-09 18:49:40.996768 | 
2026-06-09 18:49:40.996877 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-09 18:49:41.659834 | controller | changed
2026-06-09 18:49:41.667591 | 
2026-06-09 18:49:41.667730 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-09 18:49:42.071262 | controller | ok
2026-06-09 18:49:42.076206 | 
2026-06-09 18:49:42.076304 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-09 18:49:43.870056 | controller | changed
2026-06-09 18:49:43.877418 | 
2026-06-09 18:49:43.877545 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-09 18:49:45.685034 | controller | changed
2026-06-09 18:49:45.692299 | 
2026-06-09 18:49:45.692426 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-09 18:49:45.718737 | controller | skipping: Conditional result was False
2026-06-09 18:49:45.727808 | 
2026-06-09 18:49:45.728069 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-09 18:49:46.183748 | controller -> localhost | changed
2026-06-09 18:49:46.198048 | 
2026-06-09 18:49:46.198174 | TASK [add-build-sshkey : Add back temp key]
2026-06-09 18:49:46.556092 | controller -> localhost | Identity added: /var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/de60de31b1af430fb8671de6adb16f19_id_rsa (zuul-build-sshkey)
2026-06-09 18:49:46.556388 | controller -> localhost | ok: Runtime: 0:00:00.016360
2026-06-09 18:49:46.563795 | 
2026-06-09 18:49:46.563951 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-09 18:49:47.133255 | controller | ok
2026-06-09 18:49:47.139835 | 
2026-06-09 18:49:47.139996 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-09 18:49:47.176458 | controller | skipping: Conditional result was False
2026-06-09 18:49:47.189989 | 
2026-06-09 18:49:47.190120 | TASK [include_role : validate-host]
2026-06-09 18:49:47.226163 | controller | ok
2026-06-09 18:49:47.257884 | 
2026-06-09 18:49:47.257990 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-09 18:49:47.296613 | controller | ok
2026-06-09 18:49:47.302422 | 
2026-06-09 18:49:47.302512 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-09 18:49:47.620910 | controller -> localhost | ok
2026-06-09 18:49:47.630683 | 
2026-06-09 18:49:47.630820 | TASK [validate-host : Collect information about the host]
2026-06-09 18:49:48.539795 | controller | ok
2026-06-09 18:49:48.554395 | 
2026-06-09 18:49:48.554532 | TASK [validate-host : Sanitize hostname]
2026-06-09 18:49:48.626940 | controller | ok
2026-06-09 18:49:48.631564 | 
2026-06-09 18:49:48.631639 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-09 18:49:49.194202 | controller -> localhost | changed
2026-06-09 18:49:49.205180 | 
2026-06-09 18:49:49.205319 | TASK [validate-host : Collect information about zuul worker]
2026-06-09 18:49:49.774845 | controller | ok
2026-06-09 18:49:49.782053 | 
2026-06-09 18:49:49.782197 | TASK [validate-host : Write out all zuul information for each host]
2026-06-09 18:49:50.377417 | controller -> localhost | changed
2026-06-09 18:49:50.394644 | 
2026-06-09 18:49:50.394783 | TASK [include_role : prepare-workspace-openshift]
2026-06-09 18:49:50.421165 | controller | skipping: Conditional result was False
2026-06-09 18:49:50.428505 | 
2026-06-09 18:49:50.428638 | TASK [include_role : remove-zuul-sshkey]
2026-06-09 18:49:50.454936 | controller | skipping: Conditional result was False
2026-06-09 18:49:50.463589 | 
2026-06-09 18:49:50.463739 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-09 18:49:50.870825 | controller | ok: "logs"
2026-06-09 18:49:50.871115 | controller | ok: All items complete
2026-06-09 18:49:50.871152 | 
2026-06-09 18:49:51.260419 | controller | ok: "artifacts"
2026-06-09 18:49:51.634144 | controller | ok: "docs"
2026-06-09 18:49:51.646536 | 
2026-06-09 18:49:51.646723 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-09 18:49:52.062439 | controller | changed: "logs"
2026-06-09 18:49:52.452259 | controller | changed: "artifacts"
2026-06-09 18:49:52.863032 | controller | changed: "docs"
2026-06-09 18:49:52.877784 | 
2026-06-09 18:49:52.877976 | PLAY RECAP
2026-06-09 18:49:52.878061 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-09 18:49:52.878116 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-09 18:49:52.878155 | 
2026-06-09 18:49:53.035944 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-06-09 18:49:53.038235 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-09 18:49:53.680085 | 
2026-06-09 18:49:53.680309 | PLAY [all]
2026-06-09 18:49:53.698901 | 
2026-06-09 18:49:53.699150 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-09 18:49:53.754982 | controller | ok
2026-06-09 18:49:53.764700 | 
2026-06-09 18:49:53.764944 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-09 18:49:54.355430 | controller | changed
2026-06-09 18:49:54.364680 | 
2026-06-09 18:49:54.364890 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-09 18:49:56.430812 | controller | changed
2026-06-09 18:49:56.446944 | 
2026-06-09 18:49:56.447106 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-06-09 18:49:57.081713 | controller | changed:
2026-06-09 18:49:57.082040 | controller | {
2026-06-09 18:49:57.082097 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-06-09 18:49:57.082156 | controller | }
2026-06-09 18:49:57.492751 | controller | changed:
2026-06-09 18:49:57.492932 | controller | {
2026-06-09 18:49:57.492989 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-06-09 18:49:57.493032 | controller | }
2026-06-09 18:49:57.918844 | controller | changed:
2026-06-09 18:49:57.919024 | controller | {
2026-06-09 18:49:57.919093 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-06-09 18:49:57.919147 | controller | }
2026-06-09 18:49:58.355451 | controller | changed:
2026-06-09 18:49:58.355605 | controller | {
2026-06-09 18:49:58.355657 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-06-09 18:49:58.355698 | controller | }
2026-06-09 18:49:58.787500 | controller | changed:
2026-06-09 18:49:58.787659 | controller | {
2026-06-09 18:49:58.787709 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-06-09 18:49:58.787748 | controller | }
2026-06-09 18:49:59.207133 | controller | changed:
2026-06-09 18:49:59.207291 | controller | {
2026-06-09 18:49:59.207343 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-06-09 18:49:59.207386 | controller | }
2026-06-09 18:49:59.632167 | controller | changed:
2026-06-09 18:49:59.632344 | controller | {
2026-06-09 18:49:59.632394 | 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"
2026-06-09 18:49:59.632434 | controller | }
2026-06-09 18:50:00.055553 | controller | changed:
2026-06-09 18:50:00.055721 | controller | {
2026-06-09 18:50:00.055773 | 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"
2026-06-09 18:50:00.055833 | controller | }
2026-06-09 18:50:00.495477 | controller | changed:
2026-06-09 18:50:00.495646 | controller | {
2026-06-09 18:50:00.495700 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-06-09 18:50:00.495743 | controller | }
2026-06-09 18:50:00.955144 | controller | changed:
2026-06-09 18:50:00.955303 | controller | {
2026-06-09 18:50:00.955354 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-06-09 18:50:00.955396 | controller | }
2026-06-09 18:50:01.387532 | controller | changed:
2026-06-09 18:50:01.387700 | controller | {
2026-06-09 18:50:01.387765 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-06-09 18:50:01.387816 | controller | }
2026-06-09 18:50:01.849548 | controller | changed:
2026-06-09 18:50:01.849691 | controller | {
2026-06-09 18:50:01.849765 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-06-09 18:50:01.849810 | controller | }
2026-06-09 18:50:02.295674 | controller | changed:
2026-06-09 18:50:02.295987 | controller | {
2026-06-09 18:50:02.296044 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com"
2026-06-09 18:50:02.296086 | controller | }
2026-06-09 18:50:02.690592 | controller | changed:
2026-06-09 18:50:02.690742 | controller | {
2026-06-09 18:50:02.690794 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-06-09 18:50:02.690834 | controller | }
2026-06-09 18:50:03.077988 | controller | changed:
2026-06-09 18:50:03.078155 | controller | {
2026-06-09 18:50:03.078212 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-06-09 18:50:03.078254 | controller | }
2026-06-09 18:50:03.500763 | controller | changed:
2026-06-09 18:50:03.500913 | controller | {
2026-06-09 18:50:03.500962 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-06-09 18:50:03.501000 | controller | }
2026-06-09 18:50:03.972032 | controller | changed:
2026-06-09 18:50:03.972175 | controller | {
2026-06-09 18:50:03.972226 | 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"
2026-06-09 18:50:03.972268 | controller | }
2026-06-09 18:50:04.400761 | controller | changed:
2026-06-09 18:50:04.400960 | controller | {
2026-06-09 18:50:04.401041 | 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"
2026-06-09 18:50:04.401201 | controller | }
2026-06-09 18:50:04.807785 | controller | changed:
2026-06-09 18:50:04.807969 | controller | {
2026-06-09 18:50:04.808021 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-06-09 18:50:04.808061 | controller | }
2026-06-09 18:50:05.262657 | controller | changed:
2026-06-09 18:50:05.262766 | controller | {
2026-06-09 18:50:05.262793 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-06-09 18:50:05.262820 | controller | }
2026-06-09 18:50:05.691833 | controller | changed:
2026-06-09 18:50:05.692022 | controller | {
2026-06-09 18:50:05.692045 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-06-09 18:50:05.692064 | controller | }
2026-06-09 18:50:06.112256 | controller | changed:
2026-06-09 18:50:06.112991 | controller | {
2026-06-09 18:50:06.113040 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-06-09 18:50:06.113068 | controller | }
2026-06-09 18:50:06.553203 | controller | changed:
2026-06-09 18:50:06.553347 | controller | {
2026-06-09 18:50:06.553396 | 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"
2026-06-09 18:50:06.553438 | controller | }
2026-06-09 18:50:06.999148 | controller | changed:
2026-06-09 18:50:06.999287 | controller | {
2026-06-09 18:50:06.999337 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-06-09 18:50:06.999378 | controller | }
2026-06-09 18:50:07.427217 | controller | changed:
2026-06-09 18:50:07.427392 | controller | {
2026-06-09 18:50:07.427459 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-06-09 18:50:07.427503 | controller | }
2026-06-09 18:50:07.861354 | controller | changed:
2026-06-09 18:50:07.861518 | controller | {
2026-06-09 18:50:07.861581 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-06-09 18:50:07.861633 | controller | }
2026-06-09 18:50:07.904897 | 
2026-06-09 18:50:07.905091 | TASK [Set timezone to UTC]
2026-06-09 18:50:08.649007 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-06-09 18:50:08.656482 | 
2026-06-09 18:50:08.656615 | TASK [Create nodepool directory]
2026-06-09 18:50:09.097895 | controller | changed
2026-06-09 18:50:09.109248 | 
2026-06-09 18:50:09.109386 | TASK [Create nodepool sub_nodes file]
2026-06-09 18:50:10.731895 | controller | changed
2026-06-09 18:50:10.736890 | 
2026-06-09 18:50:10.736972 | TASK [Create nodepool sub_nodes_private file]
2026-06-09 18:50:12.399215 | controller | changed
2026-06-09 18:50:12.408737 | 
2026-06-09 18:50:12.409000 | LOOP [Populate nodepool sub_nodes file]
2026-06-09 18:50:12.457875 | 
2026-06-09 18:50:12.458182 | LOOP [Populate nodepool sub_nodes_private file]
2026-06-09 18:50:12.517009 | 
2026-06-09 18:50:12.517322 | TASK [Create nodepool primary file]
2026-06-09 18:50:12.544744 | controller | skipping: Conditional result was False
2026-06-09 18:50:12.559760 | 
2026-06-09 18:50:12.560025 | TASK [Create nodepool node_private for this node]
2026-06-09 18:50:14.239536 | controller | changed
2026-06-09 18:50:14.248985 | 
2026-06-09 18:50:14.249128 | LOOP [Copy ssh keys to nodepool directory]
2026-06-09 18:50:14.869405 | controller | ok: Item: id_rsa Runtime: 0:00:00.008796
2026-06-09 18:50:14.869728 | 
2026-06-09 18:50:15.234690 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.008536
2026-06-09 18:50:15.251636 | 
2026-06-09 18:50:15.251845 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-06-09 18:50:16.869623 | controller | changed
2026-06-09 18:50:16.877212 | 
2026-06-09 18:50:16.877340 | TASK [Validate sudoers config after edits]
2026-06-09 18:50:17.331787 | controller | /etc/sudoers: parsed OK
2026-06-09 18:50:17.331956 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-06-09 18:50:17.331977 | controller | /etc/sudoers.d/zuul: parsed OK
2026-06-09 18:50:17.331986 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-06-09 18:50:17.417107 | controller | ok: Runtime: 0:00:00.009074
2026-06-09 18:50:17.425469 | 
2026-06-09 18:50:17.425595 | TASK [Show the environment passed in to job shell scripts]
2026-06-09 18:50:17.863838 | controller | SHELL=/bin/bash
2026-06-09 18:50:17.864034 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-06-09 18:50:17.864054 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-06-09 18:50:17.864069 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/68/3868/19e61090ad44008046333639aa9a672fbf50b86c
2026-06-09 18:50:17.864080 | controller | PWD=/home/zuul
2026-06-09 18:50:17.864089 | controller | ZUUL_PIPELINE=github-check
2026-06-09 18:50:17.864103 | controller | LOGNAME=zuul
2026-06-09 18:50:17.864112 | controller | XDG_SESSION_TYPE=tty
2026-06-09 18:50:17.864120 | controller | _=/usr/bin/env
2026-06-09 18:50:17.864134 | controller | MOTD_SHOWN=pam
2026-06-09 18:50:17.864143 | controller | HOME=/home/zuul
2026-06-09 18:50:17.864151 | controller | LANG=en_US.UTF-8
2026-06-09 18:50:17.864161 | controller | SSH_CONNECTION=38.129.56.84 45608 38.102.83.5 22
2026-06-09 18:50:17.864171 | 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
2026-06-09 18:50:17.864181 | controller | ZUUL_CHANGE_IDS=3868,19e61090ad44008046333639aa9a672fbf50b86c
2026-06-09 18:50:17.864191 | controller | WORKSPACE=/home/zuul/workspace
2026-06-09 18:50:17.864199 | controller | XDG_SESSION_CLASS=user
2026-06-09 18:50:17.864208 | controller | SELINUX_ROLE_REQUESTED=
2026-06-09 18:50:17.864216 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-06-09 18:50:17.864225 | controller | USER=zuul
2026-06-09 18:50:17.864234 | controller | ZUUL_VOTING=True
2026-06-09 18:50:17.864242 | controller | BUILD_TIMEOUT=1800000
2026-06-09 18:50:17.864250 | controller | SELINUX_USE_CURRENT_RANGE=
2026-06-09 18:50:17.864258 | controller | SHLVL=1
2026-06-09 18:50:17.864267 | controller | ZUUL_PATCHSET=19e61090ad44008046333639aa9a672fbf50b86c
2026-06-09 18:50:17.864275 | controller | XDG_SESSION_ID=1
2026-06-09 18:50:17.864283 | controller | ZUUL_BRANCH=main
2026-06-09 18:50:17.864291 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-06-09 18:50:17.864300 | controller | SSH_CLIENT=38.129.56.84 45608 22
2026-06-09 18:50:17.864313 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-06-09 18:50:17.864322 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-06-09 18:50:17.864330 | controller | which_declare=declare -f
2026-06-09 18:50:17.864339 | controller | PATH=/home/zuul/.crc/bin/oc:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-06-09 18:50:17.864348 | controller | SELINUX_LEVEL_REQUESTED=
2026-06-09 18:50:17.864356 | controller | ZUUL_CHANGE=3868
2026-06-09 18:50:17.864364 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-06-09 18:50:17.864373 | controller | ZUUL_UUID=de60de31b1af430fb8671de6adb16f19
2026-06-09 18:50:17.864382 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-06-09 18:50:17.864390 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-06-09 18:50:17.864400 | controller | }
2026-06-09 18:50:17.972126 | controller | ok: Runtime: 0:00:00.010373
2026-06-09 18:50:17.980453 | 
2026-06-09 18:50:17.980590 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-06-09 18:50:18.007214 | controller | skipping: Conditional result was False
2026-06-09 18:50:18.016545 | 
2026-06-09 18:50:18.016674 | TASK [Symlink /home/zuul-worker/workspace]
2026-06-09 18:50:18.556272 | controller | skipping: Conditional result was False
2026-06-09 18:50:18.567470 | 
2026-06-09 18:50:18.567614 | TASK [Ensure legacy workspace directory]
2026-06-09 18:50:18.959573 | controller | changed
2026-06-09 18:50:18.963551 | 
2026-06-09 18:50:18.963680 | PLAY RECAP
2026-06-09 18:50:18.963800 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-09 18:50:18.963900 | 
2026-06-09 18:50:19.107276 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-06-09 18:50:19.109995 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-09 18:50:19.681782 | 
2026-06-09 18:50:19.681908 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-06-09 18:50:19.692542 | 
2026-06-09 18:50:19.692611 | TASK [Create zuul-output directory]
2026-06-09 18:50:20.231812 | controller | changed
2026-06-09 18:50:20.241378 | 
2026-06-09 18:50:20.241526 | TASK [Slurp Zuul inventory test]
2026-06-09 18:50:20.714518 | controller -> localhost | ok
2026-06-09 18:50:20.725547 | 
2026-06-09 18:50:20.725694 | TASK [Save zuul inventory]
2026-06-09 18:50:22.668953 | controller | changed
2026-06-09 18:50:22.677876 | 
2026-06-09 18:50:22.678073 | TASK [Save zuul vars without the change_message]
2026-06-09 18:50:24.385493 | controller | changed
2026-06-09 18:50:24.387829 | 
2026-06-09 18:50:24.387958 | PLAY RECAP
2026-06-09 18:50:24.388221 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-09 18:50:24.388263 | 
2026-06-09 18:50:24.558583 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-06-09 18:50:24.560971 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-09 18:50:25.250778 | 
2026-06-09 18:50:25.250919 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-06-09 18:50:25.262681 | 
2026-06-09 18:50:25.262821 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-06-09 18:50:25.291360 | controller | ok
2026-06-09 18:50:25.308350 | 
2026-06-09 18:50:25.308523 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-06-09 18:50:25.355309 | controller | skipping: Conditional result was False
2026-06-09 18:50:25.363149 | 
2026-06-09 18:50:25.363280 | TASK [mirror-info-fork : Create /etc/ci]
2026-06-09 18:50:25.927902 | controller | ok
2026-06-09 18:50:25.932362 | 
2026-06-09 18:50:25.932432 | TASK [mirror-info-fork : Install ci_mirror script]
2026-06-09 18:50:27.321419 | controller | ok
2026-06-09 18:50:27.336536 | 
2026-06-09 18:50:27.336704 | TASK [Prepare workspace]
2026-06-09 18:50:27.361360 | controller | ok
2026-06-09 18:50:27.385319 | 
2026-06-09 18:50:27.385484 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-09 18:50:27.952049 | controller | ok
2026-06-09 18:50:27.962982 | 
2026-06-09 18:50:27.963123 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-09 18:50:30.318760 | controller | Output suppressed because no_log was given
2026-06-09 18:50:30.325301 | 
2026-06-09 18:50:30.325364 | LOOP [Create zuul-output directory]
2026-06-09 18:50:30.726733 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-06-09 18:50:31.031612 | controller | ok: "/home/zuul/zuul-output/logs"
2026-06-09 18:50:31.050422 | 
2026-06-09 18:50:31.050619 | TASK [Install required packages]
2026-06-09 18:50:46.258934 | controller | ok: Nothing to do
2026-06-09 18:50:46.267627 | 
2026-06-09 18:50:46.267823 | TASK [Install venv]
2026-06-09 18:52:16.180572 | controller | changed
2026-06-09 18:52:16.194820 | 
2026-06-09 18:52:16.194995 | PLAY RECAP
2026-06-09 18:52:16.195072 | controller | ok: 7 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-09 18:52:16.195109 | 
2026-06-09 18:52:16.312318 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-06-09 18:52:16.315101 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-09 18:52:17.017219 | 
2026-06-09 18:52:17.017333 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-06-09 18:52:17.029963 | 
2026-06-09 18:52:17.030051 | TASK [Gather required facts]
2026-06-09 18:52:17.756807 | controller | ok
2026-06-09 18:52:17.768180 | 
2026-06-09 18:52:17.768351 | TASK [Load environment var if instructed to]
2026-06-09 18:52:17.805708 | controller | skipping: Conditional result was False
2026-06-09 18:52:17.815412 | 
2026-06-09 18:52:17.815572 | TASK [Ensure group_vars dir exists]
2026-06-09 18:52:18.373597 | controller | ok
2026-06-09 18:52:18.384945 | 
2026-06-09 18:52:18.385119 | TASK [Print related variables]
2026-06-09 18:52:18.433307 | controller | ok:
2026-06-09 18:52:18.433603 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-06-09 18:52:18.433667 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_local_storage
2026-06-09 18:52:18.439955 | 
2026-06-09 18:52:18.440118 | TASK [Run molecule]
2026-06-09 18:52:19.732323 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-06-09 18:52:19.804764 | controller | INFO     Performing prerun with role_name_check=0...
2026-06-09 18:52:48.121536 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.122518 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.123507 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.124485 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.125544 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+19e61090 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.0.0+19e61090 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.126530 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.127477 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.128428 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.129351 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.130299 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.131247 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.132208 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.133473 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.134410 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.135366 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/fc7f8d/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-06-09 18:52:48.157543 | controller | INFO     Running default > prepare
2026-06-09 18:52:48.907010 | controller |
2026-06-09 18:52:48.907247 | controller | PLAY [Prepare] *****************************************************************
2026-06-09 18:52:48.907487 | controller |
2026-06-09 18:52:48.907707 | controller | TASK [Gathering Facts] *********************************************************
2026-06-09 18:52:48.907997 | controller | Tuesday 09 June 2026  18:52:48 +0000 (0:00:00.013)       0:00:00.013 **********
2026-06-09 18:52:50.047361 | controller | ok: [instance]
2026-06-09 18:52:50.047495 | controller |
2026-06-09 18:52:50.047718 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2026-06-09 18:52:50.047945 | controller | Tuesday 09 June 2026  18:52:50 +0000 (0:00:01.141)       0:00:01.154 **********
2026-06-09 18:52:50.076782 | controller | skipping: [instance]
2026-06-09 18:52:50.076956 | controller |
2026-06-09 18:52:50.077202 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2026-06-09 18:52:50.077398 | controller | Tuesday 09 June 2026  18:52:50 +0000 (0:00:00.030)       0:00:01.184 **********
2026-06-09 18:52:50.155388 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2026-06-09 18:52:50.155550 | controller |
2026-06-09 18:52:50.155894 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2026-06-09 18:52:50.156126 | controller | Tuesday 09 June 2026  18:52:50 +0000 (0:00:00.078)       0:00:01.263 **********
2026-06-09 18:52:50.547916 | controller | ok: [instance]
2026-06-09 18:52:50.547999 | controller |
2026-06-09 18:52:50.548010 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2026-06-09 18:52:50.548149 | controller | Tuesday 09 June 2026  18:52:50 +0000 (0:00:00.392)       0:00:01.655 **********
2026-06-09 18:52:50.978176 | controller | ok: [instance]
2026-06-09 18:52:50.978317 | controller |
2026-06-09 18:52:50.978528 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2026-06-09 18:52:50.978737 | controller | Tuesday 09 June 2026  18:52:50 +0000 (0:00:00.430)       0:00:02.085 **********
2026-06-09 18:52:51.941682 | controller | ok: [instance] => (item=ubi-9-appstream)
2026-06-09 18:52:51.941739 | controller | ok: [instance] => (item=ubi-9-baseos)
2026-06-09 18:52:51.941753 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2026-06-09 18:52:51.941858 | controller |
2026-06-09 18:52:51.941968 | controller | TASK [Deploy repo-setup] *******************************************************
2026-06-09 18:52:51.942072 | controller | Tuesday 09 June 2026  18:52:51 +0000 (0:00:00.964)       0:00:03.049 **********
2026-06-09 18:52:52.041570 | controller |
2026-06-09 18:52:52.041721 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-06-09 18:52:52.041974 | controller | Tuesday 09 June 2026  18:52:52 +0000 (0:00:00.100)       0:00:03.149 **********
2026-06-09 18:52:52.801576 | controller | changed: [instance] => (item=tmp)
2026-06-09 18:52:52.801630 | controller | changed: [instance] => (item=artifacts/repositories)
2026-06-09 18:52:52.801723 | controller | changed: [instance] => (item=venv/repo_setup)
2026-06-09 18:52:52.801829 | controller |
2026-06-09 18:52:52.802004 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-06-09 18:52:52.802035 | controller | Tuesday 09 June 2026  18:52:52 +0000 (0:00:00.759)       0:00:03.909 **********
2026-06-09 18:52:53.849182 | controller | ok: [instance]
2026-06-09 18:52:53.849303 | controller |
2026-06-09 18:52:53.849815 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-06-09 18:52:53.849906 | controller | Tuesday 09 June 2026  18:52:53 +0000 (0:00:01.047)       0:00:04.957 **********
2026-06-09 18:52:55.037084 | controller | changed: [instance]
2026-06-09 18:52:55.037125 | controller |
2026-06-09 18:52:55.037136 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-06-09 18:52:55.037318 | controller | Tuesday 09 June 2026  18:52:55 +0000 (0:00:01.187)       0:00:06.144 **********
2026-06-09 18:53:02.091279 | controller | changed: [instance]
2026-06-09 18:53:02.091319 | controller |
2026-06-09 18:53:02.091343 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-06-09 18:53:02.091352 | controller | Tuesday 09 June 2026  18:53:02 +0000 (0:00:07.054)       0:00:13.198 **********
2026-06-09 18:53:03.033035 | controller | changed: [instance]
2026-06-09 18:53:03.033060 | controller |
2026-06-09 18:53:03.033064 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-06-09 18:53:03.033068 | controller | Tuesday 09 June 2026  18:53:03 +0000 (0:00:00.942)       0:00:14.141 **********
2026-06-09 18:53:03.059281 | controller | skipping: [instance]
2026-06-09 18:53:03.059305 | controller |
2026-06-09 18:53:03.059310 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-06-09 18:53:03.059315 | controller | Tuesday 09 June 2026  18:53:03 +0000 (0:00:00.026)       0:00:14.167 **********
2026-06-09 18:53:04.709041 | controller | changed: [instance]
2026-06-09 18:53:04.709085 | controller |
2026-06-09 18:53:04.709096 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-06-09 18:53:04.709111 | controller | Tuesday 09 June 2026  18:53:04 +0000 (0:00:01.648)       0:00:15.816 **********
2026-06-09 18:53:04.774153 | controller | skipping: [instance]
2026-06-09 18:53:04.774199 | controller |
2026-06-09 18:53:04.774562 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-06-09 18:53:04.774603 | controller | Tuesday 09 June 2026  18:53:04 +0000 (0:00:00.065)       0:00:15.881 **********
2026-06-09 18:53:04.832091 | controller | skipping: [instance]
2026-06-09 18:53:04.832174 | controller |
2026-06-09 18:53:04.832508 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-06-09 18:53:04.832533 | controller | Tuesday 09 June 2026  18:53:04 +0000 (0:00:00.058)       0:00:15.939 **********
2026-06-09 18:53:04.887753 | controller | skipping: [instance]
2026-06-09 18:53:04.887829 | controller |
2026-06-09 18:53:04.888138 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-06-09 18:53:04.888159 | controller | Tuesday 09 June 2026  18:53:04 +0000 (0:00:00.055)       0:00:15.995 **********
2026-06-09 18:53:05.373953 | controller | changed: [instance]
2026-06-09 18:53:05.373994 | controller |
2026-06-09 18:53:05.374004 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-06-09 18:53:05.374013 | controller | Tuesday 09 June 2026  18:53:05 +0000 (0:00:00.484)       0:00:16.480 **********
2026-06-09 18:53:05.985966 | controller | changed: [instance]
2026-06-09 18:53:05.986009 | controller |
2026-06-09 18:53:05.986020 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-06-09 18:53:05.986029 | controller | Tuesday 09 June 2026  18:53:05 +0000 (0:00:00.611)       0:00:17.092 **********
2026-06-09 18:53:06.039080 | controller | skipping: [instance]
2026-06-09 18:53:06.039136 | controller |
2026-06-09 18:53:06.039147 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-06-09 18:53:06.039157 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.053)       0:00:17.146 **********
2026-06-09 18:53:06.091102 | controller | skipping: [instance]
2026-06-09 18:53:06.091189 | controller |
2026-06-09 18:53:06.091468 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-06-09 18:53:06.091779 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.052)       0:00:17.198 **********
2026-06-09 18:53:06.141422 | controller | skipping: [instance]
2026-06-09 18:53:06.141460 | controller |
2026-06-09 18:53:06.141656 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-06-09 18:53:06.141918 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.050)       0:00:17.248 **********
2026-06-09 18:53:06.216009 | controller | ok: [instance]
2026-06-09 18:53:06.216342 | controller |
2026-06-09 18:53:06.216599 | controller | TASK [repo_setup : Create download directory] **********************************
2026-06-09 18:53:06.216840 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.074)       0:00:17.323 **********
2026-06-09 18:53:06.265518 | controller | skipping: [instance]
2026-06-09 18:53:06.265795 | controller |
2026-06-09 18:53:06.266129 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-06-09 18:53:06.266416 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.050)       0:00:17.373 **********
2026-06-09 18:53:06.317399 | controller | skipping: [instance]
2026-06-09 18:53:06.317656 | controller |
2026-06-09 18:53:06.317852 | controller | TASK [Download the RPM] ********************************************************
2026-06-09 18:53:06.318127 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.051)       0:00:17.425 **********
2026-06-09 18:53:06.361429 | controller | skipping: [instance]
2026-06-09 18:53:06.361634 | controller |
2026-06-09 18:53:06.361909 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-06-09 18:53:06.362147 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.044)       0:00:17.469 **********
2026-06-09 18:53:06.401497 | controller | skipping: [instance]
2026-06-09 18:53:06.401699 | controller |
2026-06-09 18:53:06.401991 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-06-09 18:53:06.402263 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.039)       0:00:17.509 **********
2026-06-09 18:53:06.448529 | controller | skipping: [instance]
2026-06-09 18:53:06.448731 | controller |
2026-06-09 18:53:06.449037 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-06-09 18:53:06.449381 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.047)       0:00:17.556 **********
2026-06-09 18:53:06.496802 | controller | skipping: [instance]
2026-06-09 18:53:06.496840 | controller |
2026-06-09 18:53:06.497029 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-06-09 18:53:06.497284 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.048)       0:00:17.605 **********
2026-06-09 18:53:06.545646 | controller | skipping: [instance]
2026-06-09 18:53:06.545931 | controller |
2026-06-09 18:53:06.546153 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-06-09 18:53:06.546409 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.048)       0:00:17.653 **********
2026-06-09 18:53:06.806736 | controller | ok: [instance]
2026-06-09 18:53:06.806794 | controller |
2026-06-09 18:53:06.806799 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-06-09 18:53:06.806803 | controller | Tuesday 09 June 2026  18:53:06 +0000 (0:00:00.260)       0:00:17.913 **********
2026-06-09 18:53:07.101267 | controller | changed: [instance]
2026-06-09 18:53:07.101319 | controller |
2026-06-09 18:53:07.101334 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-06-09 18:53:07.101347 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.294)       0:00:18.208 **********
2026-06-09 18:53:07.435282 | controller | changed: [instance]
2026-06-09 18:53:07.435326 | controller |
2026-06-09 18:53:07.435337 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-06-09 18:53:07.435345 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.334)       0:00:18.542 **********
2026-06-09 18:53:07.471588 | controller | skipping: [instance]
2026-06-09 18:53:07.471613 | controller |
2026-06-09 18:53:07.471622 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-06-09 18:53:07.471630 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.037)       0:00:18.579 **********
2026-06-09 18:53:07.508905 | controller | skipping: [instance]
2026-06-09 18:53:07.508931 | controller |
2026-06-09 18:53:07.508939 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-06-09 18:53:07.508947 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.037)       0:00:18.616 **********
2026-06-09 18:53:07.547294 | controller | skipping: [instance]
2026-06-09 18:53:07.547332 | controller |
2026-06-09 18:53:07.547343 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-06-09 18:53:07.547351 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.038)       0:00:18.655 **********
2026-06-09 18:53:07.586515 | controller | skipping: [instance]
2026-06-09 18:53:07.586744 | controller |
2026-06-09 18:53:07.586942 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-06-09 18:53:07.587215 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.039)       0:00:18.694 **********
2026-06-09 18:53:07.625982 | controller | skipping: [instance]
2026-06-09 18:53:07.626360 | controller |
2026-06-09 18:53:07.626583 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-06-09 18:53:07.626731 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.039)       0:00:18.734 **********
2026-06-09 18:53:07.664092 | controller | skipping: [instance]
2026-06-09 18:53:07.664248 | controller |
2026-06-09 18:53:07.664448 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-06-09 18:53:07.664645 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.038)       0:00:18.772 **********
2026-06-09 18:53:07.691706 | controller | skipping: [instance]
2026-06-09 18:53:07.691903 | controller |
2026-06-09 18:53:07.692112 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-06-09 18:53:07.692314 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.027)       0:00:18.800 **********
2026-06-09 18:53:07.742614 | controller | skipping: [instance]
2026-06-09 18:53:07.742742 | controller |
2026-06-09 18:53:07.742973 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-06-09 18:53:07.743162 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.050)       0:00:18.850 **********
2026-06-09 18:53:07.770348 | controller | skipping: [instance]
2026-06-09 18:53:07.770477 | controller |
2026-06-09 18:53:07.770733 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-06-09 18:53:07.770916 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.027)       0:00:18.878 **********
2026-06-09 18:53:07.806627 | controller | skipping: [instance]
2026-06-09 18:53:07.806701 | controller |
2026-06-09 18:53:07.806912 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2026-06-09 18:53:07.807113 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.036)       0:00:18.914 **********
2026-06-09 18:53:07.858261 | controller | skipping: [instance]
2026-06-09 18:53:07.858412 | controller |
2026-06-09 18:53:07.858613 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2026-06-09 18:53:07.858830 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.051)       0:00:18.966 **********
2026-06-09 18:53:07.916325 | controller | skipping: [instance]
2026-06-09 18:53:07.916489 | controller |
2026-06-09 18:53:07.916686 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2026-06-09 18:53:07.916907 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.058)       0:00:19.024 **********
2026-06-09 18:53:07.976460 | controller | skipping: [instance]
2026-06-09 18:53:07.976621 | controller |
2026-06-09 18:53:07.976888 | controller | TASK [test_deps : Install additional packages] *********************************
2026-06-09 18:53:07.977218 | controller | Tuesday 09 June 2026  18:53:07 +0000 (0:00:00.058)       0:00:19.083 **********
2026-06-09 18:53:08.019479 | controller | skipping: [instance]
2026-06-09 18:53:08.019619 | controller |
2026-06-09 18:53:08.019826 | controller | TASK [test_deps : Install selinux python libs] *********************************
2026-06-09 18:53:08.020093 | controller | Tuesday 09 June 2026  18:53:08 +0000 (0:00:00.043)       0:00:19.126 **********
2026-06-09 18:53:48.710407 | controller | ok: [instance]
2026-06-09 18:53:48.710490 | controller |
2026-06-09 18:53:48.711007 | controller | TASK [test_deps : Install python yaml libs] ************************************
2026-06-09 18:53:48.711045 | controller | Tuesday 09 June 2026  18:53:48 +0000 (0:00:40.690)       0:00:59.817 **********
2026-06-09 18:53:50.193908 | controller | ok: [instance]
2026-06-09 18:53:50.193961 | controller |
2026-06-09 18:53:50.193973 | controller | TASK [test_deps : Install extra packages] **************************************
2026-06-09 18:53:50.193981 | controller | Tuesday 09 June 2026  18:53:50 +0000 (0:00:01.484)       0:01:01.301 **********
2026-06-09 18:53:50.252527 | controller | skipping: [instance]
2026-06-09 18:53:50.252580 | controller |
2026-06-09 18:53:50.252591 | controller | TASK [Start CRC] ***************************************************************
2026-06-09 18:53:50.252599 | controller | Tuesday 09 June 2026  18:53:50 +0000 (0:00:00.058)       0:01:01.360 **********
2026-06-09 18:53:50.294260 | controller |
2026-06-09 18:53:50.294300 | controller | TASK [cifmw_helpers : Ensure CRC is started] ***********************************
2026-06-09 18:53:50.294311 | controller | Tuesday 09 June 2026  18:53:50 +0000 (0:00:00.041)       0:01:01.402 **********
2026-06-09 19:05:31.406648 | controller | changed: [instance]
2026-06-09 19:05:31.409368 | controller |
2026-06-09 19:05:31.409406 | controller | TASK [cifmw_helpers : Login to the OpenShift when certificate is expired] ******
2026-06-09 19:05:31.409428 | controller | Tuesday 09 June 2026  19:05:31 +0000 (0:11:41.112)       0:12:42.514 **********
2026-06-09 19:19:36.729088 | RUN END RESULT_TIMED_OUT: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-06-09 19:19:36.732464 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-09 19:19:37.425910 | 
2026-06-09 19:19:37.426056 | PLAY [Ensure ci-framework-data base directories exist on all nodes]
2026-06-09 19:19:37.437006 | 
2026-06-09 19:19:37.437082 | TASK [Create ci-framework-data/logs directory if missing]
2026-06-09 19:19:38.002008 | controller | ok
2026-06-09 19:19:38.029065 | 
2026-06-09 19:19:38.029246 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-06-09 19:19:38.035275 | 
2026-06-09 19:19:38.035465 | TASK [Filter out host if needed]
2026-06-09 19:19:38.044948 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-06-09 19:19:38.048287 | 
2026-06-09 19:19:38.048345 | TASK [Ensure file is present]
2026-06-09 19:19:38.536953 | controller | ok
2026-06-09 19:19:38.547918 | 
2026-06-09 19:19:38.548052 | TASK [Manage molecule report file]
2026-06-09 19:19:39.087647 | controller | skipping: Conditional result was False
2026-06-09 19:19:39.096623 | 
2026-06-09 19:19:39.096762 | TASK [Check if we get ci-framework-data basedir]
2026-06-09 19:19:39.485738 | controller | ok
2026-06-09 19:19:39.498766 | 
2026-06-09 19:19:39.499045 | TASK [Create ci-framework-data log directory for zuul]
2026-06-09 19:19:39.874985 | controller | changed
2026-06-09 19:19:39.880792 | 
2026-06-09 19:19:39.880906 | TASK [Copy ci-framework interesting files]
2026-06-09 19:19:40.399294 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-06-09 19:19:40.431694 | controller | ok: Runtime: 0:00:00.019577
2026-06-09 19:19:40.436468 | 
2026-06-09 19:19:40.436549 | TASK [Get SELinux listing]
2026-06-09 19:19:40.969753 | controller | ok: Runtime: 0:00:00.014538
2026-06-09 19:19:40.975870 | 
2026-06-09 19:19:40.976001 | TASK [Generate log index]
2026-06-09 19:19:42.717442 | controller | changed
2026-06-09 19:19:42.725880 | 
2026-06-09 19:19:42.726027 | TASK [Get some env related data]
2026-06-09 19:19:43.730012 | controller | /home/zuul/.local/bin/ansible
2026-06-09 19:19:44.770149 | controller | ok: Runtime: 0:00:01.471675
2026-06-09 19:19:44.778205 | 
2026-06-09 19:19:44.778334 | TASK [Generate list of logs to collect in home directory]
2026-06-09 19:19:45.309017 | controller | ok: All paths examined
2026-06-09 19:19:45.319128 | 
2026-06-09 19:19:45.319311 | LOOP [Copy logs from home directory]
2026-06-09 19:19:46.265434 | controller | changed:
2026-06-09 19:19:46.265635 | controller | {
2026-06-09 19:19:46.265671 | controller |   "atime": 1777967689.47849,
2026-06-09 19:19:46.265697 | controller |   "ctime": 1777968154.1714108,
2026-06-09 19:19:46.265721 | controller |   "dev": 64513,
2026-06-09 19:19:46.265758 | controller |   "gid": 1000,
2026-06-09 19:19:46.265782 | controller |   "gr_name": "zuul",
2026-06-09 19:19:46.265805 | controller |   "inode": 236288,
2026-06-09 19:19:46.265827 | controller |   "isblk": false,
2026-06-09 19:19:46.265870 | controller |   "ischr": false,
2026-06-09 19:19:46.265899 | controller |   "isdir": false,
2026-06-09 19:19:46.265922 | controller |   "isfifo": false,
2026-06-09 19:19:46.265944 | controller |   "isgid": false,
2026-06-09 19:19:46.265966 | controller |   "islnk": false,
2026-06-09 19:19:46.265988 | controller |   "isreg": true,
2026-06-09 19:19:46.266010 | controller |   "issock": false,
2026-06-09 19:19:46.266034 | controller |   "isuid": false,
2026-06-09 19:19:46.266057 | controller |   "mode": "0644",
2026-06-09 19:19:46.266080 | controller |   "mtime": 1777968154.1714108,
2026-06-09 19:19:46.266103 | controller |   "nlink": 1,
2026-06-09 19:19:46.266126 | controller |   "path": "/home/zuul/crc-setup.log",
2026-06-09 19:19:46.266148 | controller |   "pw_name": "zuul",
2026-06-09 19:19:46.266170 | controller |   "rgrp": true,
2026-06-09 19:19:46.266192 | controller |   "roth": true,
2026-06-09 19:19:46.266218 | controller |   "rusr": true,
2026-06-09 19:19:46.266242 | controller |   "size": 4108,
2026-06-09 19:19:46.266263 | controller |   "uid": 1000,
2026-06-09 19:19:46.266285 | controller |   "wgrp": false,
2026-06-09 19:19:46.266307 | controller |   "woth": false,
2026-06-09 19:19:46.266328 | controller |   "wusr": true,
2026-06-09 19:19:46.266351 | controller |   "xgrp": false,
2026-06-09 19:19:46.266373 | controller |   "xoth": false,
2026-06-09 19:19:46.266396 | controller |   "xusr": false
2026-06-09 19:19:46.266419 | controller | }
2026-06-09 19:19:47.044210 | controller | changed:
2026-06-09 19:19:47.044395 | controller | {
2026-06-09 19:19:47.044445 | controller |   "atime": 1777968156.210465,
2026-06-09 19:19:47.044484 | controller |   "ctime": 1777968956.4694307,
2026-06-09 19:19:47.044541 | controller |   "dev": 64513,
2026-06-09 19:19:47.044579 | controller |   "gid": 1000,
2026-06-09 19:19:47.044614 | controller |   "gr_name": "zuul",
2026-06-09 19:19:47.044650 | controller |   "inode": 2688,
2026-06-09 19:19:47.044684 | controller |   "isblk": false,
2026-06-09 19:19:47.044717 | controller |   "ischr": false,
2026-06-09 19:19:47.044752 | controller |   "isdir": false,
2026-06-09 19:19:47.044785 | controller |   "isfifo": false,
2026-06-09 19:19:47.044818 | controller |   "isgid": false,
2026-06-09 19:19:47.044877 | controller |   "islnk": false,
2026-06-09 19:19:47.044919 | controller |   "isreg": true,
2026-06-09 19:19:47.044954 | controller |   "issock": false,
2026-06-09 19:19:47.044987 | controller |   "isuid": false,
2026-06-09 19:19:47.045022 | controller |   "mode": "0644",
2026-06-09 19:19:47.045056 | controller |   "mtime": 1777968956.4694307,
2026-06-09 19:19:47.045091 | controller |   "nlink": 1,
2026-06-09 19:19:47.045126 | controller |   "path": "/home/zuul/crc-start.log",
2026-06-09 19:19:47.045160 | controller |   "pw_name": "zuul",
2026-06-09 19:19:47.045194 | controller |   "rgrp": true,
2026-06-09 19:19:47.045227 | controller |   "roth": true,
2026-06-09 19:19:47.045260 | controller |   "rusr": true,
2026-06-09 19:19:47.045293 | controller |   "size": 5003,
2026-06-09 19:19:47.045326 | controller |   "uid": 1000,
2026-06-09 19:19:47.045358 | controller |   "wgrp": false,
2026-06-09 19:19:47.045390 | controller |   "woth": false,
2026-06-09 19:19:47.045421 | controller |   "wusr": true,
2026-06-09 19:19:47.045453 | controller |   "xgrp": false,
2026-06-09 19:19:47.045484 | controller |   "xoth": false,
2026-06-09 19:19:47.045515 | controller |   "xusr": false
2026-06-09 19:19:47.045546 | controller | }
2026-06-09 19:19:47.845279 | controller | changed:
2026-06-09 19:19:47.845446 | controller | {
2026-06-09 19:19:47.845495 | controller |   "atime": 1781031100.2805097,
2026-06-09 19:19:47.845534 | controller |   "ctime": 1781031135.685542,
2026-06-09 19:19:47.845571 | controller |   "dev": 64513,
2026-06-09 19:19:47.845628 | controller |   "gid": 1000,
2026-06-09 19:19:47.845665 | controller |   "gr_name": "zuul",
2026-06-09 19:19:47.845700 | controller |   "inode": 3016290,
2026-06-09 19:19:47.845734 | controller |   "isblk": false,
2026-06-09 19:19:47.845769 | controller |   "ischr": false,
2026-06-09 19:19:47.845803 | controller |   "isdir": false,
2026-06-09 19:19:47.845837 | controller |   "isfifo": false,
2026-06-09 19:19:47.845911 | controller |   "isgid": false,
2026-06-09 19:19:47.845947 | controller |   "islnk": false,
2026-06-09 19:19:47.845981 | controller |   "isreg": true,
2026-06-09 19:19:47.846015 | controller |   "issock": false,
2026-06-09 19:19:47.846051 | controller |   "isuid": false,
2026-06-09 19:19:47.846086 | controller |   "mode": "0644",
2026-06-09 19:19:47.846119 | controller |   "mtime": 1781031135.685542,
2026-06-09 19:19:47.846159 | controller |   "nlink": 1,
2026-06-09 19:19:47.846195 | controller |   "path": "/home/zuul/ansible.log",
2026-06-09 19:19:47.846229 | controller |   "pw_name": "zuul",
2026-06-09 19:19:47.846263 | controller |   "rgrp": true,
2026-06-09 19:19:47.846297 | controller |   "roth": true,
2026-06-09 19:19:47.846331 | controller |   "rusr": true,
2026-06-09 19:19:47.846364 | controller |   "size": 6701,
2026-06-09 19:19:47.846397 | controller |   "uid": 1000,
2026-06-09 19:19:47.846430 | controller |   "wgrp": false,
2026-06-09 19:19:47.846462 | controller |   "woth": false,
2026-06-09 19:19:47.846495 | controller |   "wusr": true,
2026-06-09 19:19:47.846527 | controller |   "xgrp": false,
2026-06-09 19:19:47.846559 | controller |   "xoth": false,
2026-06-09 19:19:47.846592 | controller |   "xusr": false
2026-06-09 19:19:47.846625 | controller | }
2026-06-09 19:19:47.864099 | 
2026-06-09 19:19:47.864244 | TASK [Copy crio stats log file]
2026-06-09 19:19:47.889669 | controller | skipping: Conditional result was False
2026-06-09 19:19:47.898710 | 
2026-06-09 19:19:47.898890 | TASK [Get SELinux related data]
2026-06-09 19:19:48.292887 | controller | <no matches>
2026-06-09 19:19:48.445565 | controller | ERROR
2026-06-09 19:19:48.445927 | controller | {
2026-06-09 19:19:48.446001 | controller |   "delta": "0:00:00.010924",
2026-06-09 19:19:48.446046 | controller |   "end": "2026-06-09 19:19:48.293497",
2026-06-09 19:19:48.446083 | controller |   "msg": "non-zero return code",
2026-06-09 19:19:48.446119 | controller |   "rc": 1,
2026-06-09 19:19:48.446154 | controller |   "start": "2026-06-09 19:19:48.282573"
2026-06-09 19:19:48.446190 | controller | }
2026-06-09 19:19:48.446237 | controller | ERROR: Ignoring Errors
2026-06-09 19:19:48.454491 | 
2026-06-09 19:19:48.454652 | TASK [Create system configuration directory]
2026-06-09 19:19:48.843843 | controller | changed
2026-06-09 19:19:48.851586 | 
2026-06-09 19:19:48.851721 | TASK [Get some of the system configurations]
2026-06-09 19:19:49.397267 | controller | ok: Runtime: 0:00:00.024278
2026-06-09 19:19:49.404929 | 
2026-06-09 19:19:49.405067 | TASK [Copy generated documentation if available]
2026-06-09 19:19:49.431030 | controller | skipping: Conditional result was False
2026-06-09 19:19:49.440551 | 
2026-06-09 19:19:49.440687 | TASK [Copy generated AsciiDoc documentation if available]
2026-06-09 19:19:49.477348 | controller | skipping: Conditional result was False
2026-06-09 19:19:49.488005 | 
2026-06-09 19:19:49.488158 | TASK [Compress logs bigger than 2MB]
2026-06-09 19:19:50.033092 | controller | ok: Runtime: 0:00:00.005792
2026-06-09 19:19:50.040830 | 
2026-06-09 19:19:50.040993 | TASK [Copy files from workspace on node]
2026-06-09 19:19:50.071266 | controller | ok
2026-06-09 19:19:50.098083 | 
2026-06-09 19:19:50.098227 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-09 19:19:50.123913 | controller | skipping: Conditional result was False
2026-06-09 19:19:50.130445 | 
2026-06-09 19:19:50.130556 | TASK [fetch-output : Set log path for single node]
2026-06-09 19:19:50.182911 | controller | ok
2026-06-09 19:19:50.191289 | 
2026-06-09 19:19:50.191427 | LOOP [fetch-output : Ensure local output dirs]
2026-06-09 19:19:50.444456 | controller -> localhost | changed: "/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/logs"
2026-06-09 19:19:50.444952 | controller -> localhost | changed: All items complete
2026-06-09 19:19:50.445014 | 
2026-06-09 19:19:50.673470 | controller -> localhost | changed: "/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/artifacts"
2026-06-09 19:19:50.881976 | controller -> localhost | changed: "/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/docs"
2026-06-09 19:19:50.903164 | 
2026-06-09 19:19:50.903440 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-09 19:19:51.766773 | controller | changed:
2026-06-09 19:19:51.767598 | controller | .d..t...... ./
2026-06-09 19:19:51.767655 | controller | >f+++++++++ README.html
2026-06-09 19:19:51.767702 | controller | >f+++++++++ ansible-execution.log
2026-06-09 19:19:51.767740 | controller | >f+++++++++ ansible.log
2026-06-09 19:19:51.767776 | controller | >f+++++++++ crc-setup.log
2026-06-09 19:19:51.767812 | controller | >f+++++++++ crc-start.log
2026-06-09 19:19:51.767876 | controller | >f+++++++++ dmesg.log
2026-06-09 19:19:51.767923 | controller | >f+++++++++ installed-pkgs.log
2026-06-09 19:19:51.767960 | controller | >f+++++++++ python.log
2026-06-09 19:19:51.767995 | controller | >f+++++++++ registries.conf
2026-06-09 19:19:51.768029 | controller | >f+++++++++ selinux-denials.log
2026-06-09 19:19:51.768062 | controller | >f+++++++++ selinux-listing.log
2026-06-09 19:19:51.768095 | controller | cd+++++++++ ci-framework-data/
2026-06-09 19:19:51.768128 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-06-09 19:19:51.768163 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-06-09 19:19:51.768197 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-06-09 19:19:51.768231 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-06-09 19:19:51.768265 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2026-06-09 19:19:51.768300 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2026-06-09 19:19:51.768335 | controller | cd+++++++++ ci-framework-data/logs/
2026-06-09 19:19:51.768370 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-06-09 19:19:51.768489 | controller | cd+++++++++ registries.conf.d/
2026-06-09 19:19:51.768527 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-06-09 19:19:51.768563 | controller | cd+++++++++ system-config/
2026-06-09 19:19:51.768598 | controller | cd+++++++++ system-config/libvirt/
2026-06-09 19:19:51.768634 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-06-09 19:19:51.768668 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-06-09 19:19:51.768702 | controller | >f+++++++++ system-config/libvirt/libvirtd.conf
2026-06-09 19:19:51.768737 | controller | >f+++++++++ system-config/libvirt/network.conf
2026-06-09 19:19:51.768770 | controller | >f+++++++++ system-config/libvirt/qemu-lockd.conf
2026-06-09 19:19:51.768804 | controller | >f+++++++++ system-config/libvirt/qemu.conf
2026-06-09 19:19:51.768837 | controller | >f+++++++++ system-config/libvirt/virtinterfaced.conf
2026-06-09 19:19:51.768912 | controller | >f+++++++++ system-config/libvirt/virtlockd.conf
2026-06-09 19:19:51.768950 | controller | >f+++++++++ system-config/libvirt/virtlogd.conf
2026-06-09 19:19:51.768984 | controller | >f+++++++++ system-config/libvirt/virtnetworkd.conf
2026-06-09 19:19:51.769018 | controller | >f+++++++++ system-config/libvirt/virtnodedevd.conf
2026-06-09 19:19:51.769052 | controller | >f+++++++++ system-config/libvirt/virtnwfilterd.conf
2026-06-09 19:19:51.769084 | controller | >f+++++++++ system-config/libvirt/virtproxyd.conf
2026-06-09 19:19:51.769118 | controller | >f+++++++++ system-config/libvirt/virtqemud.conf
2026-06-09 19:19:51.769151 | controller | >f+++++++++ system-config/libvirt/virtsecretd.conf
2026-06-09 19:19:51.769184 | controller | >f+++++++++ system-config/libvirt/virtstoraged.conf
2026-06-09 19:19:52.453165 | controller | changed: .d..t...... ./
2026-06-09 19:19:53.145514 | controller | changed: .d..t...... ./
2026-06-09 19:19:53.176754 | 
2026-06-09 19:19:53.176950 | TASK [Return artifact to Zuul]
2026-06-09 19:19:53.213704 | controller | skipping: Conditional result was False
2026-06-09 19:19:53.217575 | 
2026-06-09 19:19:53.217677 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-06-09 19:19:53.217907 | 
2026-06-09 19:19:53.217972 | PLAY RECAP
2026-06-09 19:19:53.218049 | controller | ok: 17 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1
2026-06-09 19:19:53.218089 | 
2026-06-09 19:19:53.402592 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-06-09 19:19:53.404823 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-09 19:19:54.036787 | 
2026-06-09 19:19:54.037058 | PLAY [all]
2026-06-09 19:19:54.054005 | 
2026-06-09 19:19:54.054143 | TASK [include_role : fetch-output]
2026-06-09 19:19:54.086327 | controller | ok
2026-06-09 19:19:54.109965 | 
2026-06-09 19:19:54.110125 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-09 19:19:54.187222 | controller | skipping: Conditional result was False
2026-06-09 19:19:54.196507 | 
2026-06-09 19:19:54.196644 | TASK [fetch-output : Set log path for single node]
2026-06-09 19:19:54.250293 | controller | ok
2026-06-09 19:19:54.258739 | 
2026-06-09 19:19:54.258921 | LOOP [fetch-output : Ensure local output dirs]
2026-06-09 19:19:54.740289 | controller -> localhost | ok: "/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/logs"
2026-06-09 19:19:55.002444 | controller -> localhost | ok: "/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/artifacts"
2026-06-09 19:19:55.237439 | controller -> localhost | ok: "/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/docs"
2026-06-09 19:19:55.251937 | 
2026-06-09 19:19:55.252124 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-09 19:19:56.101013 | controller | ok
2026-06-09 19:19:56.101366 | controller | ok: All items complete
2026-06-09 19:19:56.101425 | 
2026-06-09 19:19:56.792595 | controller | ok
2026-06-09 19:19:57.484198 | controller | ok
2026-06-09 19:19:57.515262 | 
2026-06-09 19:19:57.515485 | TASK [include_role : fetch-output-openshift]
2026-06-09 19:19:57.544280 | controller | skipping: Conditional result was False
2026-06-09 19:19:57.555680 | 
2026-06-09 19:19:57.555832 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-09 19:19:58.044642 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012711
2026-06-09 19:19:58.344493 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.011245
2026-06-09 19:19:58.360496 | 
2026-06-09 19:19:58.360671 | PLAY [all]
2026-06-09 19:19:58.370582 | 
2026-06-09 19:19:58.370716 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-09 19:19:59.023378 | controller | changed
2026-06-09 19:19:59.032764 | 
2026-06-09 19:19:59.032894 | PLAY RECAP
2026-06-09 19:19:59.032982 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-06-09 19:19:59.033026 | 
2026-06-09 19:19:59.214487 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-06-09 19:19:59.217190 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-06-09 19:19:59.924981 | 
2026-06-09 19:19:59.925120 | PLAY [localhost]
2026-06-09 19:19:59.935943 | 
2026-06-09 19:19:59.936039 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-09 19:20:00.462475 | localhost | changed
2026-06-09 19:20:00.474599 | 
2026-06-09 19:20:00.474839 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-09 19:20:00.502869 | localhost | ok
2026-06-09 19:20:00.511527 | 
2026-06-09 19:20:00.511674 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-09 19:20:00.969535 | localhost | changed
2026-06-09 19:20:00.978607 | 
2026-06-09 19:20:00.978756 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-09 19:20:01.837618 | localhost | changed
2026-06-09 19:20:01.842206 | 
2026-06-09 19:20:01.842274 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-09 19:20:02.367071 | localhost | Identity added: /var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/tmp/ansible.4lt1d9d0 (/var/lib/zuul/builds/de60de31b1af430fb8671de6adb16f19/work/tmp/ansible.4lt1d9d0)
2026-06-09 19:20:02.367389 | localhost | ok: Runtime: 0:00:00.020315
2026-06-09 19:20:02.374662 | 
2026-06-09 19:20:02.374798 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-09 19:20:02.702570 | localhost | ok: Runtime: 0:00:00.009347
2026-06-09 19:20:02.707780 | 
2026-06-09 19:20:02.707885 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-09 19:20:02.788641 | localhost | changed
2026-06-09 19:20:02.794585 | 
2026-06-09 19:20:02.794667 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-09 19:20:03.278193 | localhost | changed
2026-06-09 19:20:03.283491 | 
2026-06-09 19:20:03.283541 | PLAY [localhost]
2026-06-09 19:20:03.287408 | 
2026-06-09 19:20:03.287463 | TASK [Generate bulk log download script]
2026-06-09 19:20:03.305461 | localhost | ok
2026-06-09 19:20:03.316318 | 
2026-06-09 19:20:03.316390 | TASK [local-log-download : Check API endpoint is defined]
2026-06-09 19:20:03.363248 | localhost | ok: All assertions passed
2026-06-09 19:20:03.366734 | 
2026-06-09 19:20:03.366791 | TASK [local-log-download : Create download script]
2026-06-09 19:20:03.886469 | localhost -> localhost | changed
2026-06-09 19:20:03.949237 | 
2026-06-09 19:20:03.949446 | TASK [Register quick-download link]
2026-06-09 19:20:03.982519 | localhost | ok
2026-06-09 19:20:03.986359 | 
2026-06-09 19:20:03.986467 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-09 19:20:03.996146 | 
2026-06-09 19:20:03.996268 | TASK [Set zuul-log-path fact]
2026-06-09 19:20:04.015668 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-09 19:20:04.028291 | 
2026-06-09 19:20:04.028416 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-09 19:20:04.067355 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-09 19:20:04.072175 | 
2026-06-09 19:20:04.072309 | TASK [upload-logs : Create log directories]
2026-06-09 19:20:06.017996 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-09 19:20:06.019741 | 
2026-06-09 19:20:06.019808 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-09 19:20:06.378247 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.010249
2026-06-09 19:20:06.381728 | 
2026-06-09 19:20:06.381793 | TASK [upload-logs : Upload logs to log server]
2026-06-09 19:20:09.323059 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | Output suppressed because no_log was given
2026-06-09 19:20:09.325118 | 
2026-06-09 19:20:09.325192 | LOOP [upload-logs : Compress console log and json output]