2026-02-27 11:41:51.508286 | Job console starting...
2026-02-27 11:41:51.723401 | Updating repositories
2026-02-27 11:41:52.441445 | Preparing job workspace
2026-02-27 11:42:03.698188 | Running Ansible setup...
2026-02-27 11:42:06.519017 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-02-27 11:42:07.037745 | 
2026-02-27 11:42:07.037883 | PLAY [localhost]
2026-02-27 11:42:07.046491 | 
2026-02-27 11:42:07.046564 | TASK [Gathering Facts]
2026-02-27 11:42:07.860279 | localhost | ok
2026-02-27 11:42:07.873199 | 
2026-02-27 11:42:07.873279 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-27 11:42:08.200538 | localhost -> localhost | changed
2026-02-27 11:42:08.206005 | 
2026-02-27 11:42:08.206097 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-27 11:42:08.897395 | localhost -> localhost | changed
2026-02-27 11:42:08.905711 | 
2026-02-27 11:42:08.905797 | TASK [Setup log path fact]
2026-02-27 11:42:08.922639 | localhost | ok
2026-02-27 11:42:08.933884 | 
2026-02-27 11:42:08.933972 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 11:42:08.950877 | localhost | ok
2026-02-27 11:42:08.958432 | 
2026-02-27 11:42:08.958519 | TASK [emit-job-header : Print job information]
2026-02-27 11:42:08.985050 | # Job Information
2026-02-27 11:42:08.985173 | Ansible Version: 2.15.12
2026-02-27 11:42:08.985204 | Job: cifmw-molecule-build_openstack_packages
2026-02-27 11:42:08.985227 | Pipeline: github-check
2026-02-27 11:42:08.985246 | Executor: ibm-bm4-ze.softwarefactory-project.io
2026-02-27 11:42:08.985266 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3710
2026-02-27 11:42:08.985286 | Log URL (when completed): https://logserver.rdoproject.org/c1d/rdoproject.org/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/
2026-02-27 11:42:08.985330 | Event ID: 1a58b5f0-13d1-11f1-8729-cd0b67269eec
2026-02-27 11:42:08.988797 | 
2026-02-27 11:42:08.988861 | LOOP [emit-job-header : Print node information]
2026-02-27 11:42:09.076868 | localhost | ok:
2026-02-27 11:42:09.077089 | localhost | # Node Information
2026-02-27 11:42:09.077124 | localhost | Inventory Hostname: controller
2026-02-27 11:42:09.077148 | localhost | Hostname: np0005632808
2026-02-27 11:42:09.077169 | localhost | Username: zuul
2026-02-27 11:42:09.077189 | localhost | Distro: CentOS 9
2026-02-27 11:42:09.077208 | localhost | Provider: ibm-bm4-nodepool
2026-02-27 11:42:09.077227 | localhost | Region: regionOne
2026-02-27 11:42:09.077246 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2026-02-27 11:42:09.077263 | localhost | Product Name: OpenStack Compute
2026-02-27 11:42:09.077280 | localhost | Interface IP: 192.168.26.113
2026-02-27 11:42:09.100347 | 
2026-02-27 11:42:09.100432 | PLAY [all]
2026-02-27 11:42:09.106444 | 
2026-02-27 11:42:09.106510 | TASK [Gather network facts]
2026-02-27 11:42:09.448919 | controller | ok
2026-02-27 11:42:09.462423 | 
2026-02-27 11:42:09.462484 | TASK [include_role : start-zuul-console]
2026-02-27 11:42:09.479225 | controller | ok
2026-02-27 11:42:09.490616 | 
2026-02-27 11:42:09.490678 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-27 11:42:09.791087 | controller | ok
2026-02-27 11:42:09.799191 | 
2026-02-27 11:42:09.799264 | TASK [include_role : add-build-sshkey]
2026-02-27 11:42:09.817008 | controller | ok
2026-02-27 11:42:09.829258 | 
2026-02-27 11:42:09.829343 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-27 11:42:10.024942 | controller -> localhost | ok
2026-02-27 11:42:10.030439 | 
2026-02-27 11:42:10.030515 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-27 11:42:10.047470 | controller | ok
2026-02-27 11:42:10.061263 | controller | included: /var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-27 11:42:10.066841 | 
2026-02-27 11:42:10.066912 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-27 11:42:10.555115 | controller -> localhost | Generating public/private rsa key pair.
2026-02-27 11:42:10.555287 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/c1d6488c9ea34b9f82e1f5cd4ad5a9e1_id_rsa.
2026-02-27 11:42:10.555346 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/c1d6488c9ea34b9f82e1f5cd4ad5a9e1_id_rsa.pub.
2026-02-27 11:42:10.555374 | controller -> localhost | The key fingerprint is:
2026-02-27 11:42:10.555405 | controller -> localhost | SHA256:PmOwzT7nmDsqWibpMT+6tsiQcURAT8iUEbA21aoQn7c zuul-build-sshkey
2026-02-27 11:42:10.555427 | controller -> localhost | The key's randomart image is:
2026-02-27 11:42:10.555445 | controller -> localhost | +---[RSA 3072]----+
2026-02-27 11:42:10.555463 | controller -> localhost | |B**o.            |
2026-02-27 11:42:10.555480 | controller -> localhost | |.*+  .           |
2026-02-27 11:42:10.555496 | controller -> localhost | |.=.o.            |
2026-02-27 11:42:10.555513 | controller -> localhost | |o.+..            |
2026-02-27 11:42:10.555529 | controller -> localhost | |o o. .. S        |
2026-02-27 11:42:10.555545 | controller -> localhost | | = .E  *         |
2026-02-27 11:42:10.555560 | controller -> localhost | |o = o . B        |
2026-02-27 11:42:10.555575 | controller -> localhost | |oo.Bo  oo=.      |
2026-02-27 11:42:10.555592 | controller -> localhost | |.o*=.o..=*.      |
2026-02-27 11:42:10.555608 | controller -> localhost | +----[SHA256]-----+
2026-02-27 11:42:10.555649 | controller -> localhost | ok: Runtime: 0:00:00.158558
2026-02-27 11:42:10.561153 | 
2026-02-27 11:42:10.561217 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-27 11:42:10.578588 | controller | ok
2026-02-27 11:42:10.587690 | controller | included: /var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-27 11:42:10.595343 | 
2026-02-27 11:42:10.595406 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-27 11:42:10.608150 | controller | skipping: Conditional result was False
2026-02-27 11:42:10.613138 | 
2026-02-27 11:42:10.613205 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-27 11:42:10.964431 | controller | changed
2026-02-27 11:42:10.970366 | 
2026-02-27 11:42:10.970450 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-27 11:42:11.149673 | controller | ok
2026-02-27 11:42:11.154481 | 
2026-02-27 11:42:11.154544 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-27 11:42:11.668459 | controller | changed
2026-02-27 11:42:11.673085 | 
2026-02-27 11:42:11.673158 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-27 11:42:12.187135 | controller | changed
2026-02-27 11:42:12.192138 | 
2026-02-27 11:42:12.192214 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-27 11:42:12.205839 | controller | skipping: Conditional result was False
2026-02-27 11:42:12.211388 | 
2026-02-27 11:42:12.211458 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-27 11:42:12.520247 | controller -> localhost | changed
2026-02-27 11:42:12.529088 | 
2026-02-27 11:42:12.529150 | TASK [add-build-sshkey : Add back temp key]
2026-02-27 11:42:12.765434 | controller -> localhost | Identity added: /var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/c1d6488c9ea34b9f82e1f5cd4ad5a9e1_id_rsa (zuul-build-sshkey)
2026-02-27 11:42:12.765651 | controller -> localhost | ok: Runtime: 0:00:00.007283
2026-02-27 11:42:12.771185 | 
2026-02-27 11:42:12.771253 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-27 11:42:13.053058 | controller | ok
2026-02-27 11:42:13.057939 | 
2026-02-27 11:42:13.058020 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-27 11:42:13.081644 | controller | skipping: Conditional result was False
2026-02-27 11:42:13.090793 | 
2026-02-27 11:42:13.090875 | TASK [include_role : validate-host]
2026-02-27 11:42:13.108281 | controller | ok
2026-02-27 11:42:13.128280 | 
2026-02-27 11:42:13.128378 | TASK [validate-host : Define zuul_info_dir fact]
2026-02-27 11:42:13.155981 | controller | ok
2026-02-27 11:42:13.160812 | 
2026-02-27 11:42:13.160879 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-02-27 11:42:13.356899 | controller -> localhost | ok
2026-02-27 11:42:13.362668 | 
2026-02-27 11:42:13.362748 | TASK [validate-host : Collect information about the host]
2026-02-27 11:42:13.947696 | controller | ok
2026-02-27 11:42:13.955650 | 
2026-02-27 11:42:13.955722 | TASK [validate-host : Sanitize hostname]
2026-02-27 11:42:14.023449 | controller | ok
2026-02-27 11:42:14.028218 | 
2026-02-27 11:42:14.028290 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-02-27 11:42:14.426933 | controller -> localhost | changed
2026-02-27 11:42:14.450976 | 
2026-02-27 11:42:14.451061 | TASK [validate-host : Collect information about zuul worker]
2026-02-27 11:42:14.751309 | controller | ok
2026-02-27 11:42:14.756019 | 
2026-02-27 11:42:14.756082 | TASK [validate-host : Write out all zuul information for each host]
2026-02-27 11:42:15.124173 | controller -> localhost | changed
2026-02-27 11:42:15.132998 | 
2026-02-27 11:42:15.133068 | TASK [include_role : prepare-workspace-openshift]
2026-02-27 11:42:15.145603 | controller | skipping: Conditional result was False
2026-02-27 11:42:15.150663 | 
2026-02-27 11:42:15.150732 | TASK [include_role : remove-zuul-sshkey]
2026-02-27 11:42:15.163786 | controller | skipping: Conditional result was False
2026-02-27 11:42:15.168559 | 
2026-02-27 11:42:15.168627 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-27 11:42:15.349128 | controller | ok: "logs"
2026-02-27 11:42:15.349352 | controller | ok: All items complete
2026-02-27 11:42:15.349388 | 
2026-02-27 11:42:15.505575 | controller | ok: "artifacts"
2026-02-27 11:42:15.661635 | controller | ok: "docs"
2026-02-27 11:42:15.672523 | 
2026-02-27 11:42:15.672588 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-27 11:42:15.874636 | controller | changed: "logs"
2026-02-27 11:42:16.040528 | controller | changed: "artifacts"
2026-02-27 11:42:16.201838 | controller | changed: "docs"
2026-02-27 11:42:16.224880 | 
2026-02-27 11:42:16.224946 | PLAY RECAP
2026-02-27 11:42:16.224988 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-02-27 11:42:16.225016 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-27 11:42:16.225035 | 
2026-02-27 11:42:16.298260 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-02-27 11:42:16.299026 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-02-27 11:42:16.840615 | 
2026-02-27 11:42:16.840715 | PLAY [all]
2026-02-27 11:42:16.859517 | 
2026-02-27 11:42:16.859590 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-02-27 11:42:16.908248 | controller | ok
2026-02-27 11:42:16.913154 | 
2026-02-27 11:42:16.913236 | TASK [mirror-info-fork : Create /etc/ci]
2026-02-27 11:42:17.236378 | controller | changed
2026-02-27 11:42:17.241787 | 
2026-02-27 11:42:17.241875 | TASK [mirror-info-fork : Install ci_mirror script]
2026-02-27 11:42:17.988687 | controller | changed
2026-02-27 11:42:17.998095 | 
2026-02-27 11:42:17.998184 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-02-27 11:42:18.350570 | controller | changed:
2026-02-27 11:42:18.350761 | controller | {
2026-02-27 11:42:18.350791 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-02-27 11:42:18.350821 | controller | }
2026-02-27 11:42:18.543079 | controller | changed:
2026-02-27 11:42:18.543152 | controller | {
2026-02-27 11:42:18.543182 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-02-27 11:42:18.543203 | controller | }
2026-02-27 11:42:18.740291 | controller | changed:
2026-02-27 11:42:18.740459 | controller | {
2026-02-27 11:42:18.740494 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-02-27 11:42:18.740518 | controller | }
2026-02-27 11:42:18.941515 | controller | changed:
2026-02-27 11:42:18.941581 | controller | {
2026-02-27 11:42:18.941608 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-02-27 11:42:18.941629 | controller | }
2026-02-27 11:42:19.139287 | controller | changed:
2026-02-27 11:42:19.139408 | controller | {
2026-02-27 11:42:19.139435 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-02-27 11:42:19.139455 | controller | }
2026-02-27 11:42:19.331431 | controller | changed:
2026-02-27 11:42:19.331514 | controller | {
2026-02-27 11:42:19.331542 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-02-27 11:42:19.331564 | controller | }
2026-02-27 11:42:19.524541 | controller | changed:
2026-02-27 11:42:19.524630 | controller | {
2026-02-27 11:42:19.524657 | 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-02-27 11:42:19.524679 | controller | }
2026-02-27 11:42:19.718340 | controller | changed:
2026-02-27 11:42:19.718430 | controller | {
2026-02-27 11:42:19.718459 | 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-02-27 11:42:19.718480 | controller | }
2026-02-27 11:42:19.908943 | controller | changed:
2026-02-27 11:42:19.909015 | controller | {
2026-02-27 11:42:19.909043 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-02-27 11:42:19.909071 | controller | }
2026-02-27 11:42:20.102241 | controller | changed:
2026-02-27 11:42:20.102330 | controller | {
2026-02-27 11:42:20.102363 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-02-27 11:42:20.102385 | controller | }
2026-02-27 11:42:20.297849 | controller | changed:
2026-02-27 11:42:20.297912 | controller | {
2026-02-27 11:42:20.297939 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-02-27 11:42:20.297959 | controller | }
2026-02-27 11:42:20.514760 | controller | changed:
2026-02-27 11:42:20.514839 | controller | {
2026-02-27 11:42:20.514866 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-02-27 11:42:20.514899 | controller | }
2026-02-27 11:42:20.688852 | controller | changed:
2026-02-27 11:42:20.688940 | controller | {
2026-02-27 11:42:20.688967 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICWBreHW95Wz2Toz5YwCGQwFcUG8oFYkienDh9tntmDc ralfieri@redhat.com"
2026-02-27 11:42:20.688988 | controller | }
2026-02-27 11:42:20.887218 | controller | changed:
2026-02-27 11:42:20.887283 | controller | {
2026-02-27 11:42:20.887329 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-02-27 11:42:20.887352 | controller | }
2026-02-27 11:42:21.083831 | controller | changed:
2026-02-27 11:42:21.083913 | controller | {
2026-02-27 11:42:21.083941 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-02-27 11:42:21.083961 | controller | }
2026-02-27 11:42:21.280071 | controller | changed:
2026-02-27 11:42:21.280136 | controller | {
2026-02-27 11:42:21.280162 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-02-27 11:42:21.280181 | controller | }
2026-02-27 11:42:21.476095 | controller | changed:
2026-02-27 11:42:21.476166 | controller | {
2026-02-27 11:42:21.476193 | 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-02-27 11:42:21.476215 | controller | }
2026-02-27 11:42:21.672344 | controller | changed:
2026-02-27 11:42:21.672418 | controller | {
2026-02-27 11:42:21.672444 | 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-02-27 11:42:21.672473 | controller | }
2026-02-27 11:42:21.870056 | controller | changed:
2026-02-27 11:42:21.870146 | controller | {
2026-02-27 11:42:21.870180 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-02-27 11:42:21.870210 | controller | }
2026-02-27 11:42:22.072105 | controller | changed:
2026-02-27 11:42:22.072173 | controller | {
2026-02-27 11:42:22.072200 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-02-27 11:42:22.072221 | controller | }
2026-02-27 11:42:22.269762 | controller | changed:
2026-02-27 11:42:22.269821 | controller | {
2026-02-27 11:42:22.269847 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-02-27 11:42:22.269867 | controller | }
2026-02-27 11:42:22.468901 | controller | changed:
2026-02-27 11:42:22.468965 | controller | {
2026-02-27 11:42:22.468998 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-02-27 11:42:22.469024 | controller | }
2026-02-27 11:42:22.672368 | controller | changed:
2026-02-27 11:42:22.672535 | controller | {
2026-02-27 11:42:22.672571 | 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-02-27 11:42:22.672595 | controller | }
2026-02-27 11:42:22.868481 | controller | changed:
2026-02-27 11:42:22.868538 | controller | {
2026-02-27 11:42:22.868563 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-02-27 11:42:22.868583 | controller | }
2026-02-27 11:42:23.066106 | controller | changed:
2026-02-27 11:42:23.066160 | controller | {
2026-02-27 11:42:23.066186 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-02-27 11:42:23.066216 | controller | }
2026-02-27 11:42:23.262444 | controller | changed:
2026-02-27 11:42:23.262546 | controller | {
2026-02-27 11:42:23.262574 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-02-27 11:42:23.262595 | controller | }
2026-02-27 11:42:23.286118 | 
2026-02-27 11:42:23.286268 | TASK [Set timezone to UTC]
2026-02-27 11:42:23.659986 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-02-27 11:42:23.664717 | 
2026-02-27 11:42:23.664782 | TASK [Create nodepool directory]
2026-02-27 11:42:23.856111 | controller | changed
2026-02-27 11:42:23.861460 | 
2026-02-27 11:42:23.861526 | TASK [Create nodepool sub_nodes file]
2026-02-27 11:42:24.335329 | controller | changed
2026-02-27 11:42:24.340070 | 
2026-02-27 11:42:24.340152 | TASK [Create nodepool sub_nodes_private file]
2026-02-27 11:42:24.826005 | controller | changed
2026-02-27 11:42:24.831671 | 
2026-02-27 11:42:24.831753 | LOOP [Populate nodepool sub_nodes file]
2026-02-27 11:42:24.860629 | 
2026-02-27 11:42:24.860753 | LOOP [Populate nodepool sub_nodes_private file]
2026-02-27 11:42:24.888636 | 
2026-02-27 11:42:24.888752 | TASK [Create nodepool primary file]
2026-02-27 11:42:24.911405 | controller | skipping: Conditional result was False
2026-02-27 11:42:24.916547 | 
2026-02-27 11:42:24.916620 | TASK [Create nodepool node_private for this node]
2026-02-27 11:42:25.430260 | controller | changed
2026-02-27 11:42:25.435638 | 
2026-02-27 11:42:25.435711 | LOOP [Copy ssh keys to nodepool directory]
2026-02-27 11:42:25.753209 | controller | ok: Item: id_rsa Runtime: 0:00:00.004128
2026-02-27 11:42:25.753469 | 
2026-02-27 11:42:25.912430 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.003674
2026-02-27 11:42:25.920242 | 
2026-02-27 11:42:25.920351 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-02-27 11:42:26.437773 | controller | changed
2026-02-27 11:42:26.442748 | 
2026-02-27 11:42:26.442815 | TASK [Validate sudoers config after edits]
2026-02-27 11:42:26.654923 | controller | /etc/sudoers: parsed OK
2026-02-27 11:42:26.654996 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-02-27 11:42:26.655007 | controller | /etc/sudoers.d/zuul: parsed OK
2026-02-27 11:42:26.655014 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-02-27 11:42:26.970955 | controller | ok: Runtime: 0:00:00.005344
2026-02-27 11:42:26.976932 | 
2026-02-27 11:42:26.977055 | TASK [Show the environment passed in to job shell scripts]
2026-02-27 11:42:27.178110 | controller | SHELL=/bin/bash
2026-02-27 11:42:27.178146 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-02-27 11:42:27.178156 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-02-27 11:42:27.178162 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/10/3710/c8f316527e18b1566468b6cf5b31f41e3d3df133
2026-02-27 11:42:27.178167 | controller | PWD=/home/zuul
2026-02-27 11:42:27.178173 | controller | ZUUL_PIPELINE=github-check
2026-02-27 11:42:27.178178 | controller | LOGNAME=zuul
2026-02-27 11:42:27.178183 | controller | XDG_SESSION_TYPE=tty
2026-02-27 11:42:27.178189 | controller | _=/usr/bin/env
2026-02-27 11:42:27.178194 | controller | MOTD_SHOWN=pam
2026-02-27 11:42:27.178230 | controller | HOME=/home/zuul
2026-02-27 11:42:27.178238 | controller | LANG=en_US.UTF-8
2026-02-27 11:42:27.178244 | controller | SSH_CONNECTION=192.168.26.12 56430 192.168.26.113 22
2026-02-27 11:42:27.178249 | 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-02-27 11:42:27.178257 | controller | ZUUL_CHANGE_IDS=3710,c8f316527e18b1566468b6cf5b31f41e3d3df133
2026-02-27 11:42:27.178263 | controller | WORKSPACE=/home/zuul/workspace
2026-02-27 11:42:27.178268 | controller | XDG_SESSION_CLASS=user
2026-02-27 11:42:27.178273 | controller | SELINUX_ROLE_REQUESTED=
2026-02-27 11:42:27.178279 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-02-27 11:42:27.178284 | controller | USER=zuul
2026-02-27 11:42:27.178289 | controller | ZUUL_VOTING=True
2026-02-27 11:42:27.178294 | controller | BUILD_TIMEOUT=1800000
2026-02-27 11:42:27.178300 | controller | SELINUX_USE_CURRENT_RANGE=
2026-02-27 11:42:27.178305 | controller | SHLVL=1
2026-02-27 11:42:27.178310 | controller | ZUUL_PATCHSET=c8f316527e18b1566468b6cf5b31f41e3d3df133
2026-02-27 11:42:27.178315 | controller | XDG_SESSION_ID=1
2026-02-27 11:42:27.178321 | controller | ZUUL_BRANCH=main
2026-02-27 11:42:27.178326 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-02-27 11:42:27.178331 | controller | SSH_CLIENT=192.168.26.12 56430 22
2026-02-27 11:42:27.178338 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-02-27 11:42:27.178343 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-02-27 11:42:27.178348 | controller | which_declare=declare -f
2026-02-27 11:42:27.178354 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-02-27 11:42:27.178359 | controller | SELINUX_LEVEL_REQUESTED=
2026-02-27 11:42:27.178364 | controller | ZUUL_CHANGE=3710
2026-02-27 11:42:27.178371 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-02-27 11:42:27.178376 | controller | ZUUL_UUID=c1d6488c9ea34b9f82e1f5cd4ad5a9e1
2026-02-27 11:42:27.178382 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-02-27 11:42:27.178387 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-02-27 11:42:27.178392 | controller | }
2026-02-27 11:42:27.503358 | controller | ok: Runtime: 0:00:00.005114
2026-02-27 11:42:27.508772 | 
2026-02-27 11:42:27.508837 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-02-27 11:42:27.523048 | controller | skipping: Conditional result was False
2026-02-27 11:42:27.529338 | 
2026-02-27 11:42:27.529404 | TASK [Symlink /home/zuul-worker/workspace]
2026-02-27 11:42:28.057696 | controller | skipping: Conditional result was False
2026-02-27 11:42:28.064018 | 
2026-02-27 11:42:28.064089 | TASK [Ensure legacy workspace directory]
2026-02-27 11:42:28.245275 | controller | changed
2026-02-27 11:42:28.263902 | 
2026-02-27 11:42:28.263990 | PLAY RECAP
2026-02-27 11:42:28.264038 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-02-27 11:42:28.264061 | 
2026-02-27 11:42:28.346378 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-02-27 11:42:28.347150 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-02-27 11:42:28.857242 | 
2026-02-27 11:42:28.857413 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-02-27 11:42:28.877674 | 
2026-02-27 11:42:28.877749 | TASK [Create zuul-output directory]
2026-02-27 11:42:29.191185 | controller | changed
2026-02-27 11:42:29.196231 | 
2026-02-27 11:42:29.196349 | TASK [Slurp Zuul inventory test]
2026-02-27 11:42:29.474002 | controller -> localhost | ok
2026-02-27 11:42:29.480533 | 
2026-02-27 11:42:29.480602 | TASK [Save zuul inventory]
2026-02-27 11:42:30.188524 | controller | changed
2026-02-27 11:42:30.193442 | 
2026-02-27 11:42:30.193508 | TASK [Save zuul vars without the change_message]
2026-02-27 11:42:30.741760 | controller | changed
2026-02-27 11:42:30.766869 | 
2026-02-27 11:42:30.766991 | PLAY RECAP
2026-02-27 11:42:30.767046 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-27 11:42:30.767069 | 
2026-02-27 11:42:30.887795 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-02-27 11:42:30.888561 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-02-27 11:42:31.516267 | 
2026-02-27 11:42:31.516438 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-02-27 11:42:31.536802 | 
2026-02-27 11:42:31.536884 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-02-27 11:42:31.555600 | controller | ok
2026-02-27 11:42:31.571900 | 
2026-02-27 11:42:31.571990 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-02-27 11:42:31.595603 | controller | skipping: Conditional result was False
2026-02-27 11:42:31.601353 | 
2026-02-27 11:42:31.601425 | TASK [mirror-info-fork : Create /etc/ci]
2026-02-27 11:42:31.914283 | controller | ok
2026-02-27 11:42:31.919825 | 
2026-02-27 11:42:31.919908 | TASK [mirror-info-fork : Install ci_mirror script]
2026-02-27 11:42:32.505953 | controller | ok
2026-02-27 11:42:32.515976 | 
2026-02-27 11:42:32.516043 | TASK [Prepare workspace]
2026-02-27 11:42:32.534280 | controller | ok
2026-02-27 11:42:32.550571 | 
2026-02-27 11:42:32.550638 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-27 11:42:32.842801 | controller | ok
2026-02-27 11:42:32.848723 | 
2026-02-27 11:42:32.848792 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-27 11:42:35.289616 | controller | Output suppressed because no_log was given
2026-02-27 11:42:35.298697 | 
2026-02-27 11:42:35.298774 | LOOP [Create zuul-output directory]
2026-02-27 11:42:35.489001 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-02-27 11:42:35.646441 | controller | ok: "/home/zuul/zuul-output/logs"
2026-02-27 11:42:35.652884 | 
2026-02-27 11:42:35.652967 | TASK [Install required packages]
2026-02-27 11:43:13.168991 | controller | changed
2026-02-27 11:43:13.174054 | 
2026-02-27 11:43:13.174129 | TASK [Install venv]
2026-02-27 11:44:13.815801 | controller | changed
2026-02-27 11:44:13.837468 | 
2026-02-27 11:44:13.837524 | PLAY RECAP
2026-02-27 11:44:13.837567 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-27 11:44:13.837589 | 
2026-02-27 11:44:13.902212 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-02-27 11:44:13.903026 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-02-27 11:44:14.381458 | 
2026-02-27 11:44:14.381558 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-02-27 11:44:14.400248 | 
2026-02-27 11:44:14.400330 | TASK [Gather required facts]
2026-02-27 11:44:14.833950 | controller | ok
2026-02-27 11:44:14.838745 | 
2026-02-27 11:44:14.838823 | TASK [Load environment var if instructed to]
2026-02-27 11:44:14.862508 | controller | skipping: Conditional result was False
2026-02-27 11:44:14.867256 | 
2026-02-27 11:44:14.867349 | TASK [Ensure group_vars dir exists]
2026-02-27 11:44:15.148837 | controller | ok
2026-02-27 11:44:15.154788 | 
2026-02-27 11:44:15.154862 | TASK [Print related variables]
2026-02-27 11:44:15.183545 | controller | ok:
2026-02-27 11:44:15.183655 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-02-27 11:44:15.183681 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages
2026-02-27 11:44:15.188068 | 
2026-02-27 11:44:15.188127 | TASK [Run molecule]
2026-02-27 11:44:16.033759 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-02-27 11:44:16.097370 | controller | INFO     Performing prerun with role_name_check=0...
2026-02-27 11:44:33.099326 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.099708 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.100122 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.100466 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.100901 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+c8f31652 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.0.0+c8f31652 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.101311 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.101711 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.102113 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.102493 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.102888 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.103270 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.103654 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.104045 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.104429 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.104845 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2026-02-27 11:44:33.113694 | controller | INFO     Running default > prepare
2026-02-27 11:44:33.761016 | controller |
2026-02-27 11:44:33.761077 | controller | PLAY [Prepare] *****************************************************************
2026-02-27 11:44:33.761160 | controller |
2026-02-27 11:44:33.761248 | controller | TASK [Gathering Facts] *********************************************************
2026-02-27 11:44:33.761339 | controller | Friday 27 February 2026  11:44:33 +0000 (0:00:00.021)       0:00:00.021 *******
2026-02-27 11:44:34.558085 | controller | ok: [instance]
2026-02-27 11:44:34.558130 | controller |
2026-02-27 11:44:34.558210 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2026-02-27 11:44:34.558304 | controller | Friday 27 February 2026  11:44:34 +0000 (0:00:00.797)       0:00:00.819 *******
2026-02-27 11:44:34.576128 | controller | skipping: [instance]
2026-02-27 11:44:34.576209 | controller |
2026-02-27 11:44:34.576306 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2026-02-27 11:44:34.576397 | controller | Friday 27 February 2026  11:44:34 +0000 (0:00:00.018)       0:00:00.838 *******
2026-02-27 11:44:34.618028 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2026-02-27 11:44:34.618115 | controller |
2026-02-27 11:44:34.618211 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2026-02-27 11:44:34.618305 | controller | Friday 27 February 2026  11:44:34 +0000 (0:00:00.041)       0:00:00.880 *******
2026-02-27 11:44:34.883998 | controller | ok: [instance]
2026-02-27 11:44:34.884054 | controller |
2026-02-27 11:44:34.884170 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2026-02-27 11:44:34.884267 | controller | Friday 27 February 2026  11:44:34 +0000 (0:00:00.265)       0:00:01.145 *******
2026-02-27 11:44:35.173389 | controller | ok: [instance]
2026-02-27 11:44:35.173444 | controller |
2026-02-27 11:44:35.173564 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2026-02-27 11:44:35.173672 | controller | Friday 27 February 2026  11:44:35 +0000 (0:00:00.289)       0:00:01.435 *******
2026-02-27 11:44:35.818432 | controller | ok: [instance] => (item=ubi-9-appstream)
2026-02-27 11:44:35.818502 | controller | ok: [instance] => (item=ubi-9-baseos)
2026-02-27 11:44:35.818637 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2026-02-27 11:44:35.818725 | controller |
2026-02-27 11:44:35.818818 | controller | TASK [Deploy repo-setup] *******************************************************
2026-02-27 11:44:35.818903 | controller | Friday 27 February 2026  11:44:35 +0000 (0:00:00.644)       0:00:02.080 *******
2026-02-27 11:44:35.869340 | controller |
2026-02-27 11:44:35.869543 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-02-27 11:44:35.869669 | controller | Friday 27 February 2026  11:44:35 +0000 (0:00:00.051)       0:00:02.131 *******
2026-02-27 11:44:36.365938 | controller | changed: [instance] => (item=tmp)
2026-02-27 11:44:36.366003 | controller | changed: [instance] => (item=artifacts/repositories)
2026-02-27 11:44:36.366101 | controller | changed: [instance] => (item=venv/repo_setup)
2026-02-27 11:44:36.366181 | controller |
2026-02-27 11:44:36.366268 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-02-27 11:44:36.366353 | controller | Friday 27 February 2026  11:44:36 +0000 (0:00:00.496)       0:00:02.627 *******
2026-02-27 11:44:37.116060 | controller | ok: [instance]
2026-02-27 11:44:37.116109 | controller |
2026-02-27 11:44:37.116213 | controller | TASK [repo_setup : Get repo-setup repository (from local path)] ****************
2026-02-27 11:44:37.116301 | controller | Friday 27 February 2026  11:44:37 +0000 (0:00:00.749)       0:00:03.377 *******
2026-02-27 11:44:37.136119 | controller | skipping: [instance]
2026-02-27 11:44:37.136195 | controller |
2026-02-27 11:44:37.136295 | controller | TASK [repo_setup : Get repo-setup repository (from git URL)] *******************
2026-02-27 11:44:37.136383 | controller | Friday 27 February 2026  11:44:37 +0000 (0:00:00.020)       0:00:03.398 *******
2026-02-27 11:44:38.151014 | controller | changed: [instance]
2026-02-27 11:44:38.151074 | controller |
2026-02-27 11:44:38.151272 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-02-27 11:44:46.165053 | controller | Friday 27 February 2026  11:44:38 +0000 (0:00:01.014)       0:00:04.412 *******
2026-02-27 11:44:46.165090 | controller | changed: [instance]
2026-02-27 11:44:46.865429 | controller |
2026-02-27 11:44:46.865457 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-02-27 11:44:46.865465 | controller | Friday 27 February 2026  11:44:46 +0000 (0:00:08.013)       0:00:12.426 *******
2026-02-27 11:44:46.865476 | controller | changed: [instance]
2026-02-27 11:44:46.886070 | controller |
2026-02-27 11:44:46.886090 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-02-27 11:44:46.886097 | controller | Friday 27 February 2026  11:44:46 +0000 (0:00:00.700)       0:00:13.126 *******
2026-02-27 11:44:46.886106 | controller | skipping: [instance]
2026-02-27 11:44:48.636622 | controller |
2026-02-27 11:44:48.636649 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-02-27 11:44:48.636657 | controller | Friday 27 February 2026  11:44:46 +0000 (0:00:00.021)       0:00:13.147 *******
2026-02-27 11:44:48.636667 | controller | changed: [instance]
2026-02-27 11:44:48.637014 | controller |
2026-02-27 11:44:48.672558 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-02-27 11:44:48.672579 | controller | Friday 27 February 2026  11:44:48 +0000 (0:00:01.750)       0:00:14.898 *******
2026-02-27 11:44:48.672591 | controller | skipping: [instance]
2026-02-27 11:44:48.708131 | controller |
2026-02-27 11:44:48.708149 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-02-27 11:44:48.708156 | controller | Friday 27 February 2026  11:44:48 +0000 (0:00:00.035)       0:00:14.934 *******
2026-02-27 11:44:48.708165 | controller | skipping: [instance]
2026-02-27 11:44:48.742344 | controller |
2026-02-27 11:44:48.742369 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-02-27 11:44:48.742378 | controller | Friday 27 February 2026  11:44:48 +0000 (0:00:00.035)       0:00:14.969 *******
2026-02-27 11:44:48.742389 | controller | skipping: [instance]
2026-02-27 11:44:49.440928 | controller |
2026-02-27 11:44:49.440959 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-02-27 11:44:49.440976 | controller | Friday 27 February 2026  11:44:48 +0000 (0:00:00.034)       0:00:15.003 *******
2026-02-27 11:44:49.440987 | controller | changed: [instance]
2026-02-27 11:44:49.864947 | controller |
2026-02-27 11:44:49.864989 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-02-27 11:44:49.864997 | controller | Friday 27 February 2026  11:44:49 +0000 (0:00:00.698)       0:00:15.702 *******
2026-02-27 11:44:49.865007 | controller | changed: [instance]
2026-02-27 11:44:49.893710 | controller |
2026-02-27 11:44:49.893735 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-02-27 11:44:49.893743 | controller | Friday 27 February 2026  11:44:49 +0000 (0:00:00.424)       0:00:16.126 *******
2026-02-27 11:44:49.893756 | controller | skipping: [instance]
2026-02-27 11:44:49.955268 | controller |
2026-02-27 11:44:49.955293 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-02-27 11:44:49.955301 | controller | Friday 27 February 2026  11:44:49 +0000 (0:00:00.028)       0:00:16.155 *******
2026-02-27 11:44:49.955311 | controller | skipping: [instance]
2026-02-27 11:44:49.983439 | controller |
2026-02-27 11:44:49.983458 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-02-27 11:44:49.983465 | controller | Friday 27 February 2026  11:44:49 +0000 (0:00:00.061)       0:00:16.217 *******
2026-02-27 11:44:49.983474 | controller | skipping: [instance]
2026-02-27 11:44:50.020495 | controller |
2026-02-27 11:44:50.020514 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-02-27 11:44:50.020544 | controller | Friday 27 February 2026  11:44:49 +0000 (0:00:00.028)       0:00:16.245 *******
2026-02-27 11:44:50.020555 | controller | ok: [instance]
2026-02-27 11:44:50.047205 | controller |
2026-02-27 11:44:50.047226 | controller | TASK [repo_setup : Create download directory] **********************************
2026-02-27 11:44:50.047233 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.037)       0:00:16.282 *******
2026-02-27 11:44:50.047251 | controller | skipping: [instance]
2026-02-27 11:44:50.073176 | controller |
2026-02-27 11:44:50.073196 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-02-27 11:44:50.073203 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.026)       0:00:16.308 *******
2026-02-27 11:44:50.073212 | controller | skipping: [instance]
2026-02-27 11:44:50.099417 | controller |
2026-02-27 11:44:50.099440 | controller | TASK [Download the RPM] ********************************************************
2026-02-27 11:44:50.099448 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.026)       0:00:16.334 *******
2026-02-27 11:44:50.099458 | controller | skipping: [instance]
2026-02-27 11:44:50.125595 | controller |
2026-02-27 11:44:50.125625 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-02-27 11:44:50.125635 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.026)       0:00:16.361 *******
2026-02-27 11:44:50.125646 | controller | skipping: [instance]
2026-02-27 11:44:50.125666 | controller |
2026-02-27 11:44:50.125674 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-02-27 11:44:50.125683 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.026)       0:00:16.387 *******
2026-02-27 11:44:50.150822 | controller | skipping: [instance]
2026-02-27 11:44:50.150918 | controller |
2026-02-27 11:44:50.151034 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-02-27 11:44:50.151133 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.025)       0:00:16.412 *******
2026-02-27 11:44:50.178869 | controller | skipping: [instance]
2026-02-27 11:44:50.178968 | controller |
2026-02-27 11:44:50.179083 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-02-27 11:44:50.179184 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.028)       0:00:16.440 *******
2026-02-27 11:44:50.203967 | controller | skipping: [instance]
2026-02-27 11:44:50.204066 | controller |
2026-02-27 11:44:50.204176 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-02-27 11:44:50.204279 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.025)       0:00:16.466 *******
2026-02-27 11:44:50.377474 | controller | ok: [instance]
2026-02-27 11:44:50.377565 | controller |
2026-02-27 11:44:50.377804 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-02-27 11:44:50.573943 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.173)       0:00:16.639 *******
2026-02-27 11:44:50.573986 | controller | changed: [instance]
2026-02-27 11:44:50.790113 | controller |
2026-02-27 11:44:50.790141 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-02-27 11:44:50.790149 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.196)       0:00:16.835 *******
2026-02-27 11:44:50.790159 | controller | changed: [instance]
2026-02-27 11:44:50.811059 | controller |
2026-02-27 11:44:50.811082 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-02-27 11:44:50.811089 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.216)       0:00:17.051 *******
2026-02-27 11:44:50.811098 | controller | skipping: [instance]
2026-02-27 11:44:50.834057 | controller |
2026-02-27 11:44:50.834076 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-02-27 11:44:50.834084 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.021)       0:00:17.072 *******
2026-02-27 11:44:50.834093 | controller | skipping: [instance]
2026-02-27 11:44:50.856406 | controller |
2026-02-27 11:44:50.856425 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-02-27 11:44:50.856432 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.022)       0:00:17.095 *******
2026-02-27 11:44:50.856441 | controller | skipping: [instance]
2026-02-27 11:44:50.879386 | controller |
2026-02-27 11:44:50.879418 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-02-27 11:44:50.879426 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.022)       0:00:17.118 *******
2026-02-27 11:44:50.879436 | controller | skipping: [instance]
2026-02-27 11:44:50.901328 | controller |
2026-02-27 11:44:50.901347 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-02-27 11:44:50.901361 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.022)       0:00:17.140 *******
2026-02-27 11:44:50.901370 | controller | skipping: [instance]
2026-02-27 11:44:50.923336 | controller |
2026-02-27 11:44:50.923354 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-02-27 11:44:50.923362 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.022)       0:00:17.163 *******
2026-02-27 11:44:50.923370 | controller | skipping: [instance]
2026-02-27 11:44:50.941059 | controller |
2026-02-27 11:44:50.941077 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-02-27 11:44:50.941084 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.021)       0:00:17.185 *******
2026-02-27 11:44:50.941092 | controller | skipping: [instance]
2026-02-27 11:44:50.969168 | controller |
2026-02-27 11:44:50.969185 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-02-27 11:44:50.969192 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.017)       0:00:17.202 *******
2026-02-27 11:44:50.969200 | controller | skipping: [instance]
2026-02-27 11:44:50.985469 | controller |
2026-02-27 11:44:50.985488 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-02-27 11:44:50.985496 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.028)       0:00:17.230 *******
2026-02-27 11:44:50.985506 | controller | skipping: [instance]
2026-02-27 11:44:51.005455 | controller |
2026-02-27 11:44:51.005472 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-02-27 11:44:51.005479 | controller | Friday 27 February 2026  11:44:50 +0000 (0:00:00.016)       0:00:17.247 *******
2026-02-27 11:44:51.005487 | controller | skipping: [instance]
2026-02-27 11:44:51.034308 | controller |
2026-02-27 11:44:51.034327 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2026-02-27 11:44:51.034335 | controller | Friday 27 February 2026  11:44:51 +0000 (0:00:00.020)       0:00:17.267 *******
2026-02-27 11:44:51.034345 | controller | skipping: [instance]
2026-02-27 11:44:51.065240 | controller |
2026-02-27 11:44:51.065262 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2026-02-27 11:44:51.065271 | controller | Friday 27 February 2026  11:44:51 +0000 (0:00:00.028)       0:00:17.296 *******
2026-02-27 11:44:51.065281 | controller | skipping: [instance]
2026-02-27 11:44:51.065448 | controller |
2026-02-27 11:44:51.065645 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2026-02-27 11:44:51.065813 | controller | Friday 27 February 2026  11:44:51 +0000 (0:00:00.031)       0:00:17.327 *******
2026-02-27 11:44:51.094654 | controller | skipping: [instance]
2026-02-27 11:44:51.094919 | controller |
2026-02-27 11:44:51.095187 | controller | TASK [test_deps : Install additional packages] *********************************
2026-02-27 11:44:51.095358 | controller | Friday 27 February 2026  11:44:51 +0000 (0:00:00.029)       0:00:17.356 *******
2026-02-27 11:44:51.123142 | controller | skipping: [instance]
2026-02-27 11:44:51.123394 | controller |
2026-02-27 11:44:51.123556 | controller | TASK [test_deps : Install selinux python libs] *********************************
2026-02-27 11:44:51.123703 | controller | Friday 27 February 2026  11:44:51 +0000 (0:00:00.028)       0:00:17.385 *******
2026-02-27 11:45:36.293881 | controller | ok: [instance]
2026-02-27 11:45:37.434308 | controller |
2026-02-27 11:45:37.434339 | controller | TASK [test_deps : Install python yaml libs] ************************************
2026-02-27 11:45:37.434347 | controller | Friday 27 February 2026  11:45:36 +0000 (0:00:45.170)       0:01:02.555 *******
2026-02-27 11:45:37.434357 | controller | ok: [instance]
2026-02-27 11:45:37.466079 | controller |
2026-02-27 11:45:37.466108 | controller | TASK [test_deps : Install extra packages] **************************************
2026-02-27 11:45:37.466116 | controller | Friday 27 February 2026  11:45:37 +0000 (0:00:01.140)       0:01:03.695 *******
2026-02-27 11:45:37.466128 | controller | skipping: [instance]
2026-02-27 11:45:37.988389 | controller |
2026-02-27 11:45:37.988419 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-02-27 11:45:37.988427 | controller | Friday 27 February 2026  11:45:37 +0000 (0:00:00.031)       0:01:03.727 *******
2026-02-27 11:45:37.988437 | controller | ok: [instance] => (item=tmp)
2026-02-27 11:45:39.149833 | controller | ok: [instance] => (item=artifacts/repositories)
2026-02-27 11:45:39.149865 | controller | ok: [instance] => (item=venv/repo_setup)
2026-02-27 11:45:39.149879 | controller |
2026-02-27 11:45:39.149885 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-02-27 11:45:39.149891 | controller | Friday 27 February 2026  11:45:37 +0000 (0:00:00.522)       0:01:04.249 *******
2026-02-27 11:45:39.149901 | controller | ok: [instance]
2026-02-27 11:45:39.169586 | controller |
2026-02-27 11:45:39.169611 | controller | TASK [repo_setup : Get repo-setup repository (from local path)] ****************
2026-02-27 11:45:39.169627 | controller | Friday 27 February 2026  11:45:39 +0000 (0:00:01.161)       0:01:05.411 *******
2026-02-27 11:45:39.169638 | controller | skipping: [instance]
2026-02-27 11:45:39.169949 | controller |
2026-02-27 11:45:39.169966 | controller | TASK [repo_setup : Get repo-setup repository (from git URL)] *******************
2026-02-27 11:45:39.775900 | controller | Friday 27 February 2026  11:45:39 +0000 (0:00:00.020)       0:01:05.431 *******
2026-02-27 11:45:39.775934 | controller | ok: [instance]
2026-02-27 11:45:40.890218 | controller |
2026-02-27 11:45:40.890248 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-02-27 11:45:40.890256 | controller | Friday 27 February 2026  11:45:39 +0000 (0:00:00.606)       0:01:06.037 *******
2026-02-27 11:45:40.890266 | controller | ok: [instance]
2026-02-27 11:45:41.066070 | controller |
2026-02-27 11:45:41.066098 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-02-27 11:45:41.066106 | controller | Friday 27 February 2026  11:45:40 +0000 (0:00:01.114)       0:01:07.151 *******
2026-02-27 11:45:41.066116 | controller | ok: [instance]
2026-02-27 11:45:41.087606 | controller |
2026-02-27 11:45:41.087636 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-02-27 11:45:41.087645 | controller | Friday 27 February 2026  11:45:41 +0000 (0:00:00.175)       0:01:07.327 *******
2026-02-27 11:45:41.087657 | controller | skipping: [instance]
2026-02-27 11:45:41.087680 | controller |
2026-02-27 11:45:41.087720 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-02-27 11:45:41.087835 | controller | Friday 27 February 2026  11:45:41 +0000 (0:00:00.021)       0:01:07.349 *******
2026-02-27 11:45:41.861109 | controller | changed: [instance]
2026-02-27 11:45:41.896128 | controller |
2026-02-27 11:45:41.896154 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-02-27 11:45:41.896163 | controller | Friday 27 February 2026  11:45:41 +0000 (0:00:00.773)       0:01:08.122 *******
2026-02-27 11:45:41.896175 | controller | skipping: [instance]
2026-02-27 11:45:41.930713 | controller |
2026-02-27 11:45:41.930731 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-02-27 11:45:41.930738 | controller | Friday 27 February 2026  11:45:41 +0000 (0:00:00.035)       0:01:08.157 *******
2026-02-27 11:45:41.930747 | controller | skipping: [instance]
2026-02-27 11:45:41.965332 | controller |
2026-02-27 11:45:41.965356 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-02-27 11:45:41.965365 | controller | Friday 27 February 2026  11:45:41 +0000 (0:00:00.034)       0:01:08.192 *******
2026-02-27 11:45:41.965375 | controller | skipping: [instance]
2026-02-27 11:45:42.496906 | controller |
2026-02-27 11:45:42.496933 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-02-27 11:45:42.496941 | controller | Friday 27 February 2026  11:45:41 +0000 (0:00:00.034)       0:01:08.226 *******
2026-02-27 11:45:42.496951 | controller | changed: [instance]
2026-02-27 11:45:42.821066 | controller |
2026-02-27 11:45:42.821094 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-02-27 11:45:42.821102 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.531)       0:01:08.758 *******
2026-02-27 11:45:42.821112 | controller | changed: [instance]
2026-02-27 11:45:42.846600 | controller |
2026-02-27 11:45:42.846627 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-02-27 11:45:42.846635 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.324)       0:01:09.082 *******
2026-02-27 11:45:42.846646 | controller | skipping: [instance]
2026-02-27 11:45:42.872314 | controller |
2026-02-27 11:45:42.872336 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-02-27 11:45:42.872349 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.025)       0:01:09.108 *******
2026-02-27 11:45:42.872359 | controller | skipping: [instance]
2026-02-27 11:45:42.898156 | controller |
2026-02-27 11:45:42.898179 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-02-27 11:45:42.898188 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.025)       0:01:09.134 *******
2026-02-27 11:45:42.898199 | controller | skipping: [instance]
2026-02-27 11:45:42.932588 | controller |
2026-02-27 11:45:42.932612 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-02-27 11:45:42.932620 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.025)       0:01:09.159 *******
2026-02-27 11:45:42.932630 | controller | ok: [instance]
2026-02-27 11:45:42.932646 | controller |
2026-02-27 11:45:42.932653 | controller | TASK [repo_setup : Create download directory] **********************************
2026-02-27 11:45:42.932660 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.034)       0:01:09.194 *******
2026-02-27 11:45:42.956317 | controller | skipping: [instance]
2026-02-27 11:45:42.979971 | controller |
2026-02-27 11:45:42.980005 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-02-27 11:45:42.980013 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.023)       0:01:09.218 *******
2026-02-27 11:45:42.980021 | controller | skipping: [instance]
2026-02-27 11:45:43.007005 | controller |
2026-02-27 11:45:43.007027 | controller | TASK [Download the RPM] ********************************************************
2026-02-27 11:45:43.007034 | controller | Friday 27 February 2026  11:45:42 +0000 (0:00:00.023)       0:01:09.241 *******
2026-02-27 11:45:43.007043 | controller | skipping: [instance]
2026-02-27 11:45:43.050250 | controller |
2026-02-27 11:45:43.050278 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-02-27 11:45:43.050286 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.026)       0:01:09.268 *******
2026-02-27 11:45:43.050298 | controller | skipping: [instance]
2026-02-27 11:45:43.075913 | controller |
2026-02-27 11:45:43.075936 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-02-27 11:45:43.075943 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.043)       0:01:09.311 *******
2026-02-27 11:45:43.075953 | controller | skipping: [instance]
2026-02-27 11:45:43.102575 | controller |
2026-02-27 11:45:43.102596 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-02-27 11:45:43.102604 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.025)       0:01:09.337 *******
2026-02-27 11:45:43.102613 | controller | skipping: [instance]
2026-02-27 11:45:43.102631 | controller |
2026-02-27 11:45:43.102714 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2026-02-27 11:45:43.102855 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.026)       0:01:09.364 *******
2026-02-27 11:45:43.128579 | controller | skipping: [instance]
2026-02-27 11:45:43.128688 | controller |
2026-02-27 11:45:43.128704 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-02-27 11:45:43.128713 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.026)       0:01:09.390 *******
2026-02-27 11:45:43.303558 | controller | ok: [instance]
2026-02-27 11:45:43.496605 | controller |
2026-02-27 11:45:43.496639 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-02-27 11:45:43.496647 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.174)       0:01:09.565 *******
2026-02-27 11:45:43.496658 | controller | changed: [instance]
2026-02-27 11:45:43.496678 | controller |
2026-02-27 11:45:43.496855 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-02-27 11:45:43.701771 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.193)       0:01:09.758 *******
2026-02-27 11:45:43.701806 | controller | changed: [instance]
2026-02-27 11:45:43.723038 | controller |
2026-02-27 11:45:43.723061 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-02-27 11:45:43.723069 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.204)       0:01:09.963 *******
2026-02-27 11:45:43.723079 | controller | skipping: [instance]
2026-02-27 11:45:43.746180 | controller |
2026-02-27 11:45:43.746201 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-02-27 11:45:43.746208 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.021)       0:01:09.984 *******
2026-02-27 11:45:43.746217 | controller | skipping: [instance]
2026-02-27 11:45:43.768587 | controller |
2026-02-27 11:45:43.768608 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-02-27 11:45:43.768616 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.023)       0:01:10.007 *******
2026-02-27 11:45:43.768626 | controller | skipping: [instance]
2026-02-27 11:45:43.768648 | controller |
2026-02-27 11:45:43.768656 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-02-27 11:45:43.768728 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.022)       0:01:10.030 *******
2026-02-27 11:45:43.791220 | controller | skipping: [instance]
2026-02-27 11:45:43.814388 | controller |
2026-02-27 11:45:43.814407 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-02-27 11:45:43.814414 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.022)       0:01:10.052 *******
2026-02-27 11:45:43.814423 | controller | skipping: [instance]
2026-02-27 11:45:43.837176 | controller |
2026-02-27 11:45:43.837195 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-02-27 11:45:43.837203 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.023)       0:01:10.076 *******
2026-02-27 11:45:43.837212 | controller | skipping: [instance]
2026-02-27 11:45:44.090896 | controller |
2026-02-27 11:45:44.090924 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-02-27 11:45:44.090932 | controller | Friday 27 February 2026  11:45:43 +0000 (0:00:00.022)       0:01:10.098 *******
2026-02-27 11:45:44.090942 | controller | ok: [instance]
2026-02-27 11:45:45.553616 | controller |
2026-02-27 11:45:45.553647 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-02-27 11:45:45.553655 | controller | Friday 27 February 2026  11:45:44 +0000 (0:00:00.253)       0:01:10.352 *******
2026-02-27 11:45:45.553666 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos-addons.repo)
2026-02-27 11:45:45.553849 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos.repo)
2026-02-27 11:45:45.553861 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean.repo)
2026-02-27 11:45:45.553867 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean-master-testing.repo)
2026-02-27 11:45:45.553873 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-highavailability.repo)
2026-02-27 11:45:45.553884 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-powertools.repo)
2026-02-27 11:45:45.553890 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-appstream.repo)
2026-02-27 11:45:45.553895 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-baseos.repo)
2026-02-27 11:45:45.553901 | controller |
2026-02-27 11:45:45.553909 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-02-27 11:45:45.980480 | controller | Friday 27 February 2026  11:45:45 +0000 (0:00:01.462)       0:01:11.814 *******
2026-02-27 11:45:45.980515 | controller | changed: [instance]
2026-02-27 11:45:46.206854 | controller |
2026-02-27 11:45:46.206897 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-02-27 11:45:46.206905 | controller | Friday 27 February 2026  11:45:45 +0000 (0:00:00.427)       0:01:12.241 *******
2026-02-27 11:45:46.206916 | controller | changed: [instance]
2026-02-27 11:45:46.206944 | controller |
2026-02-27 11:45:46.206951 | controller | PLAY RECAP *********************************************************************
2026-02-27 11:45:46.206956 | controller | instance                   : ok=35   changed=17   unreachable=0    failed=0    skipped=52   rescued=0    ignored=0
2026-02-27 11:45:46.206962 | controller |
2026-02-27 11:45:46.206967 | controller | Friday 27 February 2026  11:45:46 +0000 (0:00:00.224)       0:01:12.466 *******
2026-02-27 11:45:46.206973 | controller | ===============================================================================
2026-02-27 11:45:46.206978 | controller | test_deps : Install selinux python libs -------------------------------- 45.17s
2026-02-27 11:45:46.207001 | controller | repo_setup : Initialize python venv and install requirements ------------ 8.01s
2026-02-27 11:45:46.207008 | controller | repo_setup : Run repo-setup --------------------------------------------- 1.75s
2026-02-27 11:45:46.207013 | controller | repo_setup : Remove existing repos from /etc/yum.repos.d directory ------ 1.46s
2026-02-27 11:45:46.207018 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.16s
2026-02-27 11:45:46.207026 | controller | test_deps : Install python yaml libs ------------------------------------ 1.14s
2026-02-27 11:45:46.266493 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.11s
2026-02-27 11:45:46.266544 | controller | repo_setup : Get repo-setup repository (from git URL) ------------------- 1.01s
2026-02-27 11:45:46.266556 | controller | Gathering Facts --------------------------------------------------------- 0.80s
2026-02-27 11:45:46.266562 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.77s
2026-02-27 11:45:46.266568 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.75s
2026-02-27 11:45:46.266573 | controller | repo_setup : Install repo-setup package --------------------------------- 0.70s
2026-02-27 11:45:46.266578 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.70s
2026-02-27 11:45:46.266584 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.65s
2026-02-27 11:45:46.266589 | controller | repo_setup : Get repo-setup repository (from git URL) ------------------- 0.61s
2026-02-27 11:45:46.266594 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s
2026-02-27 11:45:46.266600 | controller | repo_setup : Ensure directories are present ----------------------------- 0.52s
2026-02-27 11:45:46.266605 | controller | repo_setup : Ensure directories are present ----------------------------- 0.50s
2026-02-27 11:45:46.266610 | controller | repo_setup : Cleanup existing metadata ---------------------------------- 0.43s
2026-02-27 11:45:46.266615 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.42s
2026-02-27 11:45:46.266626 | controller | INFO     Running default > converge
2026-02-27 11:45:46.745073 | controller |
2026-02-27 11:45:47.514597 | controller | PLAY [Converge] ****************************************************************
2026-02-27 11:45:47.514632 | controller |
2026-02-27 11:45:47.514644 | controller | TASK [Gathering Facts] *********************************************************
2026-02-27 11:45:47.514651 | controller | Friday 27 February 2026  11:45:46 +0000 (0:00:00.034)       0:00:00.034 *******
2026-02-27 11:45:47.514661 | controller | ok: [instance]
2026-02-27 11:45:48.784300 | controller |
2026-02-27 11:45:48.784335 | controller | TASK [Clone neutron-tempest-plugin] ********************************************
2026-02-27 11:45:48.784343 | controller | Friday 27 February 2026  11:45:47 +0000 (0:00:00.769)       0:00:00.804 *******
2026-02-27 11:45:48.784354 | controller | changed: [instance]
2026-02-27 11:45:48.808605 | controller |
2026-02-27 11:45:48.808631 | controller | TASK [Set cifmw_bop_openstack_project_path] ************************************
2026-02-27 11:45:48.808640 | controller | Friday 27 February 2026  11:45:48 +0000 (0:00:01.269)       0:00:02.073 *******
2026-02-27 11:45:48.808652 | controller | ok: [instance]
2026-02-27 11:45:48.808711 | controller |
2026-02-27 11:45:48.808726 | controller | TASK [build_openstack_packages : Install Mock from DLRN repos] *****************
2026-02-27 11:45:48.808736 | controller | Friday 27 February 2026  11:45:48 +0000 (0:00:00.024)       0:00:02.098 *******
2026-02-27 11:46:15.354062 | controller | changed: [instance]
2026-02-27 11:46:16.809293 | controller |
2026-02-27 11:46:16.809323 | controller | TASK [build_openstack_packages : Ensure DLRN package dependencies] *************
2026-02-27 11:46:16.809332 | controller | Friday 27 February 2026  11:46:15 +0000 (0:00:26.545)       0:00:28.643 *******
2026-02-27 11:46:16.809342 | controller | changed: [instance]
2026-02-27 11:46:17.106920 | controller |
2026-02-27 11:46:17.106953 | controller | TASK [build_openstack_packages : Create mock group] ****************************
2026-02-27 11:46:17.106961 | controller | Friday 27 February 2026  11:46:16 +0000 (0:00:01.455)       0:00:30.098 *******
2026-02-27 11:46:17.106972 | controller | ok: [instance]
2026-02-27 11:46:17.479949 | controller |
2026-02-27 11:46:17.479981 | controller | TASK [build_openstack_packages : Add user to mock group] ***********************
2026-02-27 11:46:17.479989 | controller | Friday 27 February 2026  11:46:17 +0000 (0:00:00.297)       0:00:30.396 *******
2026-02-27 11:46:17.479999 | controller | changed: [instance]
2026-02-27 11:46:17.759350 | controller |
2026-02-27 11:46:17.759382 | controller | TASK [build_openstack_packages : Ensure DLRN dir is present] *******************
2026-02-27 11:46:17.759391 | controller | Friday 27 February 2026  11:46:17 +0000 (0:00:00.373)       0:00:30.769 *******
2026-02-27 11:46:17.759400 | controller | changed: [instance]
2026-02-27 11:46:18.034496 | controller |
2026-02-27 11:46:18.034543 | controller | TASK [build_openstack_packages : Remove data files from previous runs] *********
2026-02-27 11:46:18.034554 | controller | Friday 27 February 2026  11:46:17 +0000 (0:00:00.278)       0:00:31.048 *******
2026-02-27 11:46:18.034565 | controller | ok: [instance]
2026-02-27 11:46:21.860403 | controller |
2026-02-27 11:46:21.860443 | controller | TASK [build_openstack_packages : Create dlrn-venv] *****************************
2026-02-27 11:46:21.860451 | controller | Friday 27 February 2026  11:46:18 +0000 (0:00:00.275)       0:00:31.323 *******
2026-02-27 11:46:21.860461 | controller | changed: [instance]
2026-02-27 11:46:21.887301 | controller |
2026-02-27 11:46:21.887321 | controller | TASK [build_openstack_packages : Fetch DLRN from source] ***********************
2026-02-27 11:46:21.887329 | controller | Friday 27 February 2026  11:46:21 +0000 (0:00:03.826)       0:00:35.149 *******
2026-02-27 11:46:21.887338 | controller | skipping: [instance]
2026-02-27 11:46:21.913623 | controller |
2026-02-27 11:46:21.913655 | controller | TASK [build_openstack_packages : Install DLRN requirements] ********************
2026-02-27 11:46:21.913664 | controller | Friday 27 February 2026  11:46:21 +0000 (0:00:00.027)       0:00:35.177 *******
2026-02-27 11:46:21.913674 | controller | skipping: [instance]
2026-02-27 11:46:21.940094 | controller |
2026-02-27 11:46:21.940116 | controller | TASK [build_openstack_packages : Install DLRN from source] *********************
2026-02-27 11:46:21.940124 | controller | Friday 27 February 2026  11:46:21 +0000 (0:00:00.026)       0:00:35.203 *******
2026-02-27 11:46:21.940133 | controller | skipping: [instance]
2026-02-27 11:46:36.559620 | controller |
2026-02-27 11:46:36.559652 | controller | TASK [build_openstack_packages : Install DLRN and rdopkg from pip] *************
2026-02-27 11:46:36.559661 | controller | Friday 27 February 2026  11:46:21 +0000 (0:00:00.026)       0:00:35.230 *******
2026-02-27 11:46:36.559671 | controller | changed: [instance]
2026-02-27 11:46:36.559700 | controller |
2026-02-27 11:46:36.559707 | controller | TASK [build_openstack_packages : Drop in the templated version of projects.ini] ***
2026-02-27 11:46:36.559715 | controller | Friday 27 February 2026  11:46:36 +0000 (0:00:14.619)       0:00:49.849 *******
2026-02-27 11:46:37.135631 | controller | changed: [instance]
2026-02-27 11:46:37.135742 | controller |
2026-02-27 11:46:37.135772 | controller | TASK [build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir] ***
2026-02-27 11:46:37.135784 | controller | Friday 27 February 2026  11:46:37 +0000 (0:00:00.576)       0:00:50.425 *******
2026-02-27 11:46:37.485549 | controller | changed: [instance]
2026-02-27 11:46:40.198449 | controller |
2026-02-27 11:46:40.198484 | controller | TASK [build_openstack_packages : Fetch local rdoinfo copy] *********************
2026-02-27 11:46:40.198493 | controller | Friday 27 February 2026  11:46:37 +0000 (0:00:00.349)       0:00:50.775 *******
2026-02-27 11:46:40.198504 | controller | changed: [instance]
2026-02-27 11:46:40.218275 | controller |
2026-02-27 11:46:40.218292 | controller | TASK [build_openstack_packages : Downstream related tasks] *********************
2026-02-27 11:46:40.218299 | controller | Friday 27 February 2026  11:46:40 +0000 (0:00:02.712)       0:00:53.487 *******
2026-02-27 11:46:40.218307 | controller | skipping: [instance]
2026-02-27 11:46:40.493065 | controller |
2026-02-27 11:46:40.493096 | controller | TASK [build_openstack_packages : Find all the repos files] *********************
2026-02-27 11:46:40.493104 | controller | Friday 27 February 2026  11:46:40 +0000 (0:00:00.019)       0:00:53.507 *******
2026-02-27 11:46:40.493114 | controller | ok: [instance]
2026-02-27 11:46:40.677109 | controller |
2026-02-27 11:46:40.677138 | controller | TASK [build_openstack_packages : Create local mock config] *********************
2026-02-27 11:46:40.677146 | controller | Friday 27 February 2026  11:46:40 +0000 (0:00:00.274)       0:00:53.782 *******
2026-02-27 11:46:40.677162 | controller | changed: [instance]
2026-02-27 11:46:40.861348 | controller |
2026-02-27 11:46:40.861373 | controller | TASK [build_openstack_packages : Remove last """ from local mock config] *******
2026-02-27 11:46:40.861381 | controller | Friday 27 February 2026  11:46:40 +0000 (0:00:00.184)       0:00:53.966 *******
2026-02-27 11:46:40.861391 | controller | changed: [instance]
2026-02-27 11:46:40.917663 | controller |
2026-02-27 11:46:40.917695 | controller | TASK [build_openstack_packages : Append repos into mock local config] **********
2026-02-27 11:46:40.917704 | controller | Friday 27 February 2026  11:46:40 +0000 (0:00:00.184)       0:00:54.151 *******
2026-02-27 11:46:40.917720 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/delorean.repo)
2026-02-27 11:46:40.917747 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/delorean-antelope-testing.repo)
2026-02-27 11:46:40.917757 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-highavailability.repo)
2026-02-27 11:46:40.917764 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-powertools.repo)
2026-02-27 11:46:40.917770 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-appstream.repo)
2026-02-27 11:46:40.917775 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/append_repos.yml for instance => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/artifacts/repositories/repo-setup-centos-baseos.repo)
2026-02-27 11:46:40.917781 | controller |
2026-02-27 11:46:40.917789 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-02-27 11:46:41.166028 | controller | Friday 27 February 2026  11:46:40 +0000 (0:00:00.055)       0:00:54.206 *******
2026-02-27 11:46:41.166073 | controller | ok: [instance]
2026-02-27 11:46:41.197026 | controller |
2026-02-27 11:46:41.197054 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-02-27 11:46:41.197062 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.248)       0:00:54.455 *******
2026-02-27 11:46:41.197070 | controller | ok: [instance]
2026-02-27 11:46:41.364597 | controller |
2026-02-27 11:46:41.364628 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-02-27 11:46:41.364637 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.031)       0:00:54.486 *******
2026-02-27 11:46:41.364647 | controller | ok: [instance]
2026-02-27 11:46:41.364672 | controller |
2026-02-27 11:46:41.364915 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-02-27 11:46:41.395407 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.167)       0:00:54.654 *******
2026-02-27 11:46:41.395436 | controller | ok: [instance]
2026-02-27 11:46:41.564601 | controller |
2026-02-27 11:46:41.564632 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-02-27 11:46:41.564640 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.030)       0:00:54.685 *******
2026-02-27 11:46:41.564651 | controller | ok: [instance]
2026-02-27 11:46:41.564977 | controller |
2026-02-27 11:46:41.595977 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-02-27 11:46:41.596004 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.169)       0:00:54.854 *******
2026-02-27 11:46:41.596021 | controller | ok: [instance]
2026-02-27 11:46:41.760753 | controller |
2026-02-27 11:46:41.760781 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-02-27 11:46:41.760789 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.031)       0:00:54.885 *******
2026-02-27 11:46:41.760799 | controller | ok: [instance]
2026-02-27 11:46:41.790621 | controller |
2026-02-27 11:46:41.790652 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-02-27 11:46:41.790660 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.164)       0:00:55.050 *******
2026-02-27 11:46:41.790670 | controller | ok: [instance]
2026-02-27 11:46:41.790699 | controller |
2026-02-27 11:46:41.790965 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-02-27 11:46:41.957204 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.030)       0:00:55.080 *******
2026-02-27 11:46:41.957233 | controller | ok: [instance]
2026-02-27 11:46:41.988174 | controller |
2026-02-27 11:46:41.988194 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-02-27 11:46:41.988207 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.166)       0:00:55.246 *******
2026-02-27 11:46:41.988217 | controller | ok: [instance]
2026-02-27 11:46:42.151997 | controller |
2026-02-27 11:46:42.152018 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-02-27 11:46:42.152026 | controller | Friday 27 February 2026  11:46:41 +0000 (0:00:00.031)       0:00:55.278 *******
2026-02-27 11:46:42.152035 | controller | ok: [instance]
2026-02-27 11:46:42.183023 | controller |
2026-02-27 11:46:42.183050 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-02-27 11:46:42.183057 | controller | Friday 27 February 2026  11:46:42 +0000 (0:00:00.163)       0:00:55.441 *******
2026-02-27 11:46:42.183066 | controller | ok: [instance]
2026-02-27 11:46:42.488176 | controller |
2026-02-27 11:46:42.488206 | controller | TASK [build_openstack_packages : Append repo_content ending with """ in mock local config at last] ***
2026-02-27 11:46:42.488214 | controller | Friday 27 February 2026  11:46:42 +0000 (0:00:00.031)       0:00:55.472 *******
2026-02-27 11:46:42.488225 | controller | changed: [instance]
2026-02-27 11:46:44.357630 | controller |
2026-02-27 11:46:44.357667 | controller | TASK [build_openstack_packages : Check loop devices stat] **********************
2026-02-27 11:46:44.357678 | controller | Friday 27 February 2026  11:46:42 +0000 (0:00:00.304)       0:00:55.777 *******
2026-02-27 11:46:44.357691 | controller | ok: [instance] => (item=0)
2026-02-27 11:46:44.357722 | controller | ok: [instance] => (item=1)
2026-02-27 11:46:44.357730 | controller | ok: [instance] => (item=2)
2026-02-27 11:46:44.357737 | controller | ok: [instance] => (item=3)
2026-02-27 11:46:44.357744 | controller | ok: [instance] => (item=4)
2026-02-27 11:46:44.357754 | controller | ok: [instance] => (item=5)
2026-02-27 11:46:44.357779 | controller | ok: [instance] => (item=6)
2026-02-27 11:46:44.358562 | controller | ok: [instance] => (item=7)
2026-02-27 11:46:44.393598 | controller | ok: [instance] => (item=8)
2026-02-27 11:46:44.393625 | controller | ok: [instance] => (item=9)
2026-02-27 11:46:44.393635 | controller | ok: [instance] => (item=10)
2026-02-27 11:46:44.393642 | controller | ok: [instance] => (item=11)
2026-02-27 11:46:44.393650 | controller |
2026-02-27 11:46:44.393657 | controller | TASK [build_openstack_packages : Set loop_devices_absent fact] *****************
2026-02-27 11:46:44.393665 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:01.869)       0:00:57.647 *******
2026-02-27 11:46:44.393676 | controller | ok: [instance]
2026-02-27 11:46:44.393707 | controller |
2026-02-27 11:46:44.393969 | controller | TASK [build_openstack_packages : Parse Zuul changes] ***************************
2026-02-27 11:46:44.427134 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.036)       0:00:57.683 *******
2026-02-27 11:46:44.427158 | controller | skipping: [instance]
2026-02-27 11:46:44.446505 | controller |
2026-02-27 11:46:44.446538 | controller | TASK [build_openstack_packages : Print Zuul change list] ***********************
2026-02-27 11:46:44.446548 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.033)       0:00:57.716 *******
2026-02-27 11:46:44.446557 | controller | ok: [instance] =>
2026-02-27 11:46:44.462287 | controller |   cifmw_bop_change_list: []
2026-02-27 11:46:44.462307 | controller |
2026-02-27 11:46:44.462315 | controller | TASK [build_openstack_packages : Build DLRN packages from zuul changes] ********
2026-02-27 11:46:44.462330 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.019)       0:00:57.736 *******
2026-02-27 11:46:44.462341 | controller | skipping: [instance]
2026-02-27 11:46:44.513246 | controller |
2026-02-27 11:46:44.513267 | controller | TASK [build_openstack_packages : Build DLRN packages from Local change] ********
2026-02-27 11:46:44.513276 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.015)       0:00:57.752 *******
2026-02-27 11:46:44.513286 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/run_dlrn.yml for instance
2026-02-27 11:46:44.543606 | controller |
2026-02-27 11:46:44.543634 | controller | TASK [build_openstack_packages : Set proper branch name for stable opendev branches] ***
2026-02-27 11:46:44.543645 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.050)       0:00:57.803 *******
2026-02-27 11:46:44.543658 | controller | skipping: [instance]
2026-02-27 11:46:44.543690 | controller |
2026-02-27 11:46:44.543850 | controller | TASK [build_openstack_packages : Set proper branch name for non-stable branches] ***
2026-02-27 11:46:44.576472 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.030)       0:00:57.833 *******
2026-02-27 11:46:44.576495 | controller | ok: [instance]
2026-02-27 11:46:44.596843 | controller |
2026-02-27 11:46:44.596862 | controller | TASK [build_openstack_packages : Set RDO release for master openstack release] ***
2026-02-27 11:46:44.596870 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.032)       0:00:57.866 *******
2026-02-27 11:46:44.596879 | controller | ok: [instance]
2026-02-27 11:46:44.613571 | controller |
2026-02-27 11:46:44.613591 | controller | TASK [build_openstack_packages : Set RDO release for non-master openstack release] ***
2026-02-27 11:46:44.613598 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.020)       0:00:57.886 *******
2026-02-27 11:46:44.613608 | controller | skipping: [instance]
2026-02-27 11:46:44.630571 | controller |
2026-02-27 11:46:44.630603 | controller | TASK [build_openstack_packages : Make sure /usr/share/rhn/RHN-ORG-TRUSTED-SSL-CERT exists (RHEL)] ***
2026-02-27 11:46:44.630613 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.016)       0:00:57.903 *******
2026-02-27 11:46:44.630627 | controller | skipping: [instance]
2026-02-27 11:46:45.144839 | controller |
2026-02-27 11:46:45.144868 | controller | TASK [build_openstack_packages : Override projects.ini settings] ***************
2026-02-27 11:46:45.144877 | controller | Friday 27 February 2026  11:46:44 +0000 (0:00:00.016)       0:00:57.920 *******
2026-02-27 11:46:45.144886 | controller | ok: [instance] => (item={'regexp': 'baseurl=.*', 'line': 'baseurl=https://trunk.rdoproject.org/centos9-master'})
2026-02-27 11:46:48.489068 | controller | ok: [instance] => (item={'regexp': 'distro=.*', 'line': 'distro=rpm-master'})
2026-02-27 11:46:48.489101 | controller | ok: [instance] => (item={'regexp': 'source=.*', 'line': 'source=master'})
2026-02-27 11:46:48.489109 | controller |
2026-02-27 11:46:48.489115 | controller | TASK [build_openstack_packages : Map project name to DLRN project name] ********
2026-02-27 11:46:48.489121 | controller | Friday 27 February 2026  11:46:45 +0000 (0:00:00.513)       0:00:58.434 *******
2026-02-27 11:46:48.489130 | controller | ok: [instance]
2026-02-27 11:46:48.678062 | controller |
2026-02-27 11:46:48.678097 | controller | TASK [build_openstack_packages : Create data directory if doesn't exist yet] ***
2026-02-27 11:46:48.678106 | controller | Friday 27 February 2026  11:46:48 +0000 (0:00:03.344)       0:01:01.778 *******
2026-02-27 11:46:48.678116 | controller | changed: [instance]
2026-02-27 11:46:48.855322 | controller |
2026-02-27 11:46:48.855353 | controller | TASK [build_openstack_packages : Check for existing python-neutron-tests-tempest] ***
2026-02-27 11:46:48.855361 | controller | Friday 27 February 2026  11:46:48 +0000 (0:00:00.189)       0:01:01.967 *******
2026-02-27 11:46:48.855372 | controller | ok: [instance]
2026-02-27 11:46:49.397672 | controller |
2026-02-27 11:46:49.397701 | controller | TASK [build_openstack_packages : Sync python-neutron-tests-tempest from local repo] ***
2026-02-27 11:46:49.397709 | controller | Friday 27 February 2026  11:46:48 +0000 (0:00:00.177)       0:01:02.144 *******
2026-02-27 11:46:49.397720 | controller | changed: [instance]
2026-02-27 11:46:49.430595 | controller |
2026-02-27 11:46:49.430614 | controller | TASK [build_openstack_packages : Symlink python-neutron-tests-tempest from Zuul clonned repos for upstream] ***
2026-02-27 11:46:49.430627 | controller | Friday 27 February 2026  11:46:49 +0000 (0:00:00.542)       0:01:02.687 *******
2026-02-27 11:46:49.430637 | controller | skipping: [instance]
2026-02-27 11:46:49.460328 | controller |
2026-02-27 11:46:49.460345 | controller | TASK [build_openstack_packages : Update packages.yml to use zuul repo for python-neutron-tests-tempest] ***
2026-02-27 11:46:49.460352 | controller | Friday 27 February 2026  11:46:49 +0000 (0:00:00.033)       0:01:02.720 *******
2026-02-27 11:46:49.460361 | controller | skipping: [instance]
2026-02-27 11:46:49.656750 | controller |
2026-02-27 11:46:49.656774 | controller | TASK [build_openstack_packages : Find the last commit from the clonned repo] ***
2026-02-27 11:46:49.656782 | controller | Friday 27 February 2026  11:46:49 +0000 (0:00:00.029)       0:01:02.750 *******
2026-02-27 11:46:49.656792 | controller | changed: [instance]
2026-02-27 11:46:49.678621 | controller |
2026-02-27 11:46:49.678651 | controller | TASK [build_openstack_packages : Print the last commit of the git repo] ********
2026-02-27 11:46:49.678659 | controller | Friday 27 February 2026  11:46:49 +0000 (0:00:00.196)       0:01:02.946 *******
2026-02-27 11:46:49.678670 | controller | ok: [instance] =>
2026-02-27 11:46:49.678693 | controller |   _commit.stdout: cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5
2026-02-27 11:46:49.678700 | controller |
2026-02-27 11:46:49.678708 | controller | TASK [build_openstack_packages : Ensure distgit repo is absent, DLRN takes care of cloning based on config] ***
2026-02-27 11:46:49.678801 | controller | Friday 27 February 2026  11:46:49 +0000 (0:00:00.021)       0:01:02.968 *******
2026-02-27 11:46:49.860905 | controller | ok: [instance]
2026-02-27 11:46:50.218191 | controller |
2026-02-27 11:46:50.218221 | controller | TASK [build_openstack_packages : Generate DLRN Script] *************************
2026-02-27 11:46:50.218229 | controller | Friday 27 February 2026  11:46:49 +0000 (0:00:00.181)       0:01:03.150 *******
2026-02-27 11:46:50.218239 | controller | changed: [instance]
2026-02-27 11:46:50.250507 | controller |
2026-02-27 11:46:50.250542 | controller | TASK [build_openstack_packages : Print info about building] ********************
2026-02-27 11:46:50.250552 | controller | Friday 27 February 2026  11:46:50 +0000 (0:00:00.357)       0:01:03.507 *******
2026-02-27 11:46:50.250562 | controller | ok: [instance] =>
2026-02-27 11:46:50.433202 | controller |   msg: Building change for python-neutron-tests-tempest
2026-02-27 11:46:50.433232 | controller |
2026-02-27 11:46:50.433240 | controller | TASK [build_openstack_packages : Ensure logs dir exists] ***********************
2026-02-27 11:46:50.433246 | controller | Friday 27 February 2026  11:46:50 +0000 (0:00:00.032)       0:01:03.540 *******
2026-02-27 11:46:50.433256 | controller | ok: [instance]
2026-02-27 11:50:37.766618 | controller |
2026-02-27 11:50:37.766648 | controller | TASK [build_openstack_packages : Run DLRN] *************************************
2026-02-27 11:50:37.766657 | controller | Friday 27 February 2026  11:46:50 +0000 (0:00:00.182)       0:01:03.722 *******
2026-02-27 11:50:37.766668 | controller | fatal: [instance]: FAILED! => changed=true
2026-02-27 11:50:37.766796 | controller |   cmd: |-
2026-02-27 11:50:37.766807 | controller |     set -o pipefail && /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/logs/run_dlrn.sh 2>&1 | awk '{ print strftime("%Y-%m-%d %H:%M:%S |"), $0; fflush(); }' >> /home/zuul/ci-framework-data/logs/dlrn.log
2026-02-27 11:50:37.766814 | controller |   delta: '0:03:47.158168'
2026-02-27 11:50:37.766820 | controller |   end: '2026-02-27 11:50:37.742874'
2026-02-27 11:50:37.766825 | controller |   msg: non-zero return code
2026-02-27 11:50:37.766831 | controller |   rc: 1
2026-02-27 11:50:37.766836 | controller |   start: '2026-02-27 11:46:50.584706'
2026-02-27 11:50:37.766841 | controller |   stderr: ''
2026-02-27 11:50:37.766847 | controller |   stderr_lines: <omitted>
2026-02-27 11:50:37.766852 | controller |   stdout: ''
2026-02-27 11:50:37.766860 | controller |   stdout_lines: <omitted>
2026-02-27 11:50:37.771718 | controller |
2026-02-27 11:50:37.960112 | controller | TASK [build_openstack_packages : Copy DLRN artifacts] **************************
2026-02-27 11:50:37.960140 | controller | Friday 27 February 2026  11:50:37 +0000 (0:03:47.338)       0:04:51.061 *******
2026-02-27 11:50:37.960152 | controller | changed: [instance]
2026-02-27 11:50:37.975844 | controller |
2026-02-27 11:50:37.975865 | controller | TASK [build_openstack_packages : Fail the execution] ***************************
2026-02-27 11:50:37.975873 | controller | Friday 27 February 2026  11:50:37 +0000 (0:00:00.188)       0:04:51.249 *******
2026-02-27 11:50:37.975890 | controller | fatal: [instance]: FAILED! => changed=false
2026-02-27 11:50:37.980333 | controller |   msg: DLRN run failed
2026-02-27 11:50:37.980353 | controller |
2026-02-27 11:50:38.033507 | controller | PLAY RECAP *********************************************************************
2026-02-27 11:50:38.033559 | controller | instance                   : ok=54   changed=18   unreachable=0    failed=1    skipped=11   rescued=1    ignored=0
2026-02-27 11:50:38.033567 | controller |
2026-02-27 11:50:38.033574 | controller | Friday 27 February 2026  11:50:37 +0000 (0:00:00.018)       0:04:51.268 *******
2026-02-27 11:50:38.033579 | controller | ===============================================================================
2026-02-27 11:50:38.033585 | controller | build_openstack_packages : Run DLRN ----------------------------------- 227.34s
2026-02-27 11:50:38.033590 | controller | build_openstack_packages : Install Mock from DLRN repos ---------------- 26.55s
2026-02-27 11:50:38.033596 | controller | build_openstack_packages : Install DLRN and rdopkg from pip ------------ 14.62s
2026-02-27 11:50:38.033605 | controller | build_openstack_packages : Create dlrn-venv ----------------------------- 3.83s
2026-02-27 11:50:38.033611 | controller | build_openstack_packages : Map project name to DLRN project name -------- 3.34s
2026-02-27 11:50:38.033617 | controller | build_openstack_packages : Fetch local rdoinfo copy --------------------- 2.71s
2026-02-27 11:50:38.033622 | controller | build_openstack_packages : Check loop devices stat ---------------------- 1.87s
2026-02-27 11:50:38.033627 | controller | build_openstack_packages : Ensure DLRN package dependencies ------------- 1.46s
2026-02-27 11:50:38.033632 | controller | Clone neutron-tempest-plugin -------------------------------------------- 1.27s
2026-02-27 11:50:38.033638 | controller | Gathering Facts --------------------------------------------------------- 0.77s
2026-02-27 11:50:38.033643 | controller | build_openstack_packages : Drop in the templated version of projects.ini --- 0.58s
2026-02-27 11:50:38.033649 | controller | build_openstack_packages : Sync python-neutron-tests-tempest from local repo --- 0.54s
2026-02-27 11:50:38.033654 | controller | build_openstack_packages : Override projects.ini settings --------------- 0.51s
2026-02-27 11:50:38.033659 | controller | build_openstack_packages : Add user to mock group ----------------------- 0.37s
2026-02-27 11:50:38.033664 | controller | build_openstack_packages : Generate DLRN Script ------------------------- 0.36s
2026-02-27 11:50:38.033670 | controller | build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir --- 0.35s
2026-02-27 11:50:38.033675 | controller | build_openstack_packages : Append repo_content ending with """ in mock local config at last --- 0.30s
2026-02-27 11:50:38.033681 | controller | build_openstack_packages : Create mock group ---------------------------- 0.30s
2026-02-27 11:50:38.033686 | controller | build_openstack_packages : Ensure DLRN dir is present ------------------- 0.28s
2026-02-27 11:50:38.033704 | controller | build_openstack_packages : Remove data files from previous runs --------- 0.28s
2026-02-27 11:50:38.033717 | controller | CRITICAL Ansible return code was 2, command was: ['ansible-playbook', '--inventory', '/home/zuul/.cache/molecule/build_openstack_packages/default/inventory', '--skip-tags', 'molecule-notest,notest', '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/molecule/default/converge.yml']
2026-02-27 11:50:38.034134 | controller | WARNING  An error occurred during the test sequence action: 'converge'. Cleaning up.
2026-02-27 11:50:38.042769 | controller | INFO     Running default > cleanup
2026-02-27 11:50:38.043207 | controller | WARNING  Skipping, cleanup playbook not configured.
2026-02-27 11:50:38.050825 | controller | INFO     Running default > destroy
2026-02-27 11:50:38.051167 | controller | WARNING  Skipping, instances are delegated.
2026-02-27 11:50:38.051490 | controller | INFO     Pruning extra files from scenario ephemeral directory
2026-02-27 11:50:38.052980 | controller | INFO     Writing /tmp/report.html report.
2026-02-27 11:50:38.136503 | controller | ERROR
2026-02-27 11:50:38.136665 | controller | {
2026-02-27 11:50:38.136700 | controller |   "delta": "0:06:22.628140",
2026-02-27 11:50:38.136723 | controller |   "end": "2026-02-27 11:50:38.092472",
2026-02-27 11:50:38.136747 | controller |   "msg": "non-zero return code",
2026-02-27 11:50:38.136767 | controller |   "rc": 1,
2026-02-27 11:50:38.136784 | controller |   "start": "2026-02-27 11:44:15.464332"
2026-02-27 11:50:38.136798 | controller | }
failure
2026-02-27 11:50:38.186281 | 
2026-02-27 11:50:38.186404 | PLAY RECAP
2026-02-27 11:50:38.186452 | controller | ok: 3 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0
2026-02-27 11:50:38.186480 | 
2026-02-27 11:50:38.255335 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-02-27 11:50:38.256164 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-02-27 11:50:38.777661 | 
2026-02-27 11:50:38.777763 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-02-27 11:50:38.797772 | 
2026-02-27 11:50:38.797848 | TASK [Filter out host if needed]
2026-02-27 11:50:38.806263 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-02-27 11:50:38.810738 | 
2026-02-27 11:50:38.810806 | TASK [Ensure file is present]
2026-02-27 11:50:39.102172 | controller | ok
2026-02-27 11:50:39.108961 | 
2026-02-27 11:50:39.109034 | TASK [Manage molecule report file]
2026-02-27 11:50:39.634279 | controller | changed
2026-02-27 11:50:39.639542 | 
2026-02-27 11:50:39.639623 | TASK [Check if we get ci-framework-data basedir]
2026-02-27 11:50:39.820375 | controller | ok
2026-02-27 11:50:39.825425 | 
2026-02-27 11:50:39.825490 | TASK [Create ci-framework-data log directory for zuul]
2026-02-27 11:50:40.127740 | controller | changed
2026-02-27 11:50:40.132863 | 
2026-02-27 11:50:40.132929 | TASK [Copy ci-framework interesting files]
2026-02-27 11:50:40.324835 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-02-27 11:50:40.658618 | controller | changed
2026-02-27 11:50:40.663910 | 
2026-02-27 11:50:40.663979 | TASK [Get SELinux listing]
2026-02-27 11:50:41.188689 | controller | changed
2026-02-27 11:50:41.194494 | 
2026-02-27 11:50:41.194567 | TASK [Generate log index]
2026-02-27 11:50:41.790969 | controller | changed
2026-02-27 11:50:41.795723 | 
2026-02-27 11:50:41.795786 | TASK [Get some env related data]
2026-02-27 11:50:42.323374 | controller | /home/zuul/.local/bin/ansible
2026-02-27 11:50:43.319541 | controller | changed
2026-02-27 11:50:43.324810 | 
2026-02-27 11:50:43.324872 | TASK [Generate list of logs to collect in home directory]
2026-02-27 11:50:43.606488 | controller | ok: All paths examined
2026-02-27 11:50:43.611434 | 
2026-02-27 11:50:43.611498 | LOOP [Copy logs from home directory]
2026-02-27 11:50:43.910880 | controller | changed:
2026-02-27 11:50:43.910987 | controller | {
2026-02-27 11:50:43.911014 | controller |   "atime": 1772192636.7767227,
2026-02-27 11:50:43.911034 | controller |   "ctime": 1772192653.4178488,
2026-02-27 11:50:43.911051 | controller |   "dev": 64513,
2026-02-27 11:50:43.911067 | controller |   "gid": 1000,
2026-02-27 11:50:43.911083 | controller |   "gr_name": "zuul",
2026-02-27 11:50:43.911100 | controller |   "inode": 1984545,
2026-02-27 11:50:43.911115 | controller |   "isblk": false,
2026-02-27 11:50:43.911130 | controller |   "ischr": false,
2026-02-27 11:50:43.911145 | controller |   "isdir": false,
2026-02-27 11:50:43.911159 | controller |   "isfifo": false,
2026-02-27 11:50:43.911174 | controller |   "isgid": false,
2026-02-27 11:50:43.911188 | controller |   "islnk": false,
2026-02-27 11:50:43.911203 | controller |   "isreg": true,
2026-02-27 11:50:43.911217 | controller |   "issock": false,
2026-02-27 11:50:43.911230 | controller |   "isuid": false,
2026-02-27 11:50:43.911243 | controller |   "mode": "0644",
2026-02-27 11:50:43.911256 | controller |   "mtime": 1772192653.4178488,
2026-02-27 11:50:43.911269 | controller |   "nlink": 1,
2026-02-27 11:50:43.911283 | controller |   "path": "/home/zuul/ansible.log",
2026-02-27 11:50:43.911320 | controller |   "pw_name": "zuul",
2026-02-27 11:50:43.911341 | controller |   "rgrp": true,
2026-02-27 11:50:43.911357 | controller |   "roth": true,
2026-02-27 11:50:43.911372 | controller |   "rusr": true,
2026-02-27 11:50:43.911387 | controller |   "size": 6749,
2026-02-27 11:50:43.911401 | controller |   "uid": 1000,
2026-02-27 11:50:43.911415 | controller |   "wgrp": false,
2026-02-27 11:50:43.911428 | controller |   "woth": false,
2026-02-27 11:50:43.911445 | controller |   "wusr": true,
2026-02-27 11:50:43.911460 | controller |   "xgrp": false,
2026-02-27 11:50:43.911474 | controller |   "xoth": false,
2026-02-27 11:50:43.911489 | controller |   "xusr": false
2026-02-27 11:50:43.911504 | controller | }
2026-02-27 11:50:43.924400 | 
2026-02-27 11:50:43.924462 | TASK [Copy crio stats log file]
2026-02-27 11:50:43.938107 | controller | skipping: Conditional result was False
2026-02-27 11:50:43.943344 | 
2026-02-27 11:50:43.943407 | TASK [Get SELinux related data]
2026-02-27 11:50:44.142340 | controller | <no matches>
2026-02-27 11:50:44.467509 | controller | ERROR
2026-02-27 11:50:44.467720 | controller | {
2026-02-27 11:50:44.467770 | controller |   "delta": "0:00:00.008655",
2026-02-27 11:50:44.467796 | controller |   "end": "2026-02-27 11:50:44.143440",
2026-02-27 11:50:44.467816 | controller |   "msg": "non-zero return code",
2026-02-27 11:50:44.467835 | controller |   "rc": 1,
2026-02-27 11:50:44.467852 | controller |   "start": "2026-02-27 11:50:44.134785"
2026-02-27 11:50:44.467870 | controller | }
2026-02-27 11:50:44.467894 | controller | ERROR: Ignoring Errors
2026-02-27 11:50:44.473394 | 
2026-02-27 11:50:44.473463 | TASK [Create system configuration directory]
2026-02-27 11:50:44.654737 | controller | changed
2026-02-27 11:50:44.659937 | 
2026-02-27 11:50:44.660022 | TASK [Get some of the system configurations]
2026-02-27 11:50:45.184140 | controller | changed
2026-02-27 11:50:45.189887 | 
2026-02-27 11:50:45.189970 | TASK [Copy generated documentation if available]
2026-02-27 11:50:45.203714 | controller | skipping: Conditional result was False
2026-02-27 11:50:45.209550 | 
2026-02-27 11:50:45.209647 | TASK [Copy generated AsciiDoc documentation if available]
2026-02-27 11:50:45.223417 | controller | skipping: Conditional result was False
2026-02-27 11:50:45.229564 | 
2026-02-27 11:50:45.229660 | TASK [Compress logs bigger than 2MB]
2026-02-27 11:50:45.755796 | controller | changed
2026-02-27 11:50:45.761370 | 
2026-02-27 11:50:45.761439 | TASK [Copy files from workspace on node]
2026-02-27 11:50:45.779144 | controller | ok
2026-02-27 11:50:45.800798 | 
2026-02-27 11:50:45.800863 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-27 11:50:45.814112 | controller | skipping: Conditional result was False
2026-02-27 11:50:45.819709 | 
2026-02-27 11:50:45.819776 | TASK [fetch-output : Set log path for single node]
2026-02-27 11:50:45.848134 | controller | ok
2026-02-27 11:50:45.854493 | 
2026-02-27 11:50:45.854558 | LOOP [fetch-output : Ensure local output dirs]
2026-02-27 11:50:46.049665 | controller -> localhost | ok: "/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/logs"
2026-02-27 11:50:46.050021 | controller -> localhost | changed: All items complete
2026-02-27 11:50:46.050064 | 
2026-02-27 11:50:46.230539 | controller -> localhost | changed: "/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/artifacts"
2026-02-27 11:50:46.411689 | controller -> localhost | changed: "/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/docs"
2026-02-27 11:50:46.422084 | 
2026-02-27 11:50:46.422189 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-27 11:50:46.986188 | controller | changed:
2026-02-27 11:50:46.986386 | controller | .d..t...... ./
2026-02-27 11:50:46.986421 | controller | >f+++++++++ README.html
2026-02-27 11:50:46.986444 | controller | >f+++++++++ ansible-execution.log
2026-02-27 11:50:46.986465 | controller | >f+++++++++ ansible.log
2026-02-27 11:50:46.986485 | controller | >f+++++++++ dmesg.log
2026-02-27 11:50:46.986504 | controller | >f+++++++++ installed-pkgs.log
2026-02-27 11:50:46.986531 | controller | >f+++++++++ python.log
2026-02-27 11:50:46.986553 | controller | >f+++++++++ registries.conf
2026-02-27 11:50:46.986571 | controller | >f+++++++++ report.html
2026-02-27 11:50:46.986609 | controller | >f+++++++++ selinux-denials.log
2026-02-27 11:50:46.986630 | controller | >f+++++++++ selinux-listing.log
2026-02-27 11:50:46.986650 | controller | cd+++++++++ ci-framework-data/
2026-02-27 11:50:46.986667 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-02-27 11:50:46.986685 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-02-27 11:50:46.986703 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-02-27 11:50:46.986721 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-02-27 11:50:46.986739 | controller | cd+++++++++ ci-framework-data/logs/
2026-02-27 11:50:46.986757 | controller | >f+++++++++ ci-framework-data/logs/dlrn.log
2026-02-27 11:50:46.986774 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-02-27 11:50:46.986801 | controller | cd+++++++++ ci-framework-data/logs/component_logs/
2026-02-27 11:50:46.986825 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/
2026-02-27 11:50:46.986844 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/cf/
2026-02-27 11:50:46.986863 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/
2026-02-27 11:50:46.986880 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/
2026-02-27 11:50:46.986898 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/build.log
2026-02-27 11:50:46.986915 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/commit.yaml
2026-02-27 11:50:46.986932 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/hw_info.log
2026-02-27 11:50:46.986948 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/installed_pkgs.log
2026-02-27 11:50:46.986964 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/mock.log
2026-02-27 11:50:46.986981 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/notes.log
2026-02-27 11:50:46.987004 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/python-neutron-tests-tempest-3.0.1-0.20260227114652.cfa5c40.el9.src.rpm
2026-02-27 11:50:46.987023 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/root.log
2026-02-27 11:50:46.987040 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/rpmbuild.log
2026-02-27 11:50:46.987056 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/cf/a5/cfa5c401e1d16dbdd213d2845d14bcc2fe90a1c5_dev/state.log
2026-02-27 11:50:46.987071 | controller | cd+++++++++ registries.conf.d/
2026-02-27 11:50:46.987088 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-02-27 11:50:46.987104 | controller | cd+++++++++ system-config/
2026-02-27 11:50:46.987119 | controller | cd+++++++++ system-config/libvirt/
2026-02-27 11:50:46.987135 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-02-27 11:50:46.987151 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-02-27 11:50:47.353514 | controller | changed: .d..t...... ./
2026-02-27 11:50:47.710073 | controller | changed: .d..t...... ./
2026-02-27 11:50:47.723963 | 
2026-02-27 11:50:47.724043 | TASK [Return artifact to Zuul]
2026-02-27 11:50:47.753169 | controller | ok
2026-02-27 11:50:47.772024 | 
2026-02-27 11:50:47.772082 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-02-27 11:50:47.772180 | 
2026-02-27 11:50:47.772208 | PLAY RECAP
2026-02-27 11:50:47.772244 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-02-27 11:50:47.772264 | 
2026-02-27 11:50:47.853098 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-02-27 11:50:47.853872 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-02-27 11:50:48.363675 | 
2026-02-27 11:50:48.363777 | PLAY [all]
2026-02-27 11:50:48.382170 | 
2026-02-27 11:50:48.382247 | TASK [include_role : fetch-output]
2026-02-27 11:50:48.410640 | controller | ok
2026-02-27 11:50:48.427143 | 
2026-02-27 11:50:48.427228 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-27 11:50:48.471272 | controller | skipping: Conditional result was False
2026-02-27 11:50:48.476780 | 
2026-02-27 11:50:48.476857 | TASK [fetch-output : Set log path for single node]
2026-02-27 11:50:48.504694 | controller | ok
2026-02-27 11:50:48.509733 | 
2026-02-27 11:50:48.509807 | LOOP [fetch-output : Ensure local output dirs]
2026-02-27 11:50:48.827243 | controller -> localhost | ok: "/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/logs"
2026-02-27 11:50:49.018875 | controller -> localhost | ok: "/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/artifacts"
2026-02-27 11:50:49.202371 | controller -> localhost | ok: "/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/docs"
2026-02-27 11:50:49.218207 | 
2026-02-27 11:50:49.218314 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-27 11:50:49.731711 | controller | ok
2026-02-27 11:50:49.731898 | controller | ok: All items complete
2026-02-27 11:50:49.731931 | 
2026-02-27 11:50:50.101230 | controller | ok
2026-02-27 11:50:50.463386 | controller | ok
2026-02-27 11:50:50.478573 | 
2026-02-27 11:50:50.478678 | TASK [include_role : fetch-output-openshift]
2026-02-27 11:50:50.492476 | controller | skipping: Conditional result was False
2026-02-27 11:50:50.497890 | 
2026-02-27 11:50:50.497965 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-27 11:50:50.829856 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.005864
2026-02-27 11:50:51.019671 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006528
2026-02-27 11:50:51.051288 | 
2026-02-27 11:50:51.051378 | PLAY [all]
2026-02-27 11:50:51.064640 | 
2026-02-27 11:50:51.064711 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-27 11:50:51.459565 | controller | changed
2026-02-27 11:50:51.481050 | 
2026-02-27 11:50:51.481121 | PLAY RECAP
2026-02-27 11:50:51.481169 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-02-27 11:50:51.481197 | 
2026-02-27 11:50:51.548885 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-02-27 11:50:51.549642 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-02-27 11:50:52.098591 | 
2026-02-27 11:50:52.098692 | PLAY [localhost]
2026-02-27 11:50:52.116215 | 
2026-02-27 11:50:52.116333 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-27 11:50:52.417237 | localhost | changed
2026-02-27 11:50:52.421752 | 
2026-02-27 11:50:52.421841 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-27 11:50:52.439676 | localhost | ok
2026-02-27 11:50:52.447538 | 
2026-02-27 11:50:52.447626 | TASK [add-fileserver : Create SSH private key tempfile]
2026-02-27 11:50:52.739211 | localhost | changed
2026-02-27 11:50:52.745121 | 
2026-02-27 11:50:52.745197 | TASK [add-fileserver : Create SSH private key from secret]
2026-02-27 11:50:53.279365 | localhost | changed
2026-02-27 11:50:53.284252 | 
2026-02-27 11:50:53.284362 | TASK [add-fileserver : Add fileserver ssh key]
2026-02-27 11:50:53.615941 | localhost | Identity added: /var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/tmp/ansible.4cmd5_4y (/var/lib/zuul/builds/c1d6488c9ea34b9f82e1f5cd4ad5a9e1/work/tmp/ansible.4cmd5_4y)
2026-02-27 11:50:53.616124 | localhost | ok: Runtime: 0:00:00.006152
2026-02-27 11:50:53.620428 | 
2026-02-27 11:50:53.620506 | TASK [add-fileserver : Remove SSH private key from disk]
2026-02-27 11:50:53.830785 | localhost | ok: Runtime: 0:00:00.004164
2026-02-27 11:50:53.835246 | 
2026-02-27 11:50:53.835343 | TASK [add-fileserver : Add fileserver to inventory]
2026-02-27 11:50:53.882809 | localhost | changed
2026-02-27 11:50:53.887650 | 
2026-02-27 11:50:53.887730 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-02-27 11:50:54.198781 | localhost | changed
2026-02-27 11:50:54.217647 | 
2026-02-27 11:50:54.217722 | PLAY [localhost]
2026-02-27 11:50:54.228783 | 
2026-02-27 11:50:54.228851 | TASK [Generate bulk log download script]
2026-02-27 11:50:54.247053 | localhost | ok
2026-02-27 11:50:54.258245 | 
2026-02-27 11:50:54.258359 | TASK [local-log-download : Check API endpoint is defined]
2026-02-27 11:50:54.285835 | localhost | ok: All assertions passed
2026-02-27 11:50:54.290286 | 
2026-02-27 11:50:54.290387 | TASK [local-log-download : Create download script]
2026-02-27 11:50:54.637869 | localhost -> localhost | changed
2026-02-27 11:50:54.646184 | 
2026-02-27 11:50:54.646257 | TASK [Register quick-download link]
2026-02-27 11:50:54.663014 | localhost | ok
2026-02-27 11:50:54.697141 | 
2026-02-27 11:50:54.697224 | PLAY [logserver.rdoproject.org]
2026-02-27 11:50:54.706540 | 
2026-02-27 11:50:54.706620 | TASK [Set zuul-log-path fact]
2026-02-27 11:50:54.722425 | logserver.rdoproject.org | ok
2026-02-27 11:50:54.731009 | 
2026-02-27 11:50:54.731078 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 11:50:54.756845 | logserver.rdoproject.org | ok
2026-02-27 11:50:54.762206 | 
2026-02-27 11:50:54.762274 | TASK [upload-logs : Create log directories]
2026-02-27 11:50:56.459185 | logserver.rdoproject.org | changed
2026-02-27 11:50:56.462831 | 
2026-02-27 11:50:56.462913 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-27 11:50:56.679477 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004397
2026-02-27 11:50:56.683990 | 
2026-02-27 11:50:56.684059 | TASK [upload-logs : Upload logs to log server]
2026-02-27 11:50:58.297809 | logserver.rdoproject.org | Output suppressed because no_log was given
2026-02-27 11:50:58.300600 | 
2026-02-27 11:50:58.300667 | LOOP [upload-logs : Compress console log and json output]
2026-02-27 11:50:58.339437 | logserver.rdoproject.org | skipping: Conditional result was False
2026-02-27 11:50:58.348288 | logserver.rdoproject.org | skipping: Conditional result was False
2026-02-27 11:50:58.358516 | 
2026-02-27 11:50:58.358599 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-27 11:50:58.393060 | logserver.rdoproject.org | skipping: Conditional result was False
2026-02-27 11:50:58.393260 | 
2026-02-27 11:50:58.396740 | logserver.rdoproject.org | skipping: Conditional result was False
2026-02-27 11:50:58.405380 | 
2026-02-27 11:50:58.405454 | LOOP [upload-logs : Upload console log and json output]