2026-01-29 19:05:35.804991 | Job console starting...
2026-01-29 19:05:36.002719 | Updating repositories
2026-01-29 19:05:36.724158 | Preparing job workspace
2026-01-29 19:05:43.629740 | Running Ansible setup...
2026-01-29 19:05:46.381704 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-29 19:05:46.864950 | 
2026-01-29 19:05:46.865104 | PLAY [localhost]
2026-01-29 19:05:46.873128 | 
2026-01-29 19:05:46.873199 | TASK [Gathering Facts]
2026-01-29 19:05:47.647647 | localhost | ok
2026-01-29 19:05:47.659837 | 
2026-01-29 19:05:47.659918 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-01-29 19:05:47.957058 | localhost -> localhost | changed
2026-01-29 19:05:47.962236 | 
2026-01-29 19:05:47.962339 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-01-29 19:05:48.612729 | localhost -> localhost | changed
2026-01-29 19:05:48.620647 | 
2026-01-29 19:05:48.620717 | TASK [Setup log path fact]
2026-01-29 19:05:48.637567 | localhost | ok
2026-01-29 19:05:48.648547 | 
2026-01-29 19:05:48.648613 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-29 19:05:48.664980 | localhost | ok
2026-01-29 19:05:48.671980 | 
2026-01-29 19:05:48.672044 | TASK [emit-job-header : Print job information]
2026-01-29 19:05:48.698400 | # Job Information
2026-01-29 19:05:48.698510 | Ansible Version: 2.15.12
2026-01-29 19:05:48.698539 | Job: cifmw-molecule-build_openstack_packages
2026-01-29 19:05:48.698561 | Pipeline: github-check
2026-01-29 19:05:48.698581 | Executor: ibm-bm3-ze.softwarefactory-project.io
2026-01-29 19:05:48.698600 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3640
2026-01-29 19:05:48.698619 | Log URL (when completed): https://logserver.rdoproject.org/2a5/rdoproject.org/2a559772576343628cb7ae79bbcf0d6c/
2026-01-29 19:05:48.698637 | Event ID: 5d5074d0-fd45-11f0-8570-5985e744880a
2026-01-29 19:05:48.702300 | 
2026-01-29 19:05:48.702375 | LOOP [emit-job-header : Print node information]
2026-01-29 19:05:48.783296 | localhost | ok:
2026-01-29 19:05:48.783456 | localhost | # Node Information
2026-01-29 19:05:48.783487 | localhost | Inventory Hostname: controller
2026-01-29 19:05:48.783511 | localhost | Hostname: np0005601430
2026-01-29 19:05:48.783532 | localhost | Username: zuul
2026-01-29 19:05:48.783553 | localhost | Distro: CentOS 9
2026-01-29 19:05:48.783572 | localhost | Provider: ibm-bm3-nodepool
2026-01-29 19:05:48.783590 | localhost | Region: regionOne
2026-01-29 19:05:48.783610 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2026-01-29 19:05:48.783628 | localhost | Product Name: OpenStack Compute
2026-01-29 19:05:48.783646 | localhost | Interface IP: 192.168.25.170
2026-01-29 19:05:48.803671 | 
2026-01-29 19:05:48.803738 | PLAY [all]
2026-01-29 19:05:48.809871 | 
2026-01-29 19:05:48.809958 | TASK [Gather network facts]
2026-01-29 19:05:49.142882 | controller | ok
2026-01-29 19:05:49.155885 | 
2026-01-29 19:05:49.155945 | TASK [include_role : start-zuul-console]
2026-01-29 19:05:49.173302 | controller | ok
2026-01-29 19:05:49.184514 | 
2026-01-29 19:05:49.184576 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-01-29 19:05:49.465055 | controller | ok
2026-01-29 19:05:49.472940 | 
2026-01-29 19:05:49.473001 | TASK [include_role : add-build-sshkey]
2026-01-29 19:05:49.490059 | controller | ok
2026-01-29 19:05:49.501667 | 
2026-01-29 19:05:49.501729 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-01-29 19:05:49.687039 | controller -> localhost | ok
2026-01-29 19:05:49.692398 | 
2026-01-29 19:05:49.692468 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-01-29 19:05:49.710011 | controller | ok
2026-01-29 19:05:49.722820 | controller | included: /var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-01-29 19:05:49.728140 | 
2026-01-29 19:05:49.728203 | TASK [add-build-sshkey : Create Temp SSH key]
2026-01-29 19:05:50.197120 | controller -> localhost | Generating public/private rsa key pair.
2026-01-29 19:05:50.197314 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/2a559772576343628cb7ae79bbcf0d6c_id_rsa.
2026-01-29 19:05:50.197355 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/2a559772576343628cb7ae79bbcf0d6c_id_rsa.pub.
2026-01-29 19:05:50.197381 | controller -> localhost | The key fingerprint is:
2026-01-29 19:05:50.197402 | controller -> localhost | SHA256:7MnMkkeh/KF3Q3VGXLLnVXyCKf+fHersyymQ/8hYZBo zuul-build-sshkey
2026-01-29 19:05:50.197422 | controller -> localhost | The key's randomart image is:
2026-01-29 19:05:50.197442 | controller -> localhost | +---[RSA 3072]----+
2026-01-29 19:05:50.197462 | controller -> localhost | |             +ooo|
2026-01-29 19:05:50.197482 | controller -> localhost | |          . o.oo+|
2026-01-29 19:05:50.197501 | controller -> localhost | |        .  o. +.+|
2026-01-29 19:05:50.197520 | controller -> localhost | |     . o . ..o o.|
2026-01-29 19:05:50.197539 | controller -> localhost | |      o SEoo .  .|
2026-01-29 19:05:50.197558 | controller -> localhost | |       X *=   .. |
2026-01-29 19:05:50.197577 | controller -> localhost | |      + X.=.  ..+|
2026-01-29 19:05:50.197597 | controller -> localhost | |       + .+++...o|
2026-01-29 19:05:50.197615 | controller -> localhost | |         . o=O.  |
2026-01-29 19:05:50.197633 | controller -> localhost | +----[SHA256]-----+
2026-01-29 19:05:50.197675 | controller -> localhost | ok: Runtime: 0:00:00.153878
2026-01-29 19:05:50.203177 | 
2026-01-29 19:05:50.203243 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-01-29 19:05:50.220882 | controller | ok
2026-01-29 19:05:50.229782 | controller | included: /var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-01-29 19:05:50.237110 | 
2026-01-29 19:05:50.237175 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-01-29 19:05:50.250387 | controller | skipping: Conditional result was False
2026-01-29 19:05:50.255384 | 
2026-01-29 19:05:50.255449 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-01-29 19:05:50.597494 | controller | changed
2026-01-29 19:05:50.602899 | 
2026-01-29 19:05:50.602957 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-01-29 19:05:50.782848 | controller | ok
2026-01-29 19:05:50.787414 | 
2026-01-29 19:05:50.787476 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-01-29 19:05:51.311888 | controller | changed
2026-01-29 19:05:51.316394 | 
2026-01-29 19:05:51.316457 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-01-29 19:05:51.881796 | controller | changed
2026-01-29 19:05:51.886385 | 
2026-01-29 19:05:51.886445 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-01-29 19:05:51.899378 | controller | skipping: Conditional result was False
2026-01-29 19:05:51.904279 | 
2026-01-29 19:05:51.904354 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-01-29 19:05:52.191914 | controller -> localhost | changed
2026-01-29 19:05:52.200676 | 
2026-01-29 19:05:52.200746 | TASK [add-build-sshkey : Add back temp key]
2026-01-29 19:05:52.416239 | controller -> localhost | Identity added: /var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/2a559772576343628cb7ae79bbcf0d6c_id_rsa (zuul-build-sshkey)
2026-01-29 19:05:52.416411 | controller -> localhost | ok: Runtime: 0:00:00.006312
2026-01-29 19:05:52.421120 | 
2026-01-29 19:05:52.421179 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-01-29 19:05:52.691801 | controller | ok
2026-01-29 19:05:52.696071 | 
2026-01-29 19:05:52.696134 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-01-29 19:05:52.719139 | controller | skipping: Conditional result was False
2026-01-29 19:05:52.727945 | 
2026-01-29 19:05:52.728013 | TASK [include_role : validate-host]
2026-01-29 19:05:52.744456 | controller | ok
2026-01-29 19:05:52.762515 | 
2026-01-29 19:05:52.762581 | TASK [validate-host : Define zuul_info_dir fact]
2026-01-29 19:05:52.779469 | controller | ok
2026-01-29 19:05:52.783719 | 
2026-01-29 19:05:52.783783 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-01-29 19:05:52.968178 | controller -> localhost | ok
2026-01-29 19:05:52.973497 | 
2026-01-29 19:05:52.973564 | TASK [validate-host : Collect information about the host]
2026-01-29 19:05:53.559288 | controller | ok
2026-01-29 19:05:53.566527 | 
2026-01-29 19:05:53.566587 | TASK [validate-host : Sanitize hostname]
2026-01-29 19:05:53.624181 | controller | ok
2026-01-29 19:05:53.628928 | 
2026-01-29 19:05:53.628993 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-01-29 19:05:53.997452 | controller -> localhost | changed
2026-01-29 19:05:54.019924 | 
2026-01-29 19:05:54.020005 | TASK [validate-host : Collect information about zuul worker]
2026-01-29 19:05:54.311081 | controller | ok
2026-01-29 19:05:54.315176 | 
2026-01-29 19:05:54.315241 | TASK [validate-host : Write out all zuul information for each host]
2026-01-29 19:05:54.652633 | controller -> localhost | changed
2026-01-29 19:05:54.661381 | 
2026-01-29 19:05:54.661447 | TASK [include_role : prepare-workspace-openshift]
2026-01-29 19:05:54.674442 | controller | skipping: Conditional result was False
2026-01-29 19:05:54.679069 | 
2026-01-29 19:05:54.679131 | TASK [include_role : remove-zuul-sshkey]
2026-01-29 19:05:54.691592 | controller | skipping: Conditional result was False
2026-01-29 19:05:54.696656 | 
2026-01-29 19:05:54.696722 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-01-29 19:05:54.879158 | controller | ok: "logs"
2026-01-29 19:05:54.879367 | controller | ok: All items complete
2026-01-29 19:05:54.879402 | 
2026-01-29 19:05:55.027455 | controller | ok: "artifacts"
2026-01-29 19:05:55.173340 | controller | ok: "docs"
2026-01-29 19:05:55.181036 | 
2026-01-29 19:05:55.181165 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-01-29 19:05:55.363944 | controller | changed: "logs"
2026-01-29 19:05:55.508828 | controller | changed: "artifacts"
2026-01-29 19:05:55.656877 | controller | changed: "docs"
2026-01-29 19:05:55.681402 | 
2026-01-29 19:05:55.681480 | PLAY RECAP
2026-01-29 19:05:55.681524 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-01-29 19:05:55.681553 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-29 19:05:55.681572 | 
2026-01-29 19:05:55.753748 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2026-01-29 19:05:55.754540 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-01-29 19:05:56.268239 | 
2026-01-29 19:05:56.268364 | PLAY [all]
2026-01-29 19:05:56.286932 | 
2026-01-29 19:05:56.287006 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-01-29 19:05:56.335638 | controller | ok
2026-01-29 19:05:56.340349 | 
2026-01-29 19:05:56.340429 | TASK [mirror-info-fork : Create /etc/ci]
2026-01-29 19:05:56.633955 | controller | changed
2026-01-29 19:05:56.639186 | 
2026-01-29 19:05:56.639259 | TASK [mirror-info-fork : Install ci_mirror script]
2026-01-29 19:05:57.360650 | controller | changed
2026-01-29 19:05:57.369679 | 
2026-01-29 19:05:57.369752 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2026-01-29 19:05:57.698560 | controller | changed:
2026-01-29 19:05:57.700142 | controller | {
2026-01-29 19:05:57.700193 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2026-01-29 19:05:57.700227 | controller | }
2026-01-29 19:05:57.884424 | controller | changed:
2026-01-29 19:05:57.884478 | controller | {
2026-01-29 19:05:57.884506 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2026-01-29 19:05:57.884527 | controller | }
2026-01-29 19:05:58.070976 | controller | changed:
2026-01-29 19:05:58.071041 | controller | {
2026-01-29 19:05:58.071067 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2026-01-29 19:05:58.071087 | controller | }
2026-01-29 19:05:58.255902 | controller | changed:
2026-01-29 19:05:58.255951 | controller | {
2026-01-29 19:05:58.255976 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2026-01-29 19:05:58.255994 | controller | }
2026-01-29 19:05:58.436413 | controller | changed:
2026-01-29 19:05:58.436466 | controller | {
2026-01-29 19:05:58.436491 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2026-01-29 19:05:58.436509 | controller | }
2026-01-29 19:05:58.617499 | controller | changed:
2026-01-29 19:05:58.617552 | controller | {
2026-01-29 19:05:58.617579 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2026-01-29 19:05:58.617600 | controller | }
2026-01-29 19:05:58.805358 | controller | changed:
2026-01-29 19:05:58.805414 | controller | {
2026-01-29 19:05:58.805440 | 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-01-29 19:05:58.805461 | controller | }
2026-01-29 19:05:58.995844 | controller | changed:
2026-01-29 19:05:58.995929 | controller | {
2026-01-29 19:05:58.995956 | 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-01-29 19:05:58.995978 | controller | }
2026-01-29 19:05:59.181539 | controller | changed:
2026-01-29 19:05:59.181602 | controller | {
2026-01-29 19:05:59.181628 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2026-01-29 19:05:59.181648 | controller | }
2026-01-29 19:05:59.363418 | controller | changed:
2026-01-29 19:05:59.363468 | controller | {
2026-01-29 19:05:59.363494 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2026-01-29 19:05:59.363513 | controller | }
2026-01-29 19:05:59.546248 | controller | changed:
2026-01-29 19:05:59.546327 | controller | {
2026-01-29 19:05:59.546354 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2026-01-29 19:05:59.546373 | controller | }
2026-01-29 19:05:59.746365 | controller | changed:
2026-01-29 19:05:59.746443 | controller | {
2026-01-29 19:05:59.746467 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2026-01-29 19:05:59.746486 | controller | }
2026-01-29 19:05:59.913657 | controller | changed:
2026-01-29 19:05:59.913712 | controller | {
2026-01-29 19:05:59.913737 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2026-01-29 19:05:59.913755 | controller | }
2026-01-29 19:06:00.096965 | controller | changed:
2026-01-29 19:06:00.097015 | controller | {
2026-01-29 19:06:00.097040 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2026-01-29 19:06:00.097058 | controller | }
2026-01-29 19:06:00.284162 | controller | changed:
2026-01-29 19:06:00.284212 | controller | {
2026-01-29 19:06:00.284237 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2026-01-29 19:06:00.284256 | controller | }
2026-01-29 19:06:00.473049 | controller | changed:
2026-01-29 19:06:00.473103 | controller | {
2026-01-29 19:06:00.473128 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2026-01-29 19:06:00.473148 | controller | }
2026-01-29 19:06:00.662118 | controller | changed:
2026-01-29 19:06:00.662168 | controller | {
2026-01-29 19:06:00.662194 | 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-01-29 19:06:00.662214 | controller | }
2026-01-29 19:06:00.845518 | controller | changed:
2026-01-29 19:06:00.845570 | controller | {
2026-01-29 19:06:00.845595 | 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-01-29 19:06:00.845624 | controller | }
2026-01-29 19:06:01.029992 | controller | changed:
2026-01-29 19:06:01.030042 | controller | {
2026-01-29 19:06:01.030067 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2026-01-29 19:06:01.030086 | controller | }
2026-01-29 19:06:01.217718 | controller | changed:
2026-01-29 19:06:01.217769 | controller | {
2026-01-29 19:06:01.217794 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2026-01-29 19:06:01.217814 | controller | }
2026-01-29 19:06:01.402429 | controller | changed:
2026-01-29 19:06:01.402585 | controller | {
2026-01-29 19:06:01.402623 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2026-01-29 19:06:01.402646 | controller | }
2026-01-29 19:06:01.587415 | controller | changed:
2026-01-29 19:06:01.587466 | controller | {
2026-01-29 19:06:01.587491 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2026-01-29 19:06:01.587510 | controller | }
2026-01-29 19:06:01.771134 | controller | changed:
2026-01-29 19:06:01.771181 | controller | {
2026-01-29 19:06:01.771205 | 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-01-29 19:06:01.771222 | controller | }
2026-01-29 19:06:01.955445 | controller | changed:
2026-01-29 19:06:01.955496 | controller | {
2026-01-29 19:06:01.955521 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2026-01-29 19:06:01.955539 | controller | }
2026-01-29 19:06:02.143790 | controller | changed:
2026-01-29 19:06:02.143871 | controller | {
2026-01-29 19:06:02.143895 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2026-01-29 19:06:02.143913 | controller | }
2026-01-29 19:06:02.333234 | controller | changed:
2026-01-29 19:06:02.333347 | controller | {
2026-01-29 19:06:02.333380 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2026-01-29 19:06:02.333401 | controller | }
2026-01-29 19:06:02.355327 | 
2026-01-29 19:06:02.355425 | TASK [Set timezone to UTC]
2026-01-29 19:06:02.719346 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2026-01-29 19:06:02.724126 | 
2026-01-29 19:06:02.724205 | TASK [Create nodepool directory]
2026-01-29 19:06:02.917134 | controller | changed
2026-01-29 19:06:02.922258 | 
2026-01-29 19:06:02.922360 | TASK [Create nodepool sub_nodes file]
2026-01-29 19:06:03.386205 | controller | changed
2026-01-29 19:06:03.390849 | 
2026-01-29 19:06:03.390914 | TASK [Create nodepool sub_nodes_private file]
2026-01-29 19:06:03.865728 | controller | changed
2026-01-29 19:06:03.870414 | 
2026-01-29 19:06:03.870476 | LOOP [Populate nodepool sub_nodes file]
2026-01-29 19:06:03.898895 | 
2026-01-29 19:06:03.899007 | LOOP [Populate nodepool sub_nodes_private file]
2026-01-29 19:06:03.927131 | 
2026-01-29 19:06:03.927253 | TASK [Create nodepool primary file]
2026-01-29 19:06:03.950431 | controller | skipping: Conditional result was False
2026-01-29 19:06:03.955519 | 
2026-01-29 19:06:03.955596 | TASK [Create nodepool node_private for this node]
2026-01-29 19:06:04.489347 | controller | changed
2026-01-29 19:06:04.494118 | 
2026-01-29 19:06:04.494178 | LOOP [Copy ssh keys to nodepool directory]
2026-01-29 19:06:04.822665 | controller | ok: Item: id_rsa Runtime: 0:00:00.004683
2026-01-29 19:06:04.822977 | 
2026-01-29 19:06:04.983485 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004557
2026-01-29 19:06:04.990283 | 
2026-01-29 19:06:04.990395 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2026-01-29 19:06:05.484088 | controller | changed
2026-01-29 19:06:05.488472 | 
2026-01-29 19:06:05.488530 | TASK [Validate sudoers config after edits]
2026-01-29 19:06:05.685016 | controller | /etc/sudoers: parsed OK
2026-01-29 19:06:05.685067 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2026-01-29 19:06:05.685076 | controller | /etc/sudoers.d/zuul: parsed OK
2026-01-29 19:06:05.685082 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2026-01-29 19:06:06.013234 | controller | ok: Runtime: 0:00:00.004666
2026-01-29 19:06:06.018090 | 
2026-01-29 19:06:06.018151 | TASK [Show the environment passed in to job shell scripts]
2026-01-29 19:06:06.206319 | controller | SHELL=/bin/bash
2026-01-29 19:06:06.206364 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2026-01-29 19:06:06.206373 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2026-01-29 19:06:06.206381 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/40/3640/102e0bfeaf1ffd7bfa156e12409c08e78c3bb190
2026-01-29 19:06:06.206426 | controller | PWD=/home/zuul
2026-01-29 19:06:06.206435 | controller | ZUUL_PIPELINE=github-check
2026-01-29 19:06:06.206440 | controller | LOGNAME=zuul
2026-01-29 19:06:06.206445 | controller | XDG_SESSION_TYPE=tty
2026-01-29 19:06:06.206450 | controller | _=/usr/bin/env
2026-01-29 19:06:06.206455 | controller | MOTD_SHOWN=pam
2026-01-29 19:06:06.206460 | controller | HOME=/home/zuul
2026-01-29 19:06:06.206465 | controller | LANG=en_US.UTF-8
2026-01-29 19:06:06.206470 | controller | SSH_CONNECTION=192.168.25.12 58898 192.168.25.170 22
2026-01-29 19:06:06.206475 | 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-01-29 19:06:06.206484 | controller | ZUUL_CHANGE_IDS=3640,102e0bfeaf1ffd7bfa156e12409c08e78c3bb190
2026-01-29 19:06:06.206489 | controller | WORKSPACE=/home/zuul/workspace
2026-01-29 19:06:06.206494 | controller | XDG_SESSION_CLASS=user
2026-01-29 19:06:06.206499 | controller | SELINUX_ROLE_REQUESTED=
2026-01-29 19:06:06.206504 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2026-01-29 19:06:06.206509 | controller | USER=zuul
2026-01-29 19:06:06.206514 | controller | ZUUL_VOTING=True
2026-01-29 19:06:06.206519 | controller | BUILD_TIMEOUT=1800000
2026-01-29 19:06:06.206524 | controller | SELINUX_USE_CURRENT_RANGE=
2026-01-29 19:06:06.206529 | controller | SHLVL=1
2026-01-29 19:06:06.206534 | controller | ZUUL_PATCHSET=102e0bfeaf1ffd7bfa156e12409c08e78c3bb190
2026-01-29 19:06:06.206539 | controller | XDG_SESSION_ID=1
2026-01-29 19:06:06.206544 | controller | ZUUL_BRANCH=main
2026-01-29 19:06:06.206549 | controller | XDG_RUNTIME_DIR=/run/user/1000
2026-01-29 19:06:06.206554 | controller | SSH_CLIENT=192.168.25.12 58898 22
2026-01-29 19:06:06.206559 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2026-01-29 19:06:06.206564 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2026-01-29 19:06:06.206569 | controller | which_declare=declare -f
2026-01-29 19:06:06.206575 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2026-01-29 19:06:06.206580 | controller | SELINUX_LEVEL_REQUESTED=
2026-01-29 19:06:06.206585 | controller | ZUUL_CHANGE=3640
2026-01-29 19:06:06.206590 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2026-01-29 19:06:06.206595 | controller | ZUUL_UUID=2a559772576343628cb7ae79bbcf0d6c
2026-01-29 19:06:06.206600 | controller | BASH_FUNC_which%%=() {  ( alias;
2026-01-29 19:06:06.206605 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2026-01-29 19:06:06.206610 | controller | }
2026-01-29 19:06:06.542564 | controller | ok: Runtime: 0:00:00.005722
2026-01-29 19:06:06.547419 | 
2026-01-29 19:06:06.547480 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2026-01-29 19:06:06.561026 | controller | skipping: Conditional result was False
2026-01-29 19:06:06.565970 | 
2026-01-29 19:06:06.566031 | TASK [Symlink /home/zuul-worker/workspace]
2026-01-29 19:06:07.087230 | controller | skipping: Conditional result was False
2026-01-29 19:06:07.092505 | 
2026-01-29 19:06:07.092568 | TASK [Ensure legacy workspace directory]
2026-01-29 19:06:07.263325 | controller | changed
2026-01-29 19:06:07.280335 | 
2026-01-29 19:06:07.280385 | PLAY RECAP
2026-01-29 19:06:07.280425 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-01-29 19:06:07.280446 | 
2026-01-29 19:06:07.352140 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2026-01-29 19:06:07.352890 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-01-29 19:06:07.826574 | 
2026-01-29 19:06:07.826668 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2026-01-29 19:06:07.845901 | 
2026-01-29 19:06:07.845973 | TASK [Create zuul-output directory]
2026-01-29 19:06:08.127811 | controller | changed
2026-01-29 19:06:08.132435 | 
2026-01-29 19:06:08.132507 | TASK [Slurp Zuul inventory test]
2026-01-29 19:06:08.388961 | controller -> localhost | ok
2026-01-29 19:06:08.394880 | 
2026-01-29 19:06:08.394952 | TASK [Save zuul inventory]
2026-01-29 19:06:09.061912 | controller | changed
2026-01-29 19:06:09.066721 | 
2026-01-29 19:06:09.066786 | TASK [Save zuul vars without the change_message]
2026-01-29 19:06:09.625829 | controller | changed
2026-01-29 19:06:09.642887 | 
2026-01-29 19:06:09.642949 | PLAY RECAP
2026-01-29 19:06:09.642991 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-01-29 19:06:09.643014 | 
2026-01-29 19:06:09.704001 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2026-01-29 19:06:09.704759 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-01-29 19:06:10.213423 | 
2026-01-29 19:06:10.213525 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2026-01-29 19:06:10.233590 | 
2026-01-29 19:06:10.233661 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2026-01-29 19:06:10.251597 | controller | ok
2026-01-29 19:06:10.267772 | 
2026-01-29 19:06:10.267850 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2026-01-29 19:06:10.291383 | controller | skipping: Conditional result was False
2026-01-29 19:06:10.296679 | 
2026-01-29 19:06:10.296748 | TASK [mirror-info-fork : Create /etc/ci]
2026-01-29 19:06:10.597752 | controller | ok
2026-01-29 19:06:10.603519 | 
2026-01-29 19:06:10.603589 | TASK [mirror-info-fork : Install ci_mirror script]
2026-01-29 19:06:11.170076 | controller | ok
2026-01-29 19:06:11.179857 | 
2026-01-29 19:06:11.179921 | TASK [Prepare workspace]
2026-01-29 19:06:11.197152 | controller | ok
2026-01-29 19:06:11.212320 | 
2026-01-29 19:06:11.212382 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-01-29 19:06:11.482594 | controller | ok
2026-01-29 19:06:11.488250 | 
2026-01-29 19:06:11.488344 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-01-29 19:06:13.831987 | controller | Output suppressed because no_log was given
2026-01-29 19:06:13.840919 | 
2026-01-29 19:06:13.840987 | LOOP [Create zuul-output directory]
2026-01-29 19:06:14.011727 | controller | changed: "/home/zuul/ci-framework-data/logs"
2026-01-29 19:06:14.151218 | controller | ok: "/home/zuul/zuul-output/logs"
2026-01-29 19:06:14.165633 | 
2026-01-29 19:06:14.165715 | TASK [Install required packages]
2026-01-29 19:06:49.090541 | controller | changed
2026-01-29 19:06:49.095214 | 
2026-01-29 19:06:49.095290 | TASK [Install venv]
2026-01-29 19:07:49.916189 | controller | changed
2026-01-29 19:07:49.955449 | 
2026-01-29 19:07:49.955517 | PLAY RECAP
2026-01-29 19:07:49.955555 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-01-29 19:07:49.955577 | 
2026-01-29 19:07:50.011319 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2026-01-29 19:07:50.012054 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-01-29 19:07:50.481575 | 
2026-01-29 19:07:50.481669 | PLAY [Run ci/playbooks/molecule-test.yml]
2026-01-29 19:07:50.500689 | 
2026-01-29 19:07:50.500753 | TASK [Gather required facts]
2026-01-29 19:07:50.944814 | controller | ok
2026-01-29 19:07:50.949924 | 
2026-01-29 19:07:50.949997 | TASK [Load environment var if instructed to]
2026-01-29 19:07:50.973731 | controller | skipping: Conditional result was False
2026-01-29 19:07:50.978965 | 
2026-01-29 19:07:50.979035 | TASK [Ensure group_vars dir exists]
2026-01-29 19:07:51.270738 | controller | ok
2026-01-29 19:07:51.276379 | 
2026-01-29 19:07:51.276445 | TASK [Print related variables]
2026-01-29 19:07:51.304632 | controller | ok:
2026-01-29 19:07:51.304750 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2026-01-29 19:07:51.304780 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages
2026-01-29 19:07:51.309347 | 
2026-01-29 19:07:51.309411 | TASK [Run molecule]
2026-01-29 19:07:52.156854 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2026-01-29 19:07:52.220424 | controller | INFO     Performing prerun with role_name_check=0...
2026-01-29 19:08:08.448415 | 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-01-29 19:08:08.448862 | 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-01-29 19:08:08.449334 | 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-01-29 19:08:08.449807 | 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-01-29 19:08:08.450284 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+0f8cff88 was found installed in /home/zuul/.cache/ansible-compat/6e70dd/collections/ansible_collections, only the first one will be used, 1.0.0+0f8cff88 (/home/zuul/.ansible/collections/ansible_collections).
2026-01-29 19:08:08.450777 | 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-01-29 19:08:08.451222 | 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-01-29 19:08:08.451697 | 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-01-29 19:08:08.452141 | 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-01-29 19:08:08.452620 | 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-01-29 19:08:08.453078 | 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-01-29 19:08:08.453572 | 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-01-29 19:08:08.454020 | 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-01-29 19:08:08.454512 | 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-01-29 19:08:08.454966 | 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-01-29 19:08:08.464403 | controller | INFO     Running default > prepare
2026-01-29 19:08:09.112855 | controller |
2026-01-29 19:08:09.112946 | controller | PLAY [Prepare] *****************************************************************
2026-01-29 19:08:09.113057 | controller |
2026-01-29 19:08:09.113142 | controller | TASK [Gathering Facts] *********************************************************
2026-01-29 19:08:09.113229 | controller | Thursday 29 January 2026  19:08:09 +0000 (0:00:00.021)       0:00:00.021 ******
2026-01-29 19:08:09.927720 | controller | ok: [instance]
2026-01-29 19:08:09.927821 | controller |
2026-01-29 19:08:09.927942 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2026-01-29 19:08:09.928060 | controller | Thursday 29 January 2026  19:08:09 +0000 (0:00:00.815)       0:00:00.836 ******
2026-01-29 19:08:09.945930 | controller | skipping: [instance]
2026-01-29 19:08:09.946032 | controller |
2026-01-29 19:08:09.946157 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2026-01-29 19:08:09.946277 | controller | Thursday 29 January 2026  19:08:09 +0000 (0:00:00.018)       0:00:00.855 ******
2026-01-29 19:08:09.985428 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2026-01-29 19:08:09.985529 | controller |
2026-01-29 19:08:09.985638 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2026-01-29 19:08:09.985733 | controller | Thursday 29 January 2026  19:08:09 +0000 (0:00:00.039)       0:00:00.894 ******
2026-01-29 19:08:10.248313 | controller | ok: [instance]
2026-01-29 19:08:10.248418 | controller |
2026-01-29 19:08:10.248528 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2026-01-29 19:08:10.248635 | controller | Thursday 29 January 2026  19:08:10 +0000 (0:00:00.262)       0:00:01.157 ******
2026-01-29 19:08:10.558285 | controller | ok: [instance]
2026-01-29 19:08:10.558400 | controller |
2026-01-29 19:08:10.558510 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2026-01-29 19:08:10.558609 | controller | Thursday 29 January 2026  19:08:10 +0000 (0:00:00.308)       0:00:01.465 ******
2026-01-29 19:08:11.232859 | controller | ok: [instance] => (item=ubi-9-appstream)
2026-01-29 19:08:11.232911 | controller | ok: [instance] => (item=ubi-9-baseos)
2026-01-29 19:08:11.233007 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2026-01-29 19:08:11.233084 | controller |
2026-01-29 19:08:11.233171 | controller | TASK [Deploy repo-setup] *******************************************************
2026-01-29 19:08:11.233252 | controller | Thursday 29 January 2026  19:08:11 +0000 (0:00:00.676)       0:00:02.141 ******
2026-01-29 19:08:11.284529 | controller |
2026-01-29 19:08:11.284661 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-01-29 19:08:11.284788 | controller | Thursday 29 January 2026  19:08:11 +0000 (0:00:00.051)       0:00:02.193 ******
2026-01-29 19:08:11.777831 | controller | changed: [instance] => (item=tmp)
2026-01-29 19:08:11.777883 | controller | changed: [instance] => (item=artifacts/repositories)
2026-01-29 19:08:11.777952 | controller | changed: [instance] => (item=venv/repo_setup)
2026-01-29 19:08:11.778035 | controller |
2026-01-29 19:08:11.778126 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-01-29 19:08:11.778207 | controller | Thursday 29 January 2026  19:08:11 +0000 (0:00:00.493)       0:00:02.686 ******
2026-01-29 19:08:12.527329 | controller | ok: [instance]
2026-01-29 19:08:12.527405 | controller |
2026-01-29 19:08:12.527637 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-01-29 19:08:13.574466 | controller | Thursday 29 January 2026  19:08:12 +0000 (0:00:00.749)       0:00:03.436 ******
2026-01-29 19:08:13.574506 | controller | changed: [instance]
2026-01-29 19:08:20.972099 | controller |
2026-01-29 19:08:20.972137 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-01-29 19:08:20.972146 | controller | Thursday 29 January 2026  19:08:13 +0000 (0:00:01.046)       0:00:04.483 ******
2026-01-29 19:08:20.972155 | controller | changed: [instance]
2026-01-29 19:08:21.629572 | controller |
2026-01-29 19:08:21.629604 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-01-29 19:08:21.629613 | controller | Thursday 29 January 2026  19:08:20 +0000 (0:00:07.397)       0:00:11.880 ******
2026-01-29 19:08:21.629622 | controller | changed: [instance]
2026-01-29 19:08:21.648858 | controller |
2026-01-29 19:08:21.648873 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-01-29 19:08:21.648880 | controller | Thursday 29 January 2026  19:08:21 +0000 (0:00:00.657)       0:00:12.538 ******
2026-01-29 19:08:21.648888 | controller | skipping: [instance]
2026-01-29 19:08:23.487661 | controller |
2026-01-29 19:08:23.487692 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-01-29 19:08:23.487700 | controller | Thursday 29 January 2026  19:08:21 +0000 (0:00:00.019)       0:00:12.557 ******
2026-01-29 19:08:23.487710 | controller | changed: [instance]
2026-01-29 19:08:23.520962 | controller |
2026-01-29 19:08:23.521004 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-01-29 19:08:23.521015 | controller | Thursday 29 January 2026  19:08:23 +0000 (0:00:01.838)       0:00:14.396 ******
2026-01-29 19:08:23.521029 | controller | skipping: [instance]
2026-01-29 19:08:23.521062 | controller |
2026-01-29 19:08:23.521341 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-01-29 19:08:23.553192 | controller | Thursday 29 January 2026  19:08:23 +0000 (0:00:00.033)       0:00:14.430 ******
2026-01-29 19:08:23.553217 | controller | skipping: [instance]
2026-01-29 19:08:23.585251 | controller |
2026-01-29 19:08:23.585268 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-01-29 19:08:23.585275 | controller | Thursday 29 January 2026  19:08:23 +0000 (0:00:00.032)       0:00:14.462 ******
2026-01-29 19:08:23.585284 | controller | skipping: [instance]
2026-01-29 19:08:24.116373 | controller |
2026-01-29 19:08:24.116404 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-01-29 19:08:24.116412 | controller | Thursday 29 January 2026  19:08:23 +0000 (0:00:00.031)       0:00:14.494 ******
2026-01-29 19:08:24.116422 | controller | changed: [instance]
2026-01-29 19:08:24.527911 | controller |
2026-01-29 19:08:24.527939 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-01-29 19:08:24.527947 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.531)       0:00:15.025 ******
2026-01-29 19:08:24.527957 | controller | changed: [instance]
2026-01-29 19:08:24.554403 | controller |
2026-01-29 19:08:24.554436 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-01-29 19:08:24.554447 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.411)       0:00:15.436 ******
2026-01-29 19:08:24.554460 | controller | skipping: [instance]
2026-01-29 19:08:24.554502 | controller |
2026-01-29 19:08:24.554514 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-01-29 19:08:24.554656 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.026)       0:00:15.463 ******
2026-01-29 19:08:24.579680 | controller | skipping: [instance]
2026-01-29 19:08:24.604355 | controller |
2026-01-29 19:08:24.604377 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-01-29 19:08:24.604385 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.025)       0:00:15.488 ******
2026-01-29 19:08:24.604395 | controller | skipping: [instance]
2026-01-29 19:08:24.637213 | controller |
2026-01-29 19:08:24.637233 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-01-29 19:08:24.637241 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.024)       0:00:15.513 ******
2026-01-29 19:08:24.637250 | controller | ok: [instance]
2026-01-29 19:08:24.660596 | controller |
2026-01-29 19:08:24.660628 | controller | TASK [repo_setup : Create download directory] **********************************
2026-01-29 19:08:24.660642 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.033)       0:00:15.546 ******
2026-01-29 19:08:24.660658 | controller | skipping: [instance]
2026-01-29 19:08:24.660905 | controller |
2026-01-29 19:08:24.661162 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-01-29 19:08:24.661456 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.023)       0:00:15.569 ******
2026-01-29 19:08:24.684022 | controller | skipping: [instance]
2026-01-29 19:08:24.684283 | controller |
2026-01-29 19:08:24.684600 | controller | TASK [Download the RPM] ********************************************************
2026-01-29 19:08:24.684724 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.023)       0:00:15.593 ******
2026-01-29 19:08:24.707572 | controller | skipping: [instance]
2026-01-29 19:08:24.707752 | controller |
2026-01-29 19:08:24.707879 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-01-29 19:08:24.708000 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.023)       0:00:15.616 ******
2026-01-29 19:08:24.732732 | controller | skipping: [instance]
2026-01-29 19:08:24.732912 | controller |
2026-01-29 19:08:24.733077 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-01-29 19:08:24.733237 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.025)       0:00:15.641 ******
2026-01-29 19:08:24.758898 | controller | skipping: [instance]
2026-01-29 19:08:24.759156 | controller |
2026-01-29 19:08:24.759444 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-01-29 19:08:24.759712 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.026)       0:00:15.668 ******
2026-01-29 19:08:24.795985 | controller | skipping: [instance]
2026-01-29 19:08:24.812406 | controller |
2026-01-29 19:08:24.812445 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args_override | default(cifmw_repo_setup_rhos_release_args) }}] ***
2026-01-29 19:08:24.812457 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.037)       0:00:15.705 ******
2026-01-29 19:08:24.812482 | controller | skipping: [instance]
2026-01-29 19:08:24.812506 | controller |
2026-01-29 19:08:24.812515 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-01-29 19:08:24.812525 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.016)       0:00:15.721 ******
2026-01-29 19:08:24.983723 | controller | ok: [instance]
2026-01-29 19:08:24.983806 | controller |
2026-01-29 19:08:24.983903 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-01-29 19:08:24.983994 | controller | Thursday 29 January 2026  19:08:24 +0000 (0:00:00.171)       0:00:15.893 ******
2026-01-29 19:08:25.177184 | controller | changed: [instance]
2026-01-29 19:08:25.373680 | controller |
2026-01-29 19:08:25.373705 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-01-29 19:08:25.373714 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.193)       0:00:16.086 ******
2026-01-29 19:08:25.373724 | controller | changed: [instance]
2026-01-29 19:08:25.395398 | controller |
2026-01-29 19:08:25.395426 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-01-29 19:08:25.395434 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.196)       0:00:16.282 ******
2026-01-29 19:08:25.395443 | controller | skipping: [instance]
2026-01-29 19:08:25.395465 | controller |
2026-01-29 19:08:25.395482 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-01-29 19:08:25.395596 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.021)       0:00:16.304 ******
2026-01-29 19:08:25.414389 | controller | skipping: [instance]
2026-01-29 19:08:25.414439 | controller |
2026-01-29 19:08:25.414736 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-01-29 19:08:25.433122 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.019)       0:00:16.323 ******
2026-01-29 19:08:25.433140 | controller | skipping: [instance]
2026-01-29 19:08:25.451963 | controller |
2026-01-29 19:08:25.451984 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-01-29 19:08:25.451994 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.018)       0:00:16.342 ******
2026-01-29 19:08:25.452007 | controller | skipping: [instance]
2026-01-29 19:08:25.471362 | controller |
2026-01-29 19:08:25.471383 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-01-29 19:08:25.471392 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.018)       0:00:16.360 ******
2026-01-29 19:08:25.471404 | controller | skipping: [instance]
2026-01-29 19:08:25.471597 | controller |
2026-01-29 19:08:25.471781 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-01-29 19:08:25.471974 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.019)       0:00:16.380 ******
2026-01-29 19:08:25.490590 | controller | skipping: [instance]
2026-01-29 19:08:25.490770 | controller |
2026-01-29 19:08:25.490948 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-01-29 19:08:25.491126 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.019)       0:00:16.399 ******
2026-01-29 19:08:25.505069 | controller | skipping: [instance]
2026-01-29 19:08:25.521380 | controller |
2026-01-29 19:08:25.521410 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-01-29 19:08:25.521421 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.014)       0:00:16.414 ******
2026-01-29 19:08:25.521433 | controller | skipping: [instance]
2026-01-29 19:08:25.521442 | controller |
2026-01-29 19:08:25.521450 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-01-29 19:08:25.521460 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.016)       0:00:16.430 ******
2026-01-29 19:08:25.536818 | controller | skipping: [instance]
2026-01-29 19:08:25.555142 | controller |
2026-01-29 19:08:25.555158 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-01-29 19:08:25.555166 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.015)       0:00:16.445 ******
2026-01-29 19:08:25.555174 | controller | skipping: [instance]
2026-01-29 19:08:25.572379 | controller |
2026-01-29 19:08:25.572404 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2026-01-29 19:08:25.572414 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.018)       0:00:16.464 ******
2026-01-29 19:08:25.572427 | controller | skipping: [instance]
2026-01-29 19:08:25.572459 | controller |
2026-01-29 19:08:25.572499 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2026-01-29 19:08:25.572611 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.017)       0:00:16.481 ******
2026-01-29 19:08:25.589758 | controller | skipping: [instance]
2026-01-29 19:08:25.611360 | controller |
2026-01-29 19:08:25.611399 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2026-01-29 19:08:25.611412 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.017)       0:00:16.498 ******
2026-01-29 19:08:25.611429 | controller | skipping: [instance]
2026-01-29 19:08:25.629754 | controller |
2026-01-29 19:08:25.629776 | controller | TASK [test_deps : Install additional packages] *********************************
2026-01-29 19:08:25.629784 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.021)       0:00:16.520 ******
2026-01-29 19:08:25.629793 | controller | skipping: [instance]
2026-01-29 19:09:06.009366 | controller |
2026-01-29 19:09:06.009397 | controller | TASK [test_deps : Install selinux python libs] *********************************
2026-01-29 19:09:06.009405 | controller | Thursday 29 January 2026  19:08:25 +0000 (0:00:00.018)       0:00:16.538 ******
2026-01-29 19:09:06.009415 | controller | ok: [instance]
2026-01-29 19:09:06.009699 | controller |
2026-01-29 19:09:07.112358 | controller | TASK [test_deps : Install python yaml libs] ************************************
2026-01-29 19:09:07.112385 | controller | Thursday 29 January 2026  19:09:06 +0000 (0:00:40.379)       0:00:56.918 ******
2026-01-29 19:09:07.112396 | controller | ok: [instance]
2026-01-29 19:09:07.112679 | controller |
2026-01-29 19:09:07.134408 | controller | TASK [test_deps : Install extra packages] **************************************
2026-01-29 19:09:07.134442 | controller | Thursday 29 January 2026  19:09:07 +0000 (0:00:01.103)       0:00:58.021 ******
2026-01-29 19:09:07.134455 | controller | skipping: [instance]
2026-01-29 19:09:07.134475 | controller |
2026-01-29 19:09:07.134490 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2026-01-29 19:09:07.134508 | controller | Thursday 29 January 2026  19:09:07 +0000 (0:00:00.022)       0:00:58.043 ******
2026-01-29 19:09:07.630474 | controller | ok: [instance] => (item=tmp)
2026-01-29 19:09:07.630548 | controller | ok: [instance] => (item=artifacts/repositories)
2026-01-29 19:09:07.630645 | controller | ok: [instance] => (item=venv/repo_setup)
2026-01-29 19:09:07.630941 | controller |
2026-01-29 19:09:08.714878 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2026-01-29 19:09:08.714911 | controller | Thursday 29 January 2026  19:09:07 +0000 (0:00:00.496)       0:00:58.539 ******
2026-01-29 19:09:08.714923 | controller | ok: [instance]
2026-01-29 19:09:10.463326 | controller |
2026-01-29 19:09:10.463357 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2026-01-29 19:09:10.463364 | controller | Thursday 29 January 2026  19:09:08 +0000 (0:00:01.084)       0:00:59.623 ******
2026-01-29 19:09:10.463380 | controller | ok: [instance]
2026-01-29 19:09:11.550526 | controller |
2026-01-29 19:09:11.550557 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2026-01-29 19:09:11.550565 | controller | Thursday 29 January 2026  19:09:10 +0000 (0:00:01.748)       0:01:01.372 ******
2026-01-29 19:09:11.550575 | controller | ok: [instance]
2026-01-29 19:09:11.727344 | controller |
2026-01-29 19:09:11.727401 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2026-01-29 19:09:11.727410 | controller | Thursday 29 January 2026  19:09:11 +0000 (0:00:01.087)       0:01:02.459 ******
2026-01-29 19:09:11.727421 | controller | ok: [instance]
2026-01-29 19:09:11.747842 | controller |
2026-01-29 19:09:11.747866 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2026-01-29 19:09:11.747876 | controller | Thursday 29 January 2026  19:09:11 +0000 (0:00:00.176)       0:01:02.636 ******
2026-01-29 19:09:11.747888 | controller | skipping: [instance]
2026-01-29 19:09:12.534367 | controller |
2026-01-29 19:09:12.534397 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2026-01-29 19:09:12.534405 | controller | Thursday 29 January 2026  19:09:11 +0000 (0:00:00.020)       0:01:02.656 ******
2026-01-29 19:09:12.534414 | controller | changed: [instance]
2026-01-29 19:09:12.562033 | controller |
2026-01-29 19:09:12.562057 | controller | TASK [repo_setup : Get component repo] *****************************************
2026-01-29 19:09:12.562065 | controller | Thursday 29 January 2026  19:09:12 +0000 (0:00:00.786)       0:01:03.443 ******
2026-01-29 19:09:12.562076 | controller | skipping: [instance]
2026-01-29 19:09:12.588783 | controller |
2026-01-29 19:09:12.588805 | controller | TASK [repo_setup : Rename component repo] **************************************
2026-01-29 19:09:12.588813 | controller | Thursday 29 January 2026  19:09:12 +0000 (0:00:00.027)       0:01:03.471 ******
2026-01-29 19:09:12.588824 | controller | skipping: [instance]
2026-01-29 19:09:12.616386 | controller |
2026-01-29 19:09:12.616418 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2026-01-29 19:09:12.616426 | controller | Thursday 29 January 2026  19:09:12 +0000 (0:00:00.026)       0:01:03.497 ******
2026-01-29 19:09:12.616437 | controller | skipping: [instance]
2026-01-29 19:09:12.616461 | controller |
2026-01-29 19:09:12.616635 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2026-01-29 19:09:13.123836 | controller | Thursday 29 January 2026  19:09:12 +0000 (0:00:00.027)       0:01:03.525 ******
2026-01-29 19:09:13.123866 | controller | changed: [instance]
2026-01-29 19:09:13.432822 | controller |
2026-01-29 19:09:13.432844 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2026-01-29 19:09:13.432851 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.507)       0:01:04.032 ******
2026-01-29 19:09:13.432860 | controller | changed: [instance]
2026-01-29 19:09:13.450765 | controller |
2026-01-29 19:09:13.450786 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2026-01-29 19:09:13.450793 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.309)       0:01:04.341 ******
2026-01-29 19:09:13.450803 | controller | skipping: [instance]
2026-01-29 19:09:13.467984 | controller |
2026-01-29 19:09:13.468006 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2026-01-29 19:09:13.468014 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.018)       0:01:04.359 ******
2026-01-29 19:09:13.468024 | controller | skipping: [instance]
2026-01-29 19:09:13.485839 | controller |
2026-01-29 19:09:13.485859 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2026-01-29 19:09:13.485866 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.017)       0:01:04.377 ******
2026-01-29 19:09:13.485877 | controller | skipping: [instance]
2026-01-29 19:09:13.511880 | controller |
2026-01-29 19:09:13.511904 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2026-01-29 19:09:13.511911 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.017)       0:01:04.394 ******
2026-01-29 19:09:13.511920 | controller | ok: [instance]
2026-01-29 19:09:13.528026 | controller |
2026-01-29 19:09:13.528044 | controller | TASK [repo_setup : Create download directory] **********************************
2026-01-29 19:09:13.528051 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.026)       0:01:04.421 ******
2026-01-29 19:09:13.528059 | controller | skipping: [instance]
2026-01-29 19:09:13.543465 | controller |
2026-01-29 19:09:13.543487 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2026-01-29 19:09:13.543495 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.016)       0:01:04.437 ******
2026-01-29 19:09:13.543506 | controller | skipping: [instance]
2026-01-29 19:09:13.560348 | controller |
2026-01-29 19:09:13.560368 | controller | TASK [Download the RPM] ********************************************************
2026-01-29 19:09:13.560380 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.015)       0:01:04.452 ******
2026-01-29 19:09:13.560390 | controller | skipping: [instance]
2026-01-29 19:09:13.560481 | controller |
2026-01-29 19:09:13.560488 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2026-01-29 19:09:13.560495 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.016)       0:01:04.469 ******
2026-01-29 19:09:13.576062 | controller | skipping: [instance]
2026-01-29 19:09:13.592360 | controller |
2026-01-29 19:09:13.592381 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2026-01-29 19:09:13.592390 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.015)       0:01:04.485 ******
2026-01-29 19:09:13.592401 | controller | skipping: [instance]
2026-01-29 19:09:13.592552 | controller |
2026-01-29 19:09:13.592572 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2026-01-29 19:09:13.610171 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.016)       0:01:04.501 ******
2026-01-29 19:09:13.610189 | controller | skipping: [instance]
2026-01-29 19:09:13.625791 | controller |
2026-01-29 19:09:13.625809 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args_override | default(cifmw_repo_setup_rhos_release_args) }}] ***
2026-01-29 19:09:13.625816 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.017)       0:01:04.519 ******
2026-01-29 19:09:13.625825 | controller | skipping: [instance]
2026-01-29 19:09:13.807485 | controller |
2026-01-29 19:09:13.807514 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2026-01-29 19:09:13.807521 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.015)       0:01:04.534 ******
2026-01-29 19:09:13.807531 | controller | ok: [instance]
2026-01-29 19:09:13.986834 | controller |
2026-01-29 19:09:13.986860 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2026-01-29 19:09:13.986868 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.181)       0:01:04.716 ******
2026-01-29 19:09:13.986878 | controller | changed: [instance]
2026-01-29 19:09:14.172983 | controller |
2026-01-29 19:09:14.173011 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2026-01-29 19:09:14.173019 | controller | Thursday 29 January 2026  19:09:13 +0000 (0:00:00.179)       0:01:04.895 ******
2026-01-29 19:09:14.173029 | controller | changed: [instance]
2026-01-29 19:09:14.193398 | controller |
2026-01-29 19:09:14.193426 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2026-01-29 19:09:14.193435 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.186)       0:01:05.081 ******
2026-01-29 19:09:14.193446 | controller | skipping: [instance]
2026-01-29 19:09:14.193472 | controller |
2026-01-29 19:09:14.193482 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2026-01-29 19:09:14.193504 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.020)       0:01:05.102 ******
2026-01-29 19:09:14.216708 | controller | skipping: [instance]
2026-01-29 19:09:14.238899 | controller |
2026-01-29 19:09:14.238915 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2026-01-29 19:09:14.238922 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.023)       0:01:05.125 ******
2026-01-29 19:09:14.238937 | controller | skipping: [instance]
2026-01-29 19:09:14.260354 | controller |
2026-01-29 19:09:14.260373 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2026-01-29 19:09:14.260382 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.022)       0:01:05.148 ******
2026-01-29 19:09:14.260391 | controller | skipping: [instance]
2026-01-29 19:09:14.260415 | controller |
2026-01-29 19:09:14.260558 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2026-01-29 19:09:14.282154 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.021)       0:01:05.169 ******
2026-01-29 19:09:14.282172 | controller | skipping: [instance]
2026-01-29 19:09:14.303731 | controller |
2026-01-29 19:09:14.303746 | controller | TASK [repo_setup : Lower the priority of component repos to allow installation from gating repo] ***
2026-01-29 19:09:14.303753 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.021)       0:01:05.191 ******
2026-01-29 19:09:14.303762 | controller | skipping: [instance]
2026-01-29 19:09:14.559353 | controller |
2026-01-29 19:09:14.559376 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2026-01-29 19:09:14.559384 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.021)       0:01:05.212 ******
2026-01-29 19:09:14.559393 | controller | ok: [instance]
2026-01-29 19:09:14.559657 | controller |
2026-01-29 19:09:15.955921 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2026-01-29 19:09:15.955957 | controller | Thursday 29 January 2026  19:09:14 +0000 (0:00:00.255)       0:01:05.468 ******
2026-01-29 19:09:15.955968 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos-addons.repo)
2026-01-29 19:09:16.340873 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos.repo)
2026-01-29 19:09:16.340903 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean.repo)
2026-01-29 19:09:16.340910 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean-master-testing.repo)
2026-01-29 19:09:16.340916 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-highavailability.repo)
2026-01-29 19:09:16.340922 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-powertools.repo)
2026-01-29 19:09:16.340927 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-appstream.repo)
2026-01-29 19:09:16.340932 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-baseos.repo)
2026-01-29 19:09:16.340937 | controller |
2026-01-29 19:09:16.340942 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2026-01-29 19:09:16.340953 | controller | Thursday 29 January 2026  19:09:15 +0000 (0:00:01.395)       0:01:06.863 ******
2026-01-29 19:09:16.340963 | controller | changed: [instance]
2026-01-29 19:09:16.550397 | controller |
2026-01-29 19:09:16.550427 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2026-01-29 19:09:16.550436 | controller | Thursday 29 January 2026  19:09:16 +0000 (0:00:00.385)       0:01:07.249 ******
2026-01-29 19:09:16.550446 | controller | changed: [instance]
2026-01-29 19:09:16.552761 | controller |
2026-01-29 19:09:16.552797 | controller | PLAY RECAP *********************************************************************
2026-01-29 19:09:16.606473 | controller | instance                   : ok=35   changed=17   unreachable=0    failed=0    skipped=50   rescued=0    ignored=0
2026-01-29 19:09:16.606496 | controller |
2026-01-29 19:09:16.606503 | controller | Thursday 29 January 2026  19:09:16 +0000 (0:00:00.209)       0:01:07.458 ******
2026-01-29 19:09:16.606509 | controller | ===============================================================================
2026-01-29 19:09:16.606515 | controller | test_deps : Install selinux python libs -------------------------------- 40.38s
2026-01-29 19:09:16.606519 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.40s
2026-01-29 19:09:16.606524 | controller | repo_setup : Run repo-setup --------------------------------------------- 1.84s
2026-01-29 19:09:16.606529 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.75s
2026-01-29 19:09:16.606534 | controller | repo_setup : Remove existing repos from /etc/yum.repos.d directory ------ 1.40s
2026-01-29 19:09:16.606544 | controller | test_deps : Install python yaml libs ------------------------------------ 1.10s
2026-01-29 19:09:16.606550 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.09s
2026-01-29 19:09:16.606554 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.08s
2026-01-29 19:09:16.606559 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.05s
2026-01-29 19:09:16.606564 | controller | Gathering Facts --------------------------------------------------------- 0.82s
2026-01-29 19:09:16.606569 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.79s
2026-01-29 19:09:16.606574 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.75s
2026-01-29 19:09:16.606579 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.68s
2026-01-29 19:09:16.606583 | controller | repo_setup : Install repo-setup package --------------------------------- 0.66s
2026-01-29 19:09:16.606588 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.53s
2026-01-29 19:09:16.606593 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.51s
2026-01-29 19:09:16.606598 | controller | repo_setup : Ensure directories are present ----------------------------- 0.50s
2026-01-29 19:09:16.606603 | controller | repo_setup : Ensure directories are present ----------------------------- 0.49s
2026-01-29 19:09:16.606608 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.41s
2026-01-29 19:09:16.606613 | controller | repo_setup : Cleanup existing metadata ---------------------------------- 0.39s
2026-01-29 19:09:16.606631 | controller | INFO     Running default > converge
2026-01-29 19:09:17.035093 | controller |
2026-01-29 19:09:17.035433 | controller | PLAY [Converge] ****************************************************************
2026-01-29 19:09:17.035655 | controller |
2026-01-29 19:09:17.035774 | controller | TASK [Gathering Facts] *********************************************************
2026-01-29 19:09:17.035894 | controller | Thursday 29 January 2026  19:09:17 +0000 (0:00:00.031)       0:00:00.031 ******
2026-01-29 19:09:17.768973 | controller | ok: [instance]
2026-01-29 19:09:19.054692 | controller |
2026-01-29 19:09:19.054722 | controller | TASK [Clone neutron-tempest-plugin] ********************************************
2026-01-29 19:09:19.054730 | controller | Thursday 29 January 2026  19:09:17 +0000 (0:00:00.733)       0:00:00.765 ******
2026-01-29 19:09:19.054744 | controller | changed: [instance]
2026-01-29 19:09:19.078391 | controller |
2026-01-29 19:09:19.078426 | controller | TASK [Set cifmw_bop_openstack_project_path] ************************************
2026-01-29 19:09:19.078435 | controller | Thursday 29 January 2026  19:09:19 +0000 (0:00:01.285)       0:00:02.051 ******
2026-01-29 19:09:19.078447 | controller | ok: [instance]
2026-01-29 19:09:19.078475 | controller |
2026-01-29 19:09:19.078705 | controller | TASK [build_openstack_packages : Install Mock from DLRN repos] *****************
2026-01-29 19:09:43.799372 | controller | Thursday 29 January 2026  19:09:19 +0000 (0:00:00.024)       0:00:02.075 ******
2026-01-29 19:09:43.799408 | controller | changed: [instance]
2026-01-29 19:09:43.799494 | controller |
2026-01-29 19:09:43.799503 | controller | TASK [build_openstack_packages : Ensure DLRN package dependencies] *************
2026-01-29 19:09:43.799511 | controller | Thursday 29 January 2026  19:09:43 +0000 (0:00:24.720)       0:00:26.795 ******
2026-01-29 19:09:45.119418 | controller | changed: [instance]
2026-01-29 19:09:45.119492 | controller |
2026-01-29 19:09:45.119503 | controller | TASK [build_openstack_packages : Create mock group] ****************************
2026-01-29 19:09:45.119511 | controller | Thursday 29 January 2026  19:09:45 +0000 (0:00:01.319)       0:00:28.115 ******
2026-01-29 19:09:45.401096 | controller | ok: [instance]
2026-01-29 19:09:45.755323 | controller |
2026-01-29 19:09:45.755353 | controller | TASK [build_openstack_packages : Add user to mock group] ***********************
2026-01-29 19:09:45.755361 | controller | Thursday 29 January 2026  19:09:45 +0000 (0:00:00.281)       0:00:28.397 ******
2026-01-29 19:09:45.755371 | controller | changed: [instance]
2026-01-29 19:09:46.031150 | controller |
2026-01-29 19:09:46.031179 | controller | TASK [build_openstack_packages : Ensure DLRN dir is present] *******************
2026-01-29 19:09:46.031188 | controller | Thursday 29 January 2026  19:09:45 +0000 (0:00:00.354)       0:00:28.751 ******
2026-01-29 19:09:46.031203 | controller | changed: [instance]
2026-01-29 19:09:46.304183 | controller |
2026-01-29 19:09:46.304206 | controller | TASK [build_openstack_packages : Remove data files from previous runs] *********
2026-01-29 19:09:46.304213 | controller | Thursday 29 January 2026  19:09:46 +0000 (0:00:00.275)       0:00:29.027 ******
2026-01-29 19:09:46.304222 | controller | ok: [instance]
2026-01-29 19:09:49.925952 | controller |
2026-01-29 19:09:49.925984 | controller | TASK [build_openstack_packages : Create dlrn-venv] *****************************
2026-01-29 19:09:49.925992 | controller | Thursday 29 January 2026  19:09:46 +0000 (0:00:00.273)       0:00:29.300 ******
2026-01-29 19:09:49.926002 | controller | changed: [instance]
2026-01-29 19:09:49.954071 | controller |
2026-01-29 19:09:49.954094 | controller | TASK [build_openstack_packages : Fetch DLRN from source] ***********************
2026-01-29 19:09:49.954101 | controller | Thursday 29 January 2026  19:09:49 +0000 (0:00:03.621)       0:00:32.922 ******
2026-01-29 19:09:49.954111 | controller | skipping: [instance]
2026-01-29 19:09:49.980003 | controller |
2026-01-29 19:09:49.980020 | controller | TASK [build_openstack_packages : Install DLRN requirements] ********************
2026-01-29 19:09:49.980027 | controller | Thursday 29 January 2026  19:09:49 +0000 (0:00:00.028)       0:00:32.950 ******
2026-01-29 19:09:49.980036 | controller | skipping: [instance]
2026-01-29 19:09:50.005145 | controller |
2026-01-29 19:09:50.005162 | controller | TASK [build_openstack_packages : Install DLRN from source] *********************
2026-01-29 19:09:50.005169 | controller | Thursday 29 January 2026  19:09:49 +0000 (0:00:00.025)       0:00:32.976 ******
2026-01-29 19:09:50.005178 | controller | skipping: [instance]
2026-01-29 19:10:04.617975 | controller |
2026-01-29 19:10:04.618006 | controller | TASK [build_openstack_packages : Install DLRN and rdopkg from pip] *************
2026-01-29 19:10:04.618014 | controller | Thursday 29 January 2026  19:09:50 +0000 (0:00:00.025)       0:00:33.001 ******
2026-01-29 19:10:04.618023 | controller | changed: [instance]
2026-01-29 19:10:05.131136 | controller |
2026-01-29 19:10:05.131162 | controller | TASK [build_openstack_packages : Drop in the templated version of projects.ini] ***
2026-01-29 19:10:05.131169 | controller | Thursday 29 January 2026  19:10:04 +0000 (0:00:14.612)       0:00:47.614 ******
2026-01-29 19:10:05.131179 | controller | changed: [instance]
2026-01-29 19:10:05.451656 | controller |
2026-01-29 19:10:05.451690 | controller | TASK [build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir] ***
2026-01-29 19:10:05.451698 | controller | Thursday 29 January 2026  19:10:05 +0000 (0:00:00.513)       0:00:48.127 ******
2026-01-29 19:10:05.451707 | controller | changed: [instance]
2026-01-29 19:10:08.303090 | controller |
2026-01-29 19:10:08.303146 | controller | TASK [build_openstack_packages : Fetch local rdoinfo copy] *********************
2026-01-29 19:10:08.303155 | controller | Thursday 29 January 2026  19:10:05 +0000 (0:00:00.320)       0:00:48.448 ******
2026-01-29 19:10:08.303169 | controller | changed: [instance]
2026-01-29 19:10:08.324943 | controller |
2026-01-29 19:10:08.324960 | controller | TASK [build_openstack_packages : Downstream related tasks] *********************
2026-01-29 19:10:08.324967 | controller | Thursday 29 January 2026  19:10:08 +0000 (0:00:02.850)       0:00:51.298 ******
2026-01-29 19:10:08.324984 | controller | skipping: [instance]
2026-01-29 19:10:08.606374 | controller |
2026-01-29 19:10:08.606396 | controller | TASK [build_openstack_packages : Find all the repos files] *********************
2026-01-29 19:10:08.606403 | controller | Thursday 29 January 2026  19:10:08 +0000 (0:00:00.022)       0:00:51.321 ******
2026-01-29 19:10:08.606411 | controller | ok: [instance]
2026-01-29 19:10:08.812038 | controller |
2026-01-29 19:10:08.812094 | controller | TASK [build_openstack_packages : Create local mock config] *********************
2026-01-29 19:10:08.812103 | controller | Thursday 29 January 2026  19:10:08 +0000 (0:00:00.281)       0:00:51.602 ******
2026-01-29 19:10:08.812116 | controller | changed: [instance]
2026-01-29 19:10:08.993434 | controller |
2026-01-29 19:10:08.993481 | controller | TASK [build_openstack_packages : Remove last """ from local mock config] *******
2026-01-29 19:10:08.993491 | controller | Thursday 29 January 2026  19:10:08 +0000 (0:00:00.205)       0:00:51.808 ******
2026-01-29 19:10:08.993504 | controller | changed: [instance]
2026-01-29 19:10:09.044363 | controller |
2026-01-29 19:10:09.044387 | controller | TASK [build_openstack_packages : Append repos into mock local config] **********
2026-01-29 19:10:09.044403 | controller | Thursday 29 January 2026  19:10:08 +0000 (0:00:00.181)       0:00:51.989 ******
2026-01-29 19:10:09.044419 | 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-01-29 19:10:09.045092 | 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-01-29 19:10:09.299062 | 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-01-29 19:10:09.299098 | 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-01-29 19:10:09.299106 | 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-01-29 19:10:09.299111 | 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-01-29 19:10:09.299116 | controller |
2026-01-29 19:10:09.299122 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-01-29 19:10:09.299128 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.051)       0:00:52.041 ******
2026-01-29 19:10:09.299139 | controller | ok: [instance]
2026-01-29 19:10:09.332366 | controller |
2026-01-29 19:10:09.332388 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-01-29 19:10:09.332397 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.254)       0:00:52.295 ******
2026-01-29 19:10:09.332407 | controller | ok: [instance]
2026-01-29 19:10:09.495120 | controller |
2026-01-29 19:10:09.495156 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-01-29 19:10:09.495165 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.033)       0:00:52.329 ******
2026-01-29 19:10:09.495176 | controller | ok: [instance]
2026-01-29 19:10:09.525363 | controller |
2026-01-29 19:10:09.525384 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-01-29 19:10:09.525392 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.162)       0:00:52.491 ******
2026-01-29 19:10:09.525403 | controller | ok: [instance]
2026-01-29 19:10:09.525427 | controller |
2026-01-29 19:10:09.525437 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-01-29 19:10:09.525524 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.030)       0:00:52.522 ******
2026-01-29 19:10:09.687185 | controller | ok: [instance]
2026-01-29 19:10:09.717087 | controller |
2026-01-29 19:10:09.717104 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-01-29 19:10:09.717118 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.161)       0:00:52.683 ******
2026-01-29 19:10:09.717127 | controller | ok: [instance]
2026-01-29 19:10:09.877089 | controller |
2026-01-29 19:10:09.877124 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-01-29 19:10:09.877132 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.030)       0:00:52.713 ******
2026-01-29 19:10:09.877142 | controller | ok: [instance]
2026-01-29 19:10:09.906853 | controller |
2026-01-29 19:10:09.906875 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-01-29 19:10:09.906893 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.159)       0:00:52.873 ******
2026-01-29 19:10:09.906906 | controller | ok: [instance]
2026-01-29 19:10:10.070083 | controller |
2026-01-29 19:10:10.070115 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-01-29 19:10:10.070124 | controller | Thursday 29 January 2026  19:10:09 +0000 (0:00:00.029)       0:00:52.903 ******
2026-01-29 19:10:10.070135 | controller | ok: [instance]
2026-01-29 19:10:10.101160 | controller |
2026-01-29 19:10:10.101181 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-01-29 19:10:10.101189 | controller | Thursday 29 January 2026  19:10:10 +0000 (0:00:00.163)       0:00:53.066 ******
2026-01-29 19:10:10.101198 | controller | ok: [instance]
2026-01-29 19:10:10.262690 | controller |
2026-01-29 19:10:10.262724 | controller | TASK [build_openstack_packages : Slurp the repo files and append] **************
2026-01-29 19:10:10.262732 | controller | Thursday 29 January 2026  19:10:10 +0000 (0:00:00.031)       0:00:53.097 ******
2026-01-29 19:10:10.262743 | controller | ok: [instance]
2026-01-29 19:10:10.293411 | controller |
2026-01-29 19:10:10.293445 | controller | TASK [build_openstack_packages : Store the all repo data in a single list] *****
2026-01-29 19:10:10.293460 | controller | Thursday 29 January 2026  19:10:10 +0000 (0:00:00.161)       0:00:53.259 ******
2026-01-29 19:10:10.293471 | controller | ok: [instance]
2026-01-29 19:10:10.558977 | controller |
2026-01-29 19:10:10.559023 | controller | TASK [build_openstack_packages : Append repo_content ending with """ in mock local config at last] ***
2026-01-29 19:10:10.559032 | controller | Thursday 29 January 2026  19:10:10 +0000 (0:00:00.031)       0:00:53.290 ******
2026-01-29 19:10:10.559044 | controller | changed: [instance]
2026-01-29 19:10:10.559063 | controller |
2026-01-29 19:10:10.559260 | controller | TASK [build_openstack_packages : Check loop devices stat] **********************
2026-01-29 19:10:12.414387 | controller | Thursday 29 January 2026  19:10:10 +0000 (0:00:00.265)       0:00:53.555 ******
2026-01-29 19:10:12.414426 | controller | ok: [instance] => (item=0)
2026-01-29 19:10:12.414451 | controller | ok: [instance] => (item=1)
2026-01-29 19:10:12.414457 | controller | ok: [instance] => (item=2)
2026-01-29 19:10:12.414463 | controller | ok: [instance] => (item=3)
2026-01-29 19:10:12.414471 | controller | ok: [instance] => (item=4)
2026-01-29 19:10:12.414478 | controller | ok: [instance] => (item=5)
2026-01-29 19:10:12.415204 | controller | ok: [instance] => (item=6)
2026-01-29 19:10:12.450803 | controller | ok: [instance] => (item=7)
2026-01-29 19:10:12.450825 | controller | ok: [instance] => (item=8)
2026-01-29 19:10:12.450834 | controller | ok: [instance] => (item=9)
2026-01-29 19:10:12.450853 | controller | ok: [instance] => (item=10)
2026-01-29 19:10:12.450861 | controller | ok: [instance] => (item=11)
2026-01-29 19:10:12.450868 | controller |
2026-01-29 19:10:12.450875 | controller | TASK [build_openstack_packages : Set loop_devices_absent fact] *****************
2026-01-29 19:10:12.450882 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:01.855)       0:00:55.410 ******
2026-01-29 19:10:12.450894 | controller | ok: [instance]
2026-01-29 19:10:12.484283 | controller |
2026-01-29 19:10:12.484314 | controller | TASK [build_openstack_packages : Parse Zuul changes] ***************************
2026-01-29 19:10:12.484321 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.036)       0:00:55.447 ******
2026-01-29 19:10:12.484330 | controller | skipping: [instance]
2026-01-29 19:10:12.502754 | controller |
2026-01-29 19:10:12.502772 | controller | TASK [build_openstack_packages : Print Zuul change list] ***********************
2026-01-29 19:10:12.502780 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.033)       0:00:55.480 ******
2026-01-29 19:10:12.502789 | controller | ok: [instance] =>
2026-01-29 19:10:12.516737 | controller |   cifmw_bop_change_list: []
2026-01-29 19:10:12.516753 | controller |
2026-01-29 19:10:12.516759 | controller | TASK [build_openstack_packages : Build DLRN packages from zuul changes] ********
2026-01-29 19:10:12.516764 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.018)       0:00:55.499 ******
2026-01-29 19:10:12.516772 | controller | skipping: [instance]
2026-01-29 19:10:12.567360 | controller |
2026-01-29 19:10:12.567382 | controller | TASK [build_openstack_packages : Build DLRN packages from Local change] ********
2026-01-29 19:10:12.567392 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.014)       0:00:55.513 ******
2026-01-29 19:10:12.567409 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/build_openstack_packages/tasks/run_dlrn.yml for instance
2026-01-29 19:10:12.567685 | controller |
2026-01-29 19:10:12.595377 | controller | TASK [build_openstack_packages : Set proper branch name for stable opendev branches] ***
2026-01-29 19:10:12.595408 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.050)       0:00:55.564 ******
2026-01-29 19:10:12.595421 | controller | skipping: [instance]
2026-01-29 19:10:12.595453 | controller |
2026-01-29 19:10:12.595462 | controller | TASK [build_openstack_packages : Set proper branch name for non-stable branches] ***
2026-01-29 19:10:12.595498 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.027)       0:00:55.592 ******
2026-01-29 19:10:12.626415 | controller | ok: [instance]
2026-01-29 19:10:12.646862 | controller |
2026-01-29 19:10:12.646880 | controller | TASK [build_openstack_packages : Set RDO release for master openstack release] ***
2026-01-29 19:10:12.646888 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.030)       0:00:55.623 ******
2026-01-29 19:10:12.646897 | controller | ok: [instance]
2026-01-29 19:10:12.664438 | controller |
2026-01-29 19:10:12.664456 | controller | TASK [build_openstack_packages : Set RDO release for non-master openstack release] ***
2026-01-29 19:10:12.664463 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.020)       0:00:55.643 ******
2026-01-29 19:10:12.664472 | controller | skipping: [instance]
2026-01-29 19:10:12.681344 | controller |
2026-01-29 19:10:12.681362 | controller | TASK [build_openstack_packages : Make sure /usr/share/rhn/RHN-ORG-TRUSTED-SSL-CERT exists (RHEL)] ***
2026-01-29 19:10:12.681370 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.017)       0:00:55.661 ******
2026-01-29 19:10:12.681379 | controller | skipping: [instance]
2026-01-29 19:10:12.681431 | controller |
2026-01-29 19:10:12.681440 | controller | TASK [build_openstack_packages : Override projects.ini settings] ***************
2026-01-29 19:10:12.681448 | controller | Thursday 29 January 2026  19:10:12 +0000 (0:00:00.016)       0:00:55.678 ******
2026-01-29 19:10:13.185870 | controller | ok: [instance] => (item={'regexp': 'baseurl=.*', 'line': 'baseurl=https://trunk.rdoproject.org/centos9-master'})
2026-01-29 19:10:16.397372 | controller | ok: [instance] => (item={'regexp': 'distro=.*', 'line': 'distro=rpm-master'})
2026-01-29 19:10:16.397399 | controller | ok: [instance] => (item={'regexp': 'source=.*', 'line': 'source=master'})
2026-01-29 19:10:16.397407 | controller |
2026-01-29 19:10:16.397413 | controller | TASK [build_openstack_packages : Map project name to DLRN project name] ********
2026-01-29 19:10:16.397418 | controller | Thursday 29 January 2026  19:10:13 +0000 (0:00:00.504)       0:00:56.182 ******
2026-01-29 19:10:16.397427 | controller | ok: [instance]
2026-01-29 19:10:16.575244 | controller |
2026-01-29 19:10:16.575267 | controller | TASK [build_openstack_packages : Create data directory if doesn't exist yet] ***
2026-01-29 19:10:16.575275 | controller | Thursday 29 January 2026  19:10:16 +0000 (0:00:03.211)       0:00:59.393 ******
2026-01-29 19:10:16.575284 | controller | changed: [instance]
2026-01-29 19:10:16.744321 | controller |
2026-01-29 19:10:16.744338 | controller | TASK [build_openstack_packages : Check for existing python-neutron-tests-tempest] ***
2026-01-29 19:10:16.744346 | controller | Thursday 29 January 2026  19:10:16 +0000 (0:00:00.178)       0:00:59.571 ******
2026-01-29 19:10:16.744362 | controller | ok: [instance]
2026-01-29 19:10:17.261215 | controller |
2026-01-29 19:10:17.261242 | controller | TASK [build_openstack_packages : Sync python-neutron-tests-tempest from local repo] ***
2026-01-29 19:10:17.261249 | controller | Thursday 29 January 2026  19:10:16 +0000 (0:00:00.168)       0:00:59.740 ******
2026-01-29 19:10:17.261259 | controller | changed: [instance]
2026-01-29 19:10:17.293271 | controller |
2026-01-29 19:10:17.293311 | controller | TASK [build_openstack_packages : Symlink python-neutron-tests-tempest from Zuul clonned repos for upstream] ***
2026-01-29 19:10:17.293322 | controller | Thursday 29 January 2026  19:10:17 +0000 (0:00:00.516)       0:01:00.257 ******
2026-01-29 19:10:17.293332 | controller | skipping: [instance]
2026-01-29 19:10:17.326125 | controller |
2026-01-29 19:10:17.326146 | controller | TASK [build_openstack_packages : Update packages.yml to use zuul repo for python-neutron-tests-tempest] ***
2026-01-29 19:10:17.326156 | controller | Thursday 29 January 2026  19:10:17 +0000 (0:00:00.032)       0:01:00.289 ******
2026-01-29 19:10:17.326177 | controller | skipping: [instance]
2026-01-29 19:10:17.529387 | controller |
2026-01-29 19:10:17.529417 | controller | TASK [build_openstack_packages : Find the last commit from the clonned repo] ***
2026-01-29 19:10:17.529425 | controller | Thursday 29 January 2026  19:10:17 +0000 (0:00:00.032)       0:01:00.322 ******
2026-01-29 19:10:17.529435 | controller | changed: [instance]
2026-01-29 19:10:17.529457 | controller |
2026-01-29 19:10:17.529465 | controller | TASK [build_openstack_packages : Print the last commit of the git repo] ********
2026-01-29 19:10:17.529548 | controller | Thursday 29 January 2026  19:10:17 +0000 (0:00:00.203)       0:01:00.526 ******
2026-01-29 19:10:17.552423 | controller | ok: [instance] =>
2026-01-29 19:10:17.552462 | controller |   _commit.stdout: ae235c460f0136d0a109cd1e15d8585a7a667923
2026-01-29 19:10:17.552472 | controller |
2026-01-29 19:10:17.552481 | controller | TASK [build_openstack_packages : Ensure distgit repo is absent, DLRN takes care of cloning based on config] ***
2026-01-29 19:10:17.552493 | controller | Thursday 29 January 2026  19:10:17 +0000 (0:00:00.022)       0:01:00.549 ******
2026-01-29 19:10:17.724467 | controller | ok: [instance]
2026-01-29 19:10:18.050994 | controller |
2026-01-29 19:10:18.051023 | controller | TASK [build_openstack_packages : Generate DLRN Script] *************************
2026-01-29 19:10:18.051031 | controller | Thursday 29 January 2026  19:10:17 +0000 (0:00:00.172)       0:01:00.721 ******
2026-01-29 19:10:18.051041 | controller | changed: [instance]
2026-01-29 19:10:18.083112 | controller |
2026-01-29 19:10:18.083128 | controller | TASK [build_openstack_packages : Print info about building] ********************
2026-01-29 19:10:18.083134 | controller | Thursday 29 January 2026  19:10:18 +0000 (0:00:00.326)       0:01:01.047 ******
2026-01-29 19:10:18.083143 | controller | ok: [instance] =>
2026-01-29 19:10:18.255268 | controller |   msg: Building change for python-neutron-tests-tempest
2026-01-29 19:10:18.255289 | controller |
2026-01-29 19:10:18.255314 | controller | TASK [build_openstack_packages : Ensure logs dir exists] ***********************
2026-01-29 19:10:18.255321 | controller | Thursday 29 January 2026  19:10:18 +0000 (0:00:00.032)       0:01:01.079 ******
2026-01-29 19:10:18.255330 | controller | ok: [instance]
2026-01-29 19:15:48.192385 | controller |
2026-01-29 19:15:48.192416 | controller | TASK [build_openstack_packages : Run DLRN] *************************************
2026-01-29 19:15:48.192424 | controller | Thursday 29 January 2026  19:10:18 +0000 (0:00:00.172)       0:01:01.251 ******
2026-01-29 19:15:48.192434 | controller | fatal: [instance]: FAILED! => changed=true
2026-01-29 19:15:48.192454 | controller |   cmd: |-
2026-01-29 19:15:48.192461 | 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-01-29 19:15:48.192466 | controller |   delta: '0:05:29.764127'
2026-01-29 19:15:48.192472 | controller |   end: '2026-01-29 19:15:48.168012'
2026-01-29 19:15:48.192477 | controller |   msg: non-zero return code
2026-01-29 19:15:48.192482 | controller |   rc: 1
2026-01-29 19:15:48.192487 | controller |   start: '2026-01-29 19:10:18.403885'
2026-01-29 19:15:48.192493 | controller |   stderr: ''
2026-01-29 19:15:48.192518 | controller |   stderr_lines: <omitted>
2026-01-29 19:15:48.192699 | controller |   stdout: ''
2026-01-29 19:15:48.196330 | controller |   stdout_lines: <omitted>
2026-01-29 19:15:48.196344 | controller |
2026-01-29 19:15:48.367354 | controller | TASK [build_openstack_packages : Copy DLRN artifacts] **************************
2026-01-29 19:15:48.367381 | controller | Thursday 29 January 2026  19:15:48 +0000 (0:05:29.941)       0:06:31.193 ******
2026-01-29 19:15:48.367392 | controller | changed: [instance]
2026-01-29 19:15:48.367414 | controller |
2026-01-29 19:15:48.367582 | controller | TASK [build_openstack_packages : Fail the execution] ***************************
2026-01-29 19:15:48.382097 | controller | Thursday 29 January 2026  19:15:48 +0000 (0:00:00.170)       0:06:31.363 ******
2026-01-29 19:15:48.382117 | controller | fatal: [instance]: FAILED! => changed=false
2026-01-29 19:15:48.384421 | controller |   msg: DLRN run failed
2026-01-29 19:15:48.384442 | controller |
2026-01-29 19:15:48.384478 | controller | PLAY RECAP *********************************************************************
2026-01-29 19:15:48.384617 | controller | instance                   : ok=54   changed=18   unreachable=0    failed=1    skipped=11   rescued=1    ignored=0
2026-01-29 19:15:48.386626 | controller |
2026-01-29 19:15:48.433594 | controller | Thursday 29 January 2026  19:15:48 +0000 (0:00:00.017)       0:06:31.381 ******
2026-01-29 19:15:48.433622 | controller | ===============================================================================
2026-01-29 19:15:48.433629 | controller | build_openstack_packages : Run DLRN ----------------------------------- 329.94s
2026-01-29 19:15:48.433635 | controller | build_openstack_packages : Install Mock from DLRN repos ---------------- 24.72s
2026-01-29 19:15:48.433640 | controller | build_openstack_packages : Install DLRN and rdopkg from pip ------------ 14.61s
2026-01-29 19:15:48.433645 | controller | build_openstack_packages : Create dlrn-venv ----------------------------- 3.62s
2026-01-29 19:15:48.433649 | controller | build_openstack_packages : Map project name to DLRN project name -------- 3.21s
2026-01-29 19:15:48.433654 | controller | build_openstack_packages : Fetch local rdoinfo copy --------------------- 2.85s
2026-01-29 19:15:48.433659 | controller | build_openstack_packages : Check loop devices stat ---------------------- 1.86s
2026-01-29 19:15:48.433669 | controller | build_openstack_packages : Ensure DLRN package dependencies ------------- 1.32s
2026-01-29 19:15:48.433674 | controller | Clone neutron-tempest-plugin -------------------------------------------- 1.29s
2026-01-29 19:15:48.433679 | controller | Gathering Facts --------------------------------------------------------- 0.73s
2026-01-29 19:15:48.433684 | controller | build_openstack_packages : Sync python-neutron-tests-tempest from local repo --- 0.52s
2026-01-29 19:15:48.433690 | controller | build_openstack_packages : Drop in the templated version of projects.ini --- 0.51s
2026-01-29 19:15:48.433694 | controller | build_openstack_packages : Override projects.ini settings --------------- 0.50s
2026-01-29 19:15:48.433699 | controller | build_openstack_packages : Add user to mock group ----------------------- 0.35s
2026-01-29 19:15:48.433704 | controller | build_openstack_packages : Generate DLRN Script ------------------------- 0.33s
2026-01-29 19:15:48.433709 | controller | build_openstack_packages : Copy the DLRN scripts in the virtualenv to the scripts dir --- 0.32s
2026-01-29 19:15:48.433714 | controller | build_openstack_packages : Create mock group ---------------------------- 0.28s
2026-01-29 19:15:48.433719 | controller | build_openstack_packages : Find all the repos files --------------------- 0.28s
2026-01-29 19:15:48.433724 | controller | build_openstack_packages : Ensure DLRN dir is present ------------------- 0.28s
2026-01-29 19:15:48.433729 | controller | build_openstack_packages : Remove data files from previous runs --------- 0.27s
2026-01-29 19:15:48.433741 | 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-01-29 19:15:48.434127 | controller | WARNING  An error occurred during the test sequence action: 'converge'. Cleaning up.
2026-01-29 19:15:48.442040 | controller | INFO     Running default > cleanup
2026-01-29 19:15:48.442469 | controller | WARNING  Skipping, cleanup playbook not configured.
2026-01-29 19:15:48.449719 | controller | INFO     Running default > destroy
2026-01-29 19:15:48.450024 | controller | WARNING  Skipping, instances are delegated.
2026-01-29 19:15:48.450373 | controller | INFO     Pruning extra files from scenario ephemeral directory
2026-01-29 19:15:48.451697 | controller | INFO     Writing /tmp/report.html report.
2026-01-29 19:15:48.856710 | controller | ERROR
2026-01-29 19:15:48.856836 | controller | {
2026-01-29 19:15:48.856868 | controller |   "delta": "0:07:56.895553",
2026-01-29 19:15:48.856889 | controller |   "end": "2026-01-29 19:15:48.486382",
2026-01-29 19:15:48.856906 | controller |   "msg": "non-zero return code",
2026-01-29 19:15:48.856922 | controller |   "rc": 1,
2026-01-29 19:15:48.856938 | controller |   "start": "2026-01-29 19:07:51.590829"
2026-01-29 19:15:48.856951 | controller | }
failure
2026-01-29 19:15:48.903656 | 
2026-01-29 19:15:48.903700 | PLAY RECAP
2026-01-29 19:15:48.903737 | controller | ok: 3 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0
2026-01-29 19:15:48.903757 | 
2026-01-29 19:15:48.958371 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2026-01-29 19:15:48.959151 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-01-29 19:15:49.440335 | 
2026-01-29 19:15:49.440426 | PLAY [Run ci/playbooks/collect-logs.yml]
2026-01-29 19:15:49.458573 | 
2026-01-29 19:15:49.458639 | TASK [Filter out host if needed]
2026-01-29 19:15:49.466482 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2026-01-29 19:15:49.470629 | 
2026-01-29 19:15:49.470696 | TASK [Ensure file is present]
2026-01-29 19:15:49.741819 | controller | ok
2026-01-29 19:15:49.748326 | 
2026-01-29 19:15:49.748393 | TASK [Manage molecule report file]
2026-01-29 19:15:50.272507 | controller | changed
2026-01-29 19:15:50.278117 | 
2026-01-29 19:15:50.278179 | TASK [Check if we get ci-framework-data basedir]
2026-01-29 19:15:50.447692 | controller | ok
2026-01-29 19:15:50.452645 | 
2026-01-29 19:15:50.452707 | TASK [Create ci-framework-data log directory for zuul]
2026-01-29 19:15:50.732848 | controller | changed
2026-01-29 19:15:50.737840 | 
2026-01-29 19:15:50.737902 | TASK [Copy ci-framework interesting files]
2026-01-29 19:15:50.918008 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2026-01-29 19:15:51.263475 | controller | changed
2026-01-29 19:15:51.268188 | 
2026-01-29 19:15:51.268249 | TASK [Get SELinux listing]
2026-01-29 19:15:51.791666 | controller | changed
2026-01-29 19:15:51.797090 | 
2026-01-29 19:15:51.797152 | TASK [Generate log index]
2026-01-29 19:15:52.362910 | controller | changed
2026-01-29 19:15:52.367693 | 
2026-01-29 19:15:52.367753 | TASK [Get some env related data]
2026-01-29 19:15:52.853893 | controller | /home/zuul/.local/bin/ansible
2026-01-29 19:15:53.415916 | controller | changed
2026-01-29 19:15:53.420497 | 
2026-01-29 19:15:53.420568 | TASK [Generate list of logs to collect in home directory]
2026-01-29 19:15:53.682130 | controller | ok: All paths examined
2026-01-29 19:15:53.687078 | 
2026-01-29 19:15:53.687137 | LOOP [Copy logs from home directory]
2026-01-29 19:15:53.950180 | controller | changed:
2026-01-29 19:15:53.950341 | controller | {
2026-01-29 19:15:53.950372 | controller |   "atime": 1769713653.786428,
2026-01-29 19:15:53.950391 | controller |   "ctime": 1769713669.5166,
2026-01-29 19:15:53.950409 | controller |   "dev": 64513,
2026-01-29 19:15:53.950426 | controller |   "gid": 1000,
2026-01-29 19:15:53.950443 | controller |   "gr_name": "zuul",
2026-01-29 19:15:53.950461 | controller |   "inode": 1268438,
2026-01-29 19:15:53.950477 | controller |   "isblk": false,
2026-01-29 19:15:53.950493 | controller |   "ischr": false,
2026-01-29 19:15:53.950508 | controller |   "isdir": false,
2026-01-29 19:15:53.950523 | controller |   "isfifo": false,
2026-01-29 19:15:53.950538 | controller |   "isgid": false,
2026-01-29 19:15:53.950565 | controller |   "islnk": false,
2026-01-29 19:15:53.950580 | controller |   "isreg": true,
2026-01-29 19:15:53.950594 | controller |   "issock": false,
2026-01-29 19:15:53.950608 | controller |   "isuid": false,
2026-01-29 19:15:53.950622 | controller |   "mode": "0644",
2026-01-29 19:15:53.950635 | controller |   "mtime": 1769713669.5166,
2026-01-29 19:15:53.950649 | controller |   "nlink": 1,
2026-01-29 19:15:53.950663 | controller |   "path": "/home/zuul/ansible.log",
2026-01-29 19:15:53.950682 | controller |   "pw_name": "zuul",
2026-01-29 19:15:53.950697 | controller |   "rgrp": true,
2026-01-29 19:15:53.950711 | controller |   "roth": true,
2026-01-29 19:15:53.950725 | controller |   "rusr": true,
2026-01-29 19:15:53.950739 | controller |   "size": 6749,
2026-01-29 19:15:53.950752 | controller |   "uid": 1000,
2026-01-29 19:15:53.950765 | controller |   "wgrp": false,
2026-01-29 19:15:53.950778 | controller |   "woth": false,
2026-01-29 19:15:53.950794 | controller |   "wusr": true,
2026-01-29 19:15:53.950808 | controller |   "xgrp": false,
2026-01-29 19:15:53.950822 | controller |   "xoth": false,
2026-01-29 19:15:53.950838 | controller |   "xusr": false
2026-01-29 19:15:53.950853 | controller | }
2026-01-29 19:15:53.977497 | 
2026-01-29 19:15:53.977581 | TASK [Copy crio stats log file]
2026-01-29 19:15:53.990631 | controller | skipping: Conditional result was False
2026-01-29 19:15:53.996466 | 
2026-01-29 19:15:53.996528 | TASK [Get SELinux related data]
2026-01-29 19:15:54.183741 | controller | <no matches>
2026-01-29 19:15:54.521034 | controller | ERROR
2026-01-29 19:15:54.521164 | controller | {
2026-01-29 19:15:54.521198 | controller |   "delta": "0:00:00.009152",
2026-01-29 19:15:54.521220 | controller |   "end": "2026-01-29 19:15:54.184636",
2026-01-29 19:15:54.521240 | controller |   "msg": "non-zero return code",
2026-01-29 19:15:54.521260 | controller |   "rc": 1,
2026-01-29 19:15:54.521312 | controller |   "start": "2026-01-29 19:15:54.175484"
2026-01-29 19:15:54.521332 | controller | }
2026-01-29 19:15:54.521359 | controller | ERROR: Ignoring Errors
2026-01-29 19:15:54.526488 | 
2026-01-29 19:15:54.526559 | TASK [Create system configuration directory]
2026-01-29 19:15:54.697400 | controller | changed
2026-01-29 19:15:54.702336 | 
2026-01-29 19:15:54.702398 | TASK [Get some of the system configurations]
2026-01-29 19:15:55.227431 | controller | changed
2026-01-29 19:15:55.232123 | 
2026-01-29 19:15:55.232179 | TASK [Copy generated documentation if available]
2026-01-29 19:15:55.246103 | controller | skipping: Conditional result was False
2026-01-29 19:15:55.250830 | 
2026-01-29 19:15:55.250888 | TASK [Copy generated AsciiDoc documentation if available]
2026-01-29 19:15:55.264184 | controller | skipping: Conditional result was False
2026-01-29 19:15:55.269718 | 
2026-01-29 19:15:55.269782 | TASK [Compress logs bigger than 2MB]
2026-01-29 19:15:55.794401 | controller | changed
2026-01-29 19:15:55.799041 | 
2026-01-29 19:15:55.799107 | TASK [Copy files from workspace on node]
2026-01-29 19:15:55.816296 | controller | ok
2026-01-29 19:15:55.836383 | 
2026-01-29 19:15:55.836445 | TASK [fetch-output : Set log path for multiple nodes]
2026-01-29 19:15:55.849160 | controller | skipping: Conditional result was False
2026-01-29 19:15:55.854053 | 
2026-01-29 19:15:55.854113 | TASK [fetch-output : Set log path for single node]
2026-01-29 19:15:55.880991 | controller | ok
2026-01-29 19:15:55.885630 | 
2026-01-29 19:15:55.885699 | LOOP [fetch-output : Ensure local output dirs]
2026-01-29 19:15:56.070470 | controller -> localhost | ok: "/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/logs"
2026-01-29 19:15:56.070793 | controller -> localhost | changed: All items complete
2026-01-29 19:15:56.070831 | 
2026-01-29 19:15:56.235417 | controller -> localhost | changed: "/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/artifacts"
2026-01-29 19:15:56.421156 | controller -> localhost | changed: "/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/docs"
2026-01-29 19:15:56.432953 | 
2026-01-29 19:15:56.433055 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-01-29 19:15:56.990243 | controller | changed:
2026-01-29 19:15:56.990430 | controller | .d..t...... ./
2026-01-29 19:15:56.990460 | controller | >f+++++++++ README.html
2026-01-29 19:15:56.990481 | controller | >f+++++++++ ansible-execution.log
2026-01-29 19:15:56.990500 | controller | >f+++++++++ ansible.log
2026-01-29 19:15:56.990517 | controller | >f+++++++++ dmesg.log
2026-01-29 19:15:56.990535 | controller | >f+++++++++ installed-pkgs.log
2026-01-29 19:15:56.990564 | controller | >f+++++++++ python.log
2026-01-29 19:15:56.990582 | controller | >f+++++++++ registries.conf
2026-01-29 19:15:56.990598 | controller | >f+++++++++ report.html
2026-01-29 19:15:56.990616 | controller | >f+++++++++ selinux-denials.log
2026-01-29 19:15:56.990631 | controller | >f+++++++++ selinux-listing.log
2026-01-29 19:15:56.990647 | controller | cd+++++++++ ci-framework-data/
2026-01-29 19:15:56.990663 | controller | cd+++++++++ ci-framework-data/artifacts/
2026-01-29 19:15:56.990678 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2026-01-29 19:15:56.990693 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2026-01-29 19:15:56.990708 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2026-01-29 19:15:56.990723 | controller | cd+++++++++ ci-framework-data/logs/
2026-01-29 19:15:56.990737 | controller | >f+++++++++ ci-framework-data/logs/dlrn.log
2026-01-29 19:15:56.990752 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2026-01-29 19:15:56.990767 | controller | cd+++++++++ ci-framework-data/logs/component_logs/
2026-01-29 19:15:56.990781 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/
2026-01-29 19:15:56.990796 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ae/
2026-01-29 19:15:56.990812 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ae/23/
2026-01-29 19:15:56.990828 | controller | cd+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/
2026-01-29 19:15:56.990844 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/build.log
2026-01-29 19:15:56.990865 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/commit.yaml
2026-01-29 19:15:56.990881 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/hw_info.log
2026-01-29 19:15:56.990896 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/installed_pkgs.log
2026-01-29 19:15:56.990912 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/mock.log
2026-01-29 19:15:56.990929 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/notes.log
2026-01-29 19:15:56.990945 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/python-neutron-tests-tempest-3.0.1-0.20260129191020.ae235c4.el9.src.rpm
2026-01-29 19:15:56.990962 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/root.log
2026-01-29 19:15:56.990978 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/rpmbuild.log
2026-01-29 19:15:56.990992 | controller | >f+++++++++ ci-framework-data/logs/component_logs/network/ae/23/ae235c460f0136d0a109cd1e15d8585a7a667923_dev/state.log
2026-01-29 19:15:56.991008 | controller | cd+++++++++ registries.conf.d/
2026-01-29 19:15:56.991023 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2026-01-29 19:15:56.991039 | controller | cd+++++++++ system-config/
2026-01-29 19:15:56.991054 | controller | cd+++++++++ system-config/libvirt/
2026-01-29 19:15:56.991069 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2026-01-29 19:15:56.991084 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2026-01-29 19:15:57.342437 | controller | changed: .d..t...... ./
2026-01-29 19:15:57.680913 | controller | changed: .d..t...... ./
2026-01-29 19:15:57.693654 | 
2026-01-29 19:15:57.693721 | TASK [Return artifact to Zuul]
2026-01-29 19:15:57.722007 | controller | ok
2026-01-29 19:15:57.739413 | 
2026-01-29 19:15:57.739465 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2026-01-29 19:15:57.739565 | 
2026-01-29 19:15:57.739592 | PLAY RECAP
2026-01-29 19:15:57.739629 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2026-01-29 19:15:57.739648 | 
2026-01-29 19:15:57.810860 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2026-01-29 19:15:57.811605 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-29 19:15:58.319761 | 
2026-01-29 19:15:58.319852 | PLAY [all]
2026-01-29 19:15:58.366835 | 
2026-01-29 19:15:58.366907 | TASK [include_role : fetch-output]
2026-01-29 19:15:58.394958 | controller | ok
2026-01-29 19:15:58.410394 | 
2026-01-29 19:15:58.410465 | TASK [fetch-output : Set log path for multiple nodes]
2026-01-29 19:15:58.454438 | controller | skipping: Conditional result was False
2026-01-29 19:15:58.459678 | 
2026-01-29 19:15:58.459742 | TASK [fetch-output : Set log path for single node]
2026-01-29 19:15:58.487463 | controller | ok
2026-01-29 19:15:58.491942 | 
2026-01-29 19:15:58.492002 | LOOP [fetch-output : Ensure local output dirs]
2026-01-29 19:15:58.788945 | controller -> localhost | ok: "/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/logs"
2026-01-29 19:15:58.968521 | controller -> localhost | ok: "/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/artifacts"
2026-01-29 19:15:59.141210 | controller -> localhost | ok: "/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/docs"
2026-01-29 19:15:59.151124 | 
2026-01-29 19:15:59.151220 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-01-29 19:15:59.645291 | controller | ok
2026-01-29 19:15:59.645476 | controller | ok: All items complete
2026-01-29 19:15:59.645506 | 
2026-01-29 19:15:59.995197 | controller | ok
2026-01-29 19:16:00.336649 | controller | ok
2026-01-29 19:16:00.349696 | 
2026-01-29 19:16:00.349795 | TASK [include_role : fetch-output-openshift]
2026-01-29 19:16:00.362759 | controller | skipping: Conditional result was False
2026-01-29 19:16:00.368506 | 
2026-01-29 19:16:00.368583 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-01-29 19:16:00.681202 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.005236
2026-01-29 19:16:00.857258 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006384
2026-01-29 19:16:00.890786 | 
2026-01-29 19:16:00.890875 | PLAY [all]
2026-01-29 19:16:00.903625 | 
2026-01-29 19:16:00.903695 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-01-29 19:16:01.255863 | controller | changed
2026-01-29 19:16:01.277060 | 
2026-01-29 19:16:01.277123 | PLAY RECAP
2026-01-29 19:16:01.277168 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2026-01-29 19:16:01.277189 | 
2026-01-29 19:16:01.343046 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2026-01-29 19:16:01.343784 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2026-01-29 19:16:01.854828 | 
2026-01-29 19:16:01.854925 | PLAY [localhost]
2026-01-29 19:16:01.870350 | 
2026-01-29 19:16:01.870417 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-01-29 19:16:02.160907 | localhost | changed
2026-01-29 19:16:02.165310 | 
2026-01-29 19:16:02.165386 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-01-29 19:16:02.183058 | localhost | ok
2026-01-29 19:16:02.190630 | 
2026-01-29 19:16:02.190697 | TASK [add-fileserver : Create SSH private key tempfile]
2026-01-29 19:16:02.470946 | localhost | changed
2026-01-29 19:16:02.476204 | 
2026-01-29 19:16:02.476288 | TASK [add-fileserver : Create SSH private key from secret]
2026-01-29 19:16:02.990638 | localhost | changed
2026-01-29 19:16:02.995352 | 
2026-01-29 19:16:02.995420 | TASK [add-fileserver : Add fileserver ssh key]
2026-01-29 19:16:03.316717 | localhost | Identity added: /var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/tmp/ansible.68li8mof (/var/lib/zuul/builds/2a559772576343628cb7ae79bbcf0d6c/work/tmp/ansible.68li8mof)
2026-01-29 19:16:03.316878 | localhost | ok: Runtime: 0:00:00.005710
2026-01-29 19:16:03.320990 | 
2026-01-29 19:16:03.321058 | TASK [add-fileserver : Remove SSH private key from disk]
2026-01-29 19:16:03.531277 | localhost | ok: Runtime: 0:00:00.004146
2026-01-29 19:16:03.535691 | 
2026-01-29 19:16:03.535758 | TASK [add-fileserver : Add fileserver to inventory]
2026-01-29 19:16:03.582733 | localhost | changed
2026-01-29 19:16:03.587439 | 
2026-01-29 19:16:03.587503 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-01-29 19:16:03.887586 | localhost | changed
2026-01-29 19:16:03.906020 | 
2026-01-29 19:16:03.906078 | PLAY [localhost]
2026-01-29 19:16:03.916826 | 
2026-01-29 19:16:03.916887 | TASK [Generate bulk log download script]
2026-01-29 19:16:03.934089 | localhost | ok
2026-01-29 19:16:03.944732 | 
2026-01-29 19:16:03.944796 | TASK [local-log-download : Check API endpoint is defined]
2026-01-29 19:16:03.971031 | localhost | ok: All assertions passed
2026-01-29 19:16:03.975219 | 
2026-01-29 19:16:03.975298 | TASK [local-log-download : Create download script]
2026-01-29 19:16:04.301624 | localhost -> localhost | changed
2026-01-29 19:16:04.309802 | 
2026-01-29 19:16:04.309866 | TASK [Register quick-download link]
2026-01-29 19:16:04.326016 | localhost | ok
2026-01-29 19:16:04.356595 | 
2026-01-29 19:16:04.356670 | PLAY [logserver.rdoproject.org]
2026-01-29 19:16:04.365475 | 
2026-01-29 19:16:04.365534 | TASK [Set zuul-log-path fact]
2026-01-29 19:16:04.380510 | logserver.rdoproject.org | ok
2026-01-29 19:16:04.388452 | 
2026-01-29 19:16:04.388520 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-01-29 19:16:04.403382 | logserver.rdoproject.org | ok
2026-01-29 19:16:04.408462 | 
2026-01-29 19:16:04.408524 | TASK [upload-logs : Create log directories]
2026-01-29 19:16:06.229364 | logserver.rdoproject.org | changed
2026-01-29 19:16:06.232349 | 
2026-01-29 19:16:06.232412 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-01-29 19:16:06.437826 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004712
2026-01-29 19:16:06.442751 | 
2026-01-29 19:16:06.442811 | TASK [upload-logs : Upload logs to log server]
2026-01-29 19:16:08.081664 | logserver.rdoproject.org | Output suppressed because no_log was given
2026-01-29 19:16:08.084690 | 
2026-01-29 19:16:08.084761 | LOOP [upload-logs : Compress console log and json output]
2026-01-29 19:16:08.123551 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-29 19:16:08.130263 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-29 19:16:08.141817 | 
2026-01-29 19:16:08.141907 | LOOP [upload-logs : Upload compressed console log and json output]
2026-01-29 19:16:08.176462 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-29 19:16:08.176699 | 
2026-01-29 19:16:08.179505 | logserver.rdoproject.org | skipping: Conditional result was False
2026-01-29 19:16:08.190554 | 
2026-01-29 19:16:08.190651 | LOOP [upload-logs : Upload console log and json output]