2025-10-14 07:00:33.633514 | Job console starting...
2025-10-14 07:00:33.876788 | Updating repositories
2025-10-14 07:00:33.908382 | Preparing job workspace
2025-10-14 07:00:42.499435 | Running Ansible setup...
2025-10-14 07:00:45.618749 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-14 07:00:46.246025 | 
2025-10-14 07:00:46.246564 | PLAY [localhost]
2025-10-14 07:00:46.257390 | 
2025-10-14 07:00:46.257504 | TASK [Gathering Facts]
2025-10-14 07:00:47.168766 | localhost | ok
2025-10-14 07:00:47.189221 | 
2025-10-14 07:00:47.189360 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-14 07:00:47.570277 | localhost -> localhost | changed
2025-10-14 07:00:47.576576 | 
2025-10-14 07:00:47.576657 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-14 07:00:48.425094 | localhost -> localhost | changed
2025-10-14 07:00:48.434541 | 
2025-10-14 07:00:48.434641 | TASK [Setup log path fact]
2025-10-14 07:00:48.453028 | localhost | ok
2025-10-14 07:00:48.465257 | 
2025-10-14 07:00:48.465330 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-14 07:00:48.492452 | localhost | ok
2025-10-14 07:00:48.500534 | 
2025-10-14 07:00:48.500620 | TASK [emit-job-header : Print job information]
2025-10-14 07:00:48.528987 | # Job Information
2025-10-14 07:00:48.529153 | Ansible Version: 2.15.12
2025-10-14 07:00:48.529183 | Job: cifmw-molecule-dlrn_promote
2025-10-14 07:00:48.529206 | Pipeline: github-check
2025-10-14 07:00:48.529227 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-14 07:00:48.529248 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237
2025-10-14 07:00:48.529268 | Log URL (when completed): https://logserver.rdoproject.org/75f/rdoproject.org/75f4865c001647798a89c41e1ff488e8/
2025-10-14 07:00:48.529288 | Event ID: c940b7c0-a8c9-11f0-80da-b48bf6033ab5
2025-10-14 07:00:48.532962 | 
2025-10-14 07:00:48.533036 | LOOP [emit-job-header : Print node information]
2025-10-14 07:00:48.633725 | localhost | ok:
2025-10-14 07:00:48.633890 | localhost | # Node Information
2025-10-14 07:00:48.633943 | localhost | Inventory Hostname: controller
2025-10-14 07:00:48.633974 | localhost | Hostname: np0005486899
2025-10-14 07:00:48.633995 | localhost | Username: zuul
2025-10-14 07:00:48.634016 | localhost | Distro: CentOS 9
2025-10-14 07:00:48.634033 | localhost | Provider: ibm-bm4-nodepool
2025-10-14 07:00:48.634050 | localhost | Region: regionOne
2025-10-14 07:00:48.634066 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-14 07:00:48.634081 | localhost | Product Name: OpenStack Compute
2025-10-14 07:00:48.634097 | localhost | Interface IP: 192.168.26.148
2025-10-14 07:00:48.663373 | 
2025-10-14 07:00:48.663520 | PLAY [all]
2025-10-14 07:00:48.671843 | 
2025-10-14 07:00:48.671930 | TASK [Gather network facts]
2025-10-14 07:00:49.047278 | controller | ok
2025-10-14 07:00:49.061959 | 
2025-10-14 07:00:49.062048 | TASK [include_role : start-zuul-console]
2025-10-14 07:00:49.081531 | controller | ok
2025-10-14 07:00:49.097211 | 
2025-10-14 07:00:49.097374 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-14 07:00:49.444007 | controller | ok
2025-10-14 07:00:49.452487 | 
2025-10-14 07:00:49.452570 | TASK [include_role : add-build-sshkey]
2025-10-14 07:00:49.470348 | controller | ok
2025-10-14 07:00:49.483235 | 
2025-10-14 07:00:49.483313 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-14 07:00:49.693700 | controller -> localhost | ok
2025-10-14 07:00:49.701409 | 
2025-10-14 07:00:49.701506 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-14 07:00:49.721115 | controller | ok
2025-10-14 07:00:49.734655 | controller | included: /var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-14 07:00:49.741346 | 
2025-10-14 07:00:49.741427 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-14 07:00:50.291377 | controller -> localhost | Generating public/private rsa key pair.
2025-10-14 07:00:50.291561 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/75f4865c001647798a89c41e1ff488e8_id_rsa.
2025-10-14 07:00:50.291596 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/75f4865c001647798a89c41e1ff488e8_id_rsa.pub.
2025-10-14 07:00:50.291621 | controller -> localhost | The key fingerprint is:
2025-10-14 07:00:50.291643 | controller -> localhost | SHA256:6AKaHCbMEz8xjJfGTmlYstjz0//Fj/8rjtfFOmzRKIQ zuul-build-sshkey
2025-10-14 07:00:50.291676 | controller -> localhost | The key's randomart image is:
2025-10-14 07:00:50.291699 | controller -> localhost | +---[RSA 3072]----+
2025-10-14 07:00:50.291720 | controller -> localhost | | . .             |
2025-10-14 07:00:50.291740 | controller -> localhost | |..O o            |
2025-10-14 07:00:50.291759 | controller -> localhost | |.=o%       .     |
2025-10-14 07:00:50.291778 | controller -> localhost | |o Ooo. .  E .    |
2025-10-14 07:00:50.291796 | controller -> localhost | |.*.+o o S  .   + |
2025-10-14 07:00:50.291814 | controller -> localhost | |+oo..o .   .. o +|
2025-10-14 07:00:50.291831 | controller -> localhost | |o.  . . .   oo.o.|
2025-10-14 07:00:50.292144 | controller -> localhost | |     .   . ..==. |
2025-10-14 07:00:50.292182 | controller -> localhost | |          ..++++o|
2025-10-14 07:00:50.292207 | controller -> localhost | +----[SHA256]-----+
2025-10-14 07:00:50.292266 | controller -> localhost | ok: Runtime: 0:00:00.155457
2025-10-14 07:00:50.298610 | 
2025-10-14 07:00:50.298685 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-14 07:00:50.317595 | controller | ok
2025-10-14 07:00:50.327817 | controller | included: /var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-14 07:00:50.336065 | 
2025-10-14 07:00:50.336140 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-14 07:00:50.350506 | controller | skipping: Conditional result was False
2025-10-14 07:00:50.357625 | 
2025-10-14 07:00:50.357736 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-14 07:00:50.744273 | controller | changed
2025-10-14 07:00:50.749347 | 
2025-10-14 07:00:50.749426 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-14 07:00:50.956276 | controller | ok
2025-10-14 07:00:50.962856 | 
2025-10-14 07:00:50.962985 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-14 07:00:51.553258 | controller | changed
2025-10-14 07:00:51.558555 | 
2025-10-14 07:00:51.558643 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-14 07:00:52.133785 | controller | changed
2025-10-14 07:00:52.139036 | 
2025-10-14 07:00:52.139108 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-14 07:00:52.153086 | controller | skipping: Conditional result was False
2025-10-14 07:00:52.159535 | 
2025-10-14 07:00:52.159613 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-14 07:00:52.580889 | controller -> localhost | changed
2025-10-14 07:00:52.591364 | 
2025-10-14 07:00:52.591447 | TASK [add-build-sshkey : Add back temp key]
2025-10-14 07:00:52.858572 | controller -> localhost | Identity added: /var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/75f4865c001647798a89c41e1ff488e8_id_rsa (zuul-build-sshkey)
2025-10-14 07:00:52.858773 | controller -> localhost | ok: Runtime: 0:00:00.016259
2025-10-14 07:00:52.864546 | 
2025-10-14 07:00:52.864712 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-14 07:00:53.222388 | controller | ok
2025-10-14 07:00:53.227519 | 
2025-10-14 07:00:53.227599 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-14 07:00:53.257270 | controller | skipping: Conditional result was False
2025-10-14 07:00:53.268687 | 
2025-10-14 07:00:53.268780 | TASK [include_role : validate-host]
2025-10-14 07:00:53.287186 | controller | ok
2025-10-14 07:00:53.309611 | 
2025-10-14 07:00:53.309827 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-14 07:00:53.348241 | controller | ok
2025-10-14 07:00:53.353511 | 
2025-10-14 07:00:53.353594 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-14 07:00:53.662200 | controller -> localhost | ok
2025-10-14 07:00:53.668219 | 
2025-10-14 07:00:53.668294 | TASK [validate-host : Collect information about the host]
2025-10-14 07:00:54.295774 | controller | ok
2025-10-14 07:00:54.364143 | 
2025-10-14 07:00:54.364242 | TASK [validate-host : Sanitize hostname]
2025-10-14 07:00:54.428443 | controller | ok
2025-10-14 07:00:54.440545 | 
2025-10-14 07:00:54.440690 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-14 07:00:54.911452 | controller -> localhost | changed
2025-10-14 07:00:54.917063 | 
2025-10-14 07:00:54.917156 | TASK [validate-host : Collect information about zuul worker]
2025-10-14 07:00:55.302396 | controller | ok
2025-10-14 07:00:55.307051 | 
2025-10-14 07:00:55.307130 | TASK [validate-host : Write out all zuul information for each host]
2025-10-14 07:00:55.778040 | controller -> localhost | changed
2025-10-14 07:00:55.789075 | 
2025-10-14 07:00:55.789174 | TASK [include_role : prepare-workspace-openshift]
2025-10-14 07:00:55.827616 | controller | skipping: Conditional result was False
2025-10-14 07:00:55.832960 | 
2025-10-14 07:00:55.833037 | TASK [include_role : remove-zuul-sshkey]
2025-10-14 07:00:55.867510 | controller | skipping: Conditional result was False
2025-10-14 07:00:55.874550 | 
2025-10-14 07:00:55.874646 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-14 07:00:56.120424 | controller | ok: "logs"
2025-10-14 07:00:56.120672 | controller | ok: All items complete
2025-10-14 07:00:56.120708 | 
2025-10-14 07:00:56.318024 | controller | ok: "artifacts"
2025-10-14 07:00:56.503471 | controller | ok: "docs"
2025-10-14 07:00:56.519320 | 
2025-10-14 07:00:56.519435 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-14 07:00:56.759770 | controller | changed: "logs"
2025-10-14 07:00:56.929456 | controller | changed: "artifacts"
2025-10-14 07:00:57.094815 | controller | changed: "docs"
2025-10-14 07:00:57.123158 | 
2025-10-14 07:00:57.123240 | PLAY RECAP
2025-10-14 07:00:57.123285 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-14 07:00:57.123313 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-14 07:00:57.123332 | 
2025-10-14 07:00:57.202358 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-14 07:00:57.203174 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-14 07:00:58.094385 | 
2025-10-14 07:00:58.094501 | PLAY [all]
2025-10-14 07:00:58.117414 | 
2025-10-14 07:00:58.117593 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-14 07:00:58.186892 | controller | ok
2025-10-14 07:00:58.192339 | 
2025-10-14 07:00:58.192446 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-14 07:00:58.656996 | controller | changed
2025-10-14 07:00:58.663567 | 
2025-10-14 07:00:58.663674 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-14 07:00:59.679977 | controller | changed
2025-10-14 07:00:59.691179 | 
2025-10-14 07:00:59.692264 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-14 07:01:00.075429 | controller | changed:
2025-10-14 07:01:00.075588 | controller | {
2025-10-14 07:01:00.075619 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-14 07:01:00.075663 | controller | }
2025-10-14 07:01:00.293288 | controller | changed:
2025-10-14 07:01:00.293378 | controller | {
2025-10-14 07:01:00.293408 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-14 07:01:00.293431 | controller | }
2025-10-14 07:01:00.504296 | controller | changed:
2025-10-14 07:01:00.508383 | controller | {
2025-10-14 07:01:00.508419 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-14 07:01:00.508444 | controller | }
2025-10-14 07:01:00.713522 | controller | changed:
2025-10-14 07:01:00.713607 | controller | {
2025-10-14 07:01:00.713636 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-14 07:01:00.713673 | controller | }
2025-10-14 07:01:00.935892 | controller | changed:
2025-10-14 07:01:00.935993 | controller | {
2025-10-14 07:01:00.936022 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-14 07:01:00.936045 | controller | }
2025-10-14 07:01:01.158985 | controller | changed:
2025-10-14 07:01:01.159068 | controller | {
2025-10-14 07:01:01.159098 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-14 07:01:01.159122 | controller | }
2025-10-14 07:01:01.381014 | controller | changed:
2025-10-14 07:01:01.381116 | controller | {
2025-10-14 07:01:01.381145 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-10-14 07:01:01.381168 | controller | }
2025-10-14 07:01:01.608265 | controller | changed:
2025-10-14 07:01:01.608349 | controller | {
2025-10-14 07:01:01.608378 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-10-14 07:01:01.608401 | controller | }
2025-10-14 07:01:01.854481 | controller | changed:
2025-10-14 07:01:01.854575 | controller | {
2025-10-14 07:01:01.854605 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-14 07:01:01.854628 | controller | }
2025-10-14 07:01:02.071220 | controller | changed:
2025-10-14 07:01:02.071324 | controller | {
2025-10-14 07:01:02.071352 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-14 07:01:02.071373 | controller | }
2025-10-14 07:01:02.342211 | controller | changed:
2025-10-14 07:01:02.342283 | controller | {
2025-10-14 07:01:02.342312 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-14 07:01:02.342333 | controller | }
2025-10-14 07:01:02.517408 | controller | changed:
2025-10-14 07:01:02.517489 | controller | {
2025-10-14 07:01:02.517517 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-14 07:01:02.517540 | controller | }
2025-10-14 07:01:02.736230 | controller | changed:
2025-10-14 07:01:02.736308 | controller | {
2025-10-14 07:01:02.736335 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-14 07:01:02.736358 | controller | }
2025-10-14 07:01:02.968364 | controller | changed:
2025-10-14 07:01:02.968438 | controller | {
2025-10-14 07:01:02.968465 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-14 07:01:02.968486 | controller | }
2025-10-14 07:01:03.217453 | controller | changed:
2025-10-14 07:01:03.217532 | controller | {
2025-10-14 07:01:03.217559 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-14 07:01:03.217581 | controller | }
2025-10-14 07:01:03.449776 | controller | changed:
2025-10-14 07:01:03.449863 | controller | {
2025-10-14 07:01:03.449890 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-14 07:01:03.449929 | controller | }
2025-10-14 07:01:03.687035 | controller | changed:
2025-10-14 07:01:03.687179 | controller | {
2025-10-14 07:01:03.687242 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-10-14 07:01:03.687272 | controller | }
2025-10-14 07:01:03.921292 | controller | changed:
2025-10-14 07:01:03.921376 | controller | {
2025-10-14 07:01:03.921404 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-10-14 07:01:03.921433 | controller | }
2025-10-14 07:01:04.142232 | controller | changed:
2025-10-14 07:01:04.142319 | controller | {
2025-10-14 07:01:04.142345 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-14 07:01:04.142366 | controller | }
2025-10-14 07:01:04.383260 | controller | changed:
2025-10-14 07:01:04.383350 | controller | {
2025-10-14 07:01:04.383378 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-14 07:01:04.383400 | controller | }
2025-10-14 07:01:04.616312 | controller | changed:
2025-10-14 07:01:04.616409 | controller | {
2025-10-14 07:01:04.616436 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-14 07:01:04.616457 | controller | }
2025-10-14 07:01:04.859344 | controller | changed:
2025-10-14 07:01:04.859424 | controller | {
2025-10-14 07:01:04.859452 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-14 07:01:04.859473 | controller | }
2025-10-14 07:01:05.084109 | controller | changed:
2025-10-14 07:01:05.084196 | controller | {
2025-10-14 07:01:05.084224 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-10-14 07:01:05.084248 | controller | }
2025-10-14 07:01:05.323871 | controller | changed:
2025-10-14 07:01:05.323986 | controller | {
2025-10-14 07:01:05.324016 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-14 07:01:05.324038 | controller | }
2025-10-14 07:01:05.548573 | controller | changed:
2025-10-14 07:01:05.548672 | controller | {
2025-10-14 07:01:05.548702 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-14 07:01:05.548726 | controller | }
2025-10-14 07:01:05.771955 | controller | changed:
2025-10-14 07:01:05.772046 | controller | {
2025-10-14 07:01:05.772074 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-14 07:01:05.772095 | controller | }
2025-10-14 07:01:05.797975 | 
2025-10-14 07:01:05.798091 | TASK [Set timezone to UTC]
2025-10-14 07:01:06.325535 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-14 07:01:06.331099 | 
2025-10-14 07:01:06.331170 | TASK [Create nodepool directory]
2025-10-14 07:01:06.553267 | controller | changed
2025-10-14 07:01:06.558968 | 
2025-10-14 07:01:06.559051 | TASK [Create nodepool sub_nodes file]
2025-10-14 07:01:07.154482 | controller | changed
2025-10-14 07:01:07.162075 | 
2025-10-14 07:01:07.162145 | TASK [Create nodepool sub_nodes_private file]
2025-10-14 07:01:07.800253 | controller | changed
2025-10-14 07:01:07.805713 | 
2025-10-14 07:01:07.805824 | LOOP [Populate nodepool sub_nodes file]
2025-10-14 07:01:07.836674 | 
2025-10-14 07:01:07.836823 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-14 07:01:07.876227 | 
2025-10-14 07:01:07.876371 | TASK [Create nodepool primary file]
2025-10-14 07:01:07.920592 | controller | skipping: Conditional result was False
2025-10-14 07:01:07.926178 | 
2025-10-14 07:01:07.926256 | TASK [Create nodepool node_private for this node]
2025-10-14 07:01:08.569964 | controller | changed
2025-10-14 07:01:08.575156 | 
2025-10-14 07:01:08.575225 | LOOP [Copy ssh keys to nodepool directory]
2025-10-14 07:01:08.936310 | controller | ok: Item: id_rsa Runtime: 0:00:00.006456
2025-10-14 07:01:08.936487 | 
2025-10-14 07:01:09.135037 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.008482
2025-10-14 07:01:09.144588 | 
2025-10-14 07:01:09.144711 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-14 07:01:09.791561 | controller | changed
2025-10-14 07:01:09.806792 | 
2025-10-14 07:01:09.806903 | TASK [Validate sudoers config after edits]
2025-10-14 07:01:10.091097 | controller | /etc/sudoers: parsed OK
2025-10-14 07:01:10.091181 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-14 07:01:10.091195 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-14 07:01:10.091247 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-14 07:01:10.339043 | controller | ok: Runtime: 0:00:00.007057
2025-10-14 07:01:10.353006 | 
2025-10-14 07:01:10.353302 | TASK [Show the environment passed in to job shell scripts]
2025-10-14 07:01:10.595303 | controller | SHELL=/bin/bash
2025-10-14 07:01:10.595422 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-14 07:01:10.595435 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-14 07:01:10.595443 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/04/3404/9f142a3066b32ef704ae4f0d5fc5f7189e41a1f8^openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/2f8c81ac66bb5746ceb3bd299e433353061ca719
2025-10-14 07:01:10.595453 | controller | PWD=/home/zuul
2025-10-14 07:01:10.595459 | controller | ZUUL_PIPELINE=github-check
2025-10-14 07:01:10.595465 | controller | LOGNAME=zuul
2025-10-14 07:01:10.595471 | controller | XDG_SESSION_TYPE=tty
2025-10-14 07:01:10.595476 | controller | _=/usr/bin/env
2025-10-14 07:01:10.595482 | controller | MOTD_SHOWN=pam
2025-10-14 07:01:10.595487 | controller | HOME=/home/zuul
2025-10-14 07:01:10.595492 | controller | LANG=en_US.UTF-8
2025-10-14 07:01:10.595498 | controller | SSH_CONNECTION=192.168.26.12 53328 192.168.26.148 22
2025-10-14 07:01:10.595505 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-10-14 07:01:10.595511 | controller | ZUUL_CHANGE_IDS=3404,9f142a3066b32ef704ae4f0d5fc5f7189e41a1f8 3237,2f8c81ac66bb5746ceb3bd299e433353061ca719
2025-10-14 07:01:10.595517 | controller | WORKSPACE=/home/zuul/workspace
2025-10-14 07:01:10.595523 | controller | XDG_SESSION_CLASS=user
2025-10-14 07:01:10.595529 | controller | SELINUX_ROLE_REQUESTED=
2025-10-14 07:01:10.595534 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-14 07:01:10.595540 | controller | USER=zuul
2025-10-14 07:01:10.595546 | controller | ZUUL_VOTING=True
2025-10-14 07:01:10.595551 | controller | BUILD_TIMEOUT=1800000
2025-10-14 07:01:10.595556 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-14 07:01:10.595562 | controller | SHLVL=1
2025-10-14 07:01:10.595568 | controller | ZUUL_PATCHSET=2f8c81ac66bb5746ceb3bd299e433353061ca719
2025-10-14 07:01:10.595573 | controller | XDG_SESSION_ID=1
2025-10-14 07:01:10.595579 | controller | ZUUL_BRANCH=main
2025-10-14 07:01:10.595584 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-14 07:01:10.595590 | controller | SSH_CLIENT=192.168.26.12 53328 22
2025-10-14 07:01:10.595595 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-14 07:01:10.595601 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-14 07:01:10.595606 | controller | which_declare=declare -f
2025-10-14 07:01:10.595613 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-14 07:01:10.595620 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-14 07:01:10.595625 | controller | ZUUL_CHANGE=3237
2025-10-14 07:01:10.595631 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-14 07:01:10.595637 | controller | ZUUL_UUID=75f4865c001647798a89c41e1ff488e8
2025-10-14 07:01:10.595643 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-14 07:01:10.595648 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-14 07:01:10.595654 | controller | }
2025-10-14 07:01:10.890891 | controller | ok: Runtime: 0:00:00.007419
2025-10-14 07:01:10.896608 | 
2025-10-14 07:01:10.896708 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-14 07:01:10.921341 | controller | skipping: Conditional result was False
2025-10-14 07:01:10.927505 | 
2025-10-14 07:01:10.927590 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-14 07:01:11.485265 | controller | skipping: Conditional result was False
2025-10-14 07:01:11.491273 | 
2025-10-14 07:01:11.491342 | TASK [Ensure legacy workspace directory]
2025-10-14 07:01:11.681809 | controller | changed
2025-10-14 07:01:11.701179 | 
2025-10-14 07:01:11.701242 | PLAY RECAP
2025-10-14 07:01:11.701288 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-14 07:01:11.701311 | 
2025-10-14 07:01:11.781562 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-14 07:01:11.782385 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-14 07:01:12.364996 | 
2025-10-14 07:01:12.365103 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-14 07:01:12.398219 | 
2025-10-14 07:01:12.398322 | TASK [Create zuul-output directory]
2025-10-14 07:01:12.763567 | controller | changed
2025-10-14 07:01:12.769666 | 
2025-10-14 07:01:12.769780 | TASK [Slurp Zuul inventory test]
2025-10-14 07:01:13.073318 | controller -> localhost | ok
2025-10-14 07:01:13.080201 | 
2025-10-14 07:01:13.080273 | TASK [Save zuul inventory]
2025-10-14 07:01:13.880435 | controller | changed
2025-10-14 07:01:13.885927 | 
2025-10-14 07:01:13.886013 | TASK [Save zuul vars without the change_message]
2025-10-14 07:01:14.544328 | controller | changed
2025-10-14 07:01:14.573149 | 
2025-10-14 07:01:14.573262 | PLAY RECAP
2025-10-14 07:01:14.573312 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-14 07:01:14.573336 | 
2025-10-14 07:01:14.682271 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-14 07:01:14.683027 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-14 07:01:15.543203 | 
2025-10-14 07:01:15.543464 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-14 07:01:15.565794 | 
2025-10-14 07:01:15.565894 | TASK [Read group_vars]
2025-10-14 07:01:15.584583 | controller | ok
2025-10-14 07:01:15.604657 | 
2025-10-14 07:01:15.604828 | TASK [cifmw_helpers : Check directory is available]
2025-10-14 07:01:15.931585 | controller | ok
2025-10-14 07:01:15.936972 | 
2025-10-14 07:01:15.937041 | TASK [cifmw_helpers : Print var]
2025-10-14 07:01:15.955605 | controller | ok:
2025-10-14 07:01:15.955738 | controller | provide_var is /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars
2025-10-14 07:01:15.955977 | controller |  and registered one is {'changed': False, 'stat': {'exists': False}, 'failed': False}
2025-10-14 07:01:15.961074 | 
2025-10-14 07:01:15.961206 | TASK [cifmw_helpers : List dir in ansible user home]
2025-10-14 07:01:16.326445 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-14 07:01:16.327769 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-14 07:01:16.329038 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied
2025-10-14 07:01:16.330278 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-14 07:01:16.504423 | controller | ERROR
2025-10-14 07:01:16.504556 | controller | {
2025-10-14 07:01:16.504589 | controller |   "delta": "0:00:00.009304",
2025-10-14 07:01:16.504616 | controller |   "end": "2025-10-14 07:01:16.330606",
2025-10-14 07:01:16.504652 | controller |   "msg": "non-zero return code",
2025-10-14 07:01:16.504672 | controller |   "rc": 2,
2025-10-14 07:01:16.504690 | controller |   "start": "2025-10-14 07:01:16.321302"
2025-10-14 07:01:16.504708 | controller | }
2025-10-14 07:01:16.504734 | controller | ERROR: Ignoring Errors
2025-10-14 07:01:16.513585 | 
2025-10-14 07:01:16.513668 | TASK [cifmw_helpers : Find yaml files]
2025-10-14 07:01:16.527841 | controller | skipping: Conditional result was False
2025-10-14 07:01:16.533590 | 
2025-10-14 07:01:16.533677 | TASK [cifmw_helpers : Print available yaml files]
2025-10-14 07:01:16.547111 | controller | skipping: Conditional result was False
2025-10-14 07:01:16.554462 | 
2025-10-14 07:01:16.554568 | LOOP [cifmw_helpers : Read vars]
2025-10-14 07:01:16.573451 | 
2025-10-14 07:01:16.573579 | LOOP [cifmw_helpers : Call task to parse all files as fact]
2025-10-14 07:01:16.606686 | 
2025-10-14 07:01:16.606813 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-14 07:01:16.626327 | controller | ok
2025-10-14 07:01:16.647600 | 
2025-10-14 07:01:16.647681 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-14 07:01:16.701442 | controller | skipping: Conditional result was False
2025-10-14 07:01:16.728246 | 
2025-10-14 07:01:16.728327 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-14 07:01:17.039461 | controller | ok
2025-10-14 07:01:17.044840 | 
2025-10-14 07:01:17.044927 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-14 07:01:17.562926 | controller | ok
2025-10-14 07:01:17.573282 | 
2025-10-14 07:01:17.573347 | TASK [Prepare workspace]
2025-10-14 07:01:17.592883 | controller | ok
2025-10-14 07:01:17.615557 | 
2025-10-14 07:01:17.615648 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-14 07:01:17.897276 | controller | ok
2025-10-14 07:01:17.903993 | 
2025-10-14 07:01:17.904067 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-14 07:01:20.637731 | controller | Output suppressed because no_log was given
2025-10-14 07:01:20.649493 | 
2025-10-14 07:01:20.649602 | LOOP [Create zuul-output directory]
2025-10-14 07:01:20.869667 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-14 07:01:20.869896 | 
2025-10-14 07:01:21.041046 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-14 07:01:21.056581 | 
2025-10-14 07:01:21.056696 | TASK [Install required packages]
2025-10-14 07:02:47.362970 | controller | changed
2025-10-14 07:02:47.367737 | 
2025-10-14 07:02:47.367798 | TASK [Install venv]
2025-10-14 07:03:53.911672 | controller | changed
2025-10-14 07:03:53.937572 | 
2025-10-14 07:03:53.937655 | PLAY RECAP
2025-10-14 07:03:53.937701 | controller | ok: 10 changed: 5 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 1
2025-10-14 07:03:53.937724 | 
2025-10-14 07:03:54.028947 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-14 07:03:54.029748 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-14 07:03:54.583252 | 
2025-10-14 07:03:54.583367 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-14 07:03:54.604437 | 
2025-10-14 07:03:54.604567 | TASK [Gather required facts]
2025-10-14 07:03:55.110942 | controller | ok
2025-10-14 07:03:55.116324 | 
2025-10-14 07:03:55.116419 | TASK [Load environment var if instructed to]
2025-10-14 07:03:55.140225 | controller | skipping: Conditional result was False
2025-10-14 07:03:55.145481 | 
2025-10-14 07:03:55.145550 | TASK [Ensure group_vars dir exists]
2025-10-14 07:03:55.447103 | controller | ok
2025-10-14 07:03:55.453288 | 
2025-10-14 07:03:55.453361 | TASK [Run molecule]
2025-10-14 07:03:56.405039 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-14 07:03:56.541231 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-14 07:04:15.020558 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.020988 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.021463 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.021920 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.022404 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+2ef920f0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.0.0+2ef920f0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.022843 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.023311 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.023746 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.024209 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.024649 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.025111 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.025561 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.026009 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.026475 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.026930 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:04:15.036847 | controller | INFO     Running check_criteria > prepare
2025-10-14 07:04:15.726524 | controller |
2025-10-14 07:04:15.726582 | controller | PLAY [Prepare] *****************************************************************
2025-10-14 07:04:15.726684 | controller |
2025-10-14 07:04:15.726789 | controller | TASK [Gathering Facts] *********************************************************
2025-10-14 07:04:15.726901 | controller | Tuesday 14 October 2025  07:04:15 +0000 (0:00:00.013)       0:00:00.013 *******
2025-10-14 07:04:16.560674 | controller | ok: [instance]
2025-10-14 07:04:16.560725 | controller |
2025-10-14 07:04:16.560818 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2025-10-14 07:04:16.560948 | controller | Tuesday 14 October 2025  07:04:16 +0000 (0:00:00.834)       0:00:00.848 *******
2025-10-14 07:04:16.577790 | controller | skipping: [instance]
2025-10-14 07:04:16.577891 | controller |
2025-10-14 07:04:16.578003 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2025-10-14 07:04:16.578109 | controller | Tuesday 14 October 2025  07:04:16 +0000 (0:00:00.017)       0:00:00.865 *******
2025-10-14 07:04:16.619359 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2025-10-14 07:04:16.619417 | controller |
2025-10-14 07:04:16.619555 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2025-10-14 07:04:16.619681 | controller | Tuesday 14 October 2025  07:04:16 +0000 (0:00:00.041)       0:00:00.907 *******
2025-10-14 07:04:16.897829 | controller | ok: [instance]
2025-10-14 07:04:16.897910 | controller |
2025-10-14 07:04:16.898021 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2025-10-14 07:04:16.898126 | controller | Tuesday 14 October 2025  07:04:16 +0000 (0:00:00.278)       0:00:01.185 *******
2025-10-14 07:04:17.206913 | controller | ok: [instance]
2025-10-14 07:04:17.207001 | controller |
2025-10-14 07:04:17.207120 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2025-10-14 07:04:17.207264 | controller | Tuesday 14 October 2025  07:04:17 +0000 (0:00:00.309)       0:00:01.494 *******
2025-10-14 07:04:17.912061 | controller | ok: [instance] => (item=ubi-9-appstream)
2025-10-14 07:04:17.912147 | controller | ok: [instance] => (item=ubi-9-baseos)
2025-10-14 07:04:17.912387 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2025-10-14 07:04:17.912490 | controller |
2025-10-14 07:04:17.912595 | controller | TASK [Deploy repo-setup] *******************************************************
2025-10-14 07:04:17.912702 | controller | Tuesday 14 October 2025  07:04:17 +0000 (0:00:00.705)       0:00:02.199 *******
2025-10-14 07:04:17.972445 | controller |
2025-10-14 07:04:17.972562 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-10-14 07:04:17.972687 | controller | Tuesday 14 October 2025  07:04:17 +0000 (0:00:00.060)       0:00:02.260 *******
2025-10-14 07:04:18.524660 | controller | changed: [instance] => (item=tmp)
2025-10-14 07:04:18.524754 | controller | changed: [instance] => (item=artifacts/repositories)
2025-10-14 07:04:18.524877 | controller | changed: [instance] => (item=venv/repo_setup)
2025-10-14 07:04:18.524978 | controller |
2025-10-14 07:04:18.525082 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-10-14 07:04:18.525208 | controller | Tuesday 14 October 2025  07:04:18 +0000 (0:00:00.552)       0:00:02.812 *******
2025-10-14 07:04:19.315500 | controller | ok: [instance]
2025-10-14 07:04:19.315847 | controller |
2025-10-14 07:04:20.486417 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-10-14 07:04:20.486451 | controller | Tuesday 14 October 2025  07:04:19 +0000 (0:00:00.790)       0:00:03.603 *******
2025-10-14 07:04:20.486463 | controller | changed: [instance]
2025-10-14 07:04:28.485382 | controller |
2025-10-14 07:04:28.485422 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-10-14 07:04:28.485433 | controller | Tuesday 14 October 2025  07:04:20 +0000 (0:00:01.170)       0:00:04.773 *******
2025-10-14 07:04:28.485444 | controller | changed: [instance]
2025-10-14 07:04:29.193674 | controller |
2025-10-14 07:04:29.193717 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-10-14 07:04:29.193726 | controller | Tuesday 14 October 2025  07:04:28 +0000 (0:00:07.998)       0:00:12.772 *******
2025-10-14 07:04:29.193737 | controller | changed: [instance]
2025-10-14 07:04:29.214681 | controller |
2025-10-14 07:04:29.214709 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-10-14 07:04:29.214717 | controller | Tuesday 14 October 2025  07:04:29 +0000 (0:00:00.708)       0:00:13.481 *******
2025-10-14 07:04:29.214726 | controller | skipping: [instance]
2025-10-14 07:04:30.058249 | controller |
2025-10-14 07:04:30.058286 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-10-14 07:04:30.058295 | controller | Tuesday 14 October 2025  07:04:29 +0000 (0:00:00.021)       0:00:13.502 *******
2025-10-14 07:04:30.058305 | controller | changed: [instance]
2025-10-14 07:04:30.092253 | controller |
2025-10-14 07:04:30.092301 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-10-14 07:04:30.092309 | controller | Tuesday 14 October 2025  07:04:30 +0000 (0:00:00.843)       0:00:14.345 *******
2025-10-14 07:04:30.092320 | controller | skipping: [instance]
2025-10-14 07:04:30.126179 | controller |
2025-10-14 07:04:30.126211 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-10-14 07:04:30.126220 | controller | Tuesday 14 October 2025  07:04:30 +0000 (0:00:00.034)       0:00:14.379 *******
2025-10-14 07:04:30.126232 | controller | skipping: [instance]
2025-10-14 07:04:30.159485 | controller |
2025-10-14 07:04:30.159524 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-10-14 07:04:30.159533 | controller | Tuesday 14 October 2025  07:04:30 +0000 (0:00:00.033)       0:00:14.413 *******
2025-10-14 07:04:30.159543 | controller | skipping: [instance]
2025-10-14 07:04:30.159731 | controller |
2025-10-14 07:04:30.159916 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-10-14 07:04:30.160073 | controller | Tuesday 14 October 2025  07:04:30 +0000 (0:00:00.033)       0:00:14.447 *******
2025-10-14 07:04:30.718986 | controller | changed: [instance]
2025-10-14 07:04:31.165910 | controller |
2025-10-14 07:04:31.165943 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-10-14 07:04:31.165952 | controller | Tuesday 14 October 2025  07:04:30 +0000 (0:00:00.559)       0:00:15.006 *******
2025-10-14 07:04:31.165962 | controller | changed: [instance]
2025-10-14 07:04:31.194038 | controller |
2025-10-14 07:04:31.194060 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-10-14 07:04:31.194067 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.446)       0:00:15.453 *******
2025-10-14 07:04:31.194076 | controller | skipping: [instance]
2025-10-14 07:04:31.222844 | controller |
2025-10-14 07:04:31.222868 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-10-14 07:04:31.222875 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.028)       0:00:15.481 *******
2025-10-14 07:04:31.222889 | controller | skipping: [instance]
2025-10-14 07:04:31.252820 | controller |
2025-10-14 07:04:31.252879 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-10-14 07:04:31.252888 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.028)       0:00:15.510 *******
2025-10-14 07:04:31.252898 | controller | skipping: [instance]
2025-10-14 07:04:31.292663 | controller |
2025-10-14 07:04:31.292699 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-10-14 07:04:31.292708 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.029)       0:00:15.540 *******
2025-10-14 07:04:31.292718 | controller | ok: [instance]
2025-10-14 07:04:31.320554 | controller |
2025-10-14 07:04:31.320579 | controller | TASK [repo_setup : Create download directory] **********************************
2025-10-14 07:04:31.320586 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.039)       0:00:15.579 *******
2025-10-14 07:04:31.320595 | controller | skipping: [instance]
2025-10-14 07:04:31.320737 | controller |
2025-10-14 07:04:31.320910 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-10-14 07:04:31.321052 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.028)       0:00:15.608 *******
2025-10-14 07:04:31.348247 | controller | skipping: [instance]
2025-10-14 07:04:31.348412 | controller |
2025-10-14 07:04:31.348557 | controller | TASK [Download the RPM] ********************************************************
2025-10-14 07:04:31.348700 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.027)       0:00:15.636 *******
2025-10-14 07:04:31.376127 | controller | skipping: [instance]
2025-10-14 07:04:31.376303 | controller |
2025-10-14 07:04:31.376453 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-10-14 07:04:31.376608 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.027)       0:00:15.663 *******
2025-10-14 07:04:31.403932 | controller | skipping: [instance]
2025-10-14 07:04:31.431218 | controller |
2025-10-14 07:04:31.431244 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-10-14 07:04:31.431252 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.027)       0:00:15.691 *******
2025-10-14 07:04:31.431262 | controller | skipping: [instance]
2025-10-14 07:04:31.431487 | controller |
2025-10-14 07:04:31.431501 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-10-14 07:04:31.460244 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.027)       0:00:15.718 *******
2025-10-14 07:04:31.460281 | controller | skipping: [instance]
2025-10-14 07:04:31.460309 | controller |
2025-10-14 07:04:31.460545 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-10-14 07:04:31.486596 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.029)       0:00:15.748 *******
2025-10-14 07:04:31.486626 | controller | skipping: [instance]
2025-10-14 07:04:31.677269 | controller |
2025-10-14 07:04:31.677304 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-10-14 07:04:31.677313 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.026)       0:00:15.774 *******
2025-10-14 07:04:31.677323 | controller | ok: [instance]
2025-10-14 07:04:31.677348 | controller |
2025-10-14 07:04:31.677357 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-10-14 07:04:31.677512 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.190)       0:00:15.964 *******
2025-10-14 07:04:31.919543 | controller | changed: [instance]
2025-10-14 07:04:32.151454 | controller |
2025-10-14 07:04:32.151491 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-10-14 07:04:32.151499 | controller | Tuesday 14 October 2025  07:04:31 +0000 (0:00:00.242)       0:00:16.206 *******
2025-10-14 07:04:32.151509 | controller | changed: [instance]
2025-10-14 07:04:32.173123 | controller |
2025-10-14 07:04:32.173181 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-10-14 07:04:32.173194 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.231)       0:00:16.438 *******
2025-10-14 07:04:32.173206 | controller | skipping: [instance]
2025-10-14 07:04:32.196391 | controller |
2025-10-14 07:04:32.196422 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-10-14 07:04:32.196431 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.021)       0:00:16.460 *******
2025-10-14 07:04:32.196440 | controller | skipping: [instance]
2025-10-14 07:04:32.218622 | controller |
2025-10-14 07:04:32.218645 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-10-14 07:04:32.218653 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.023)       0:00:16.483 *******
2025-10-14 07:04:32.218662 | controller | skipping: [instance]
2025-10-14 07:04:32.241006 | controller |
2025-10-14 07:04:32.241037 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-10-14 07:04:32.241045 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.022)       0:00:16.506 *******
2025-10-14 07:04:32.241055 | controller | skipping: [instance]
2025-10-14 07:04:32.241229 | controller |
2025-10-14 07:04:32.241384 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-10-14 07:04:32.241532 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.022)       0:00:16.528 *******
2025-10-14 07:04:32.265241 | controller | skipping: [instance]
2025-10-14 07:04:32.265278 | controller |
2025-10-14 07:04:32.265286 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-10-14 07:04:32.265304 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.023)       0:00:16.552 *******
2025-10-14 07:04:32.288514 | controller | skipping: [instance]
2025-10-14 07:04:32.305335 | controller |
2025-10-14 07:04:32.305360 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-10-14 07:04:32.305369 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.023)       0:00:16.575 *******
2025-10-14 07:04:32.305378 | controller | skipping: [instance]
2025-10-14 07:04:32.335106 | controller |
2025-10-14 07:04:32.335134 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-10-14 07:04:32.335143 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.017)       0:00:16.593 *******
2025-10-14 07:04:32.335175 | controller | skipping: [instance]
2025-10-14 07:04:32.351952 | controller |
2025-10-14 07:04:32.351976 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-10-14 07:04:32.351984 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.029)       0:00:16.622 *******
2025-10-14 07:04:32.351995 | controller | skipping: [instance]
2025-10-14 07:04:32.352196 | controller |
2025-10-14 07:04:32.352384 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-10-14 07:04:32.352563 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.017)       0:00:16.639 *******
2025-10-14 07:04:32.372847 | controller | skipping: [instance]
2025-10-14 07:04:32.373037 | controller |
2025-10-14 07:04:32.373243 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2025-10-14 07:04:32.373416 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.020)       0:00:16.660 *******
2025-10-14 07:04:32.403097 | controller | skipping: [instance]
2025-10-14 07:04:32.403317 | controller |
2025-10-14 07:04:32.403494 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2025-10-14 07:04:32.403659 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.030)       0:00:16.690 *******
2025-10-14 07:04:32.433179 | controller | skipping: [instance]
2025-10-14 07:04:32.433365 | controller |
2025-10-14 07:04:32.433537 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2025-10-14 07:04:32.433702 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.030)       0:00:16.721 *******
2025-10-14 07:04:32.463184 | controller | skipping: [instance]
2025-10-14 07:04:32.463379 | controller |
2025-10-14 07:04:32.463553 | controller | TASK [test_deps : Install additional packages] *********************************
2025-10-14 07:04:32.463716 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.029)       0:00:16.751 *******
2025-10-14 07:04:32.492593 | controller | skipping: [instance]
2025-10-14 07:04:32.492790 | controller |
2025-10-14 07:04:32.492962 | controller | TASK [test_deps : Install selinux python libs] *********************************
2025-10-14 07:04:32.493121 | controller | Tuesday 14 October 2025  07:04:32 +0000 (0:00:00.029)       0:00:16.780 *******
2025-10-14 07:05:18.023898 | controller | ok: [instance]
2025-10-14 07:05:18.024107 | controller |
2025-10-14 07:05:18.024298 | controller | TASK [test_deps : Install python yaml libs] ************************************
2025-10-14 07:05:18.024450 | controller | Tuesday 14 October 2025  07:05:18 +0000 (0:00:45.527)       0:01:02.308 *******
2025-10-14 07:05:19.196196 | controller | ok: [instance]
2025-10-14 07:05:19.227121 | controller |
2025-10-14 07:05:19.227147 | controller | TASK [test_deps : Install extra packages] **************************************
2025-10-14 07:05:19.227180 | controller | Tuesday 14 October 2025  07:05:19 +0000 (0:00:01.175)       0:01:03.483 *******
2025-10-14 07:05:19.227190 | controller | skipping: [instance]
2025-10-14 07:05:32.180268 | controller |
2025-10-14 07:05:32.180302 | controller | TASK [Get the zuul/zuul-jobs repo] *********************************************
2025-10-14 07:05:32.180312 | controller | Tuesday 14 October 2025  07:05:19 +0000 (0:00:00.031)       0:01:03.514 *******
2025-10-14 07:05:32.180324 | controller | changed: [instance]
2025-10-14 07:05:32.180353 | controller |
2025-10-14 07:05:32.180361 | controller | PLAY RECAP *********************************************************************
2025-10-14 07:05:32.180368 | controller | instance                   : ok=20   changed=10   unreachable=0    failed=0    skipped=30   rescued=0    ignored=0
2025-10-14 07:05:32.180382 | controller |
2025-10-14 07:05:32.180389 | controller | Tuesday 14 October 2025  07:05:32 +0000 (0:00:12.952)       0:01:16.467 *******
2025-10-14 07:05:32.180398 | controller | ===============================================================================
2025-10-14 07:05:32.180425 | controller | test_deps : Install selinux python libs -------------------------------- 45.53s
2025-10-14 07:05:32.181279 | controller | Get the zuul/zuul-jobs repo -------------------------------------------- 12.95s
2025-10-14 07:05:32.182383 | controller | repo_setup : Initialize python venv and install requirements ------------ 8.00s
2025-10-14 07:05:32.182417 | controller | test_deps : Install python yaml libs ------------------------------------ 1.18s
2025-10-14 07:05:32.182425 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.17s
2025-10-14 07:05:32.182430 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.84s
2025-10-14 07:05:32.182436 | controller | Gathering Facts --------------------------------------------------------- 0.83s
2025-10-14 07:05:32.182441 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.79s
2025-10-14 07:05:32.182446 | controller | repo_setup : Install repo-setup package --------------------------------- 0.71s
2025-10-14 07:05:32.182456 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.71s
2025-10-14 07:05:32.239188 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.56s
2025-10-14 07:05:32.239214 | controller | repo_setup : Ensure directories are present ----------------------------- 0.55s
2025-10-14 07:05:32.239221 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.45s
2025-10-14 07:05:32.239227 | controller | test_deps : Disable ubi host subscription-manager integration ----------- 0.31s
2025-10-14 07:05:32.239232 | controller | test_deps : Detect mirrors file ----------------------------------------- 0.28s
2025-10-14 07:05:32.239238 | controller | repo_setup : Use RDO proxy mirrors -------------------------------------- 0.24s
2025-10-14 07:05:32.239243 | controller | repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.23s
2025-10-14 07:05:32.239249 | controller | repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.19s
2025-10-14 07:05:32.239254 | controller | Deploy repo-setup ------------------------------------------------------- 0.06s
2025-10-14 07:05:32.239259 | controller | test_deps : Gather variables for each operating system ------------------ 0.04s
2025-10-14 07:05:32.239268 | controller | INFO     Running check_criteria > converge
2025-10-14 07:05:32.658938 | controller |
2025-10-14 07:05:33.433269 | controller | PLAY [Converge] ****************************************************************
2025-10-14 07:05:33.433303 | controller |
2025-10-14 07:05:33.433313 | controller | TASK [Gathering Facts] *********************************************************
2025-10-14 07:05:33.433320 | controller | Tuesday 14 October 2025  07:05:32 +0000 (0:00:00.034)       0:00:00.034 *******
2025-10-14 07:05:33.433331 | controller | ok: [instance]
2025-10-14 07:05:33.433418 | controller |
2025-10-14 07:05:33.433450 | controller | TASK [Check check_promotion_criteria playbook] *********************************
2025-10-14 07:05:33.433463 | controller | Tuesday 14 October 2025  07:05:33 +0000 (0:00:00.774)       0:00:00.809 *******
2025-10-14 07:05:33.460803 | controller |
2025-10-14 07:05:33.489226 | controller | TASK [dlrn_promote : Empty dlrnapi output (no jobs reported)] ******************
2025-10-14 07:05:33.489255 | controller | Tuesday 14 October 2025  07:05:33 +0000 (0:00:00.027)       0:00:00.836 *******
2025-10-14 07:05:33.489266 | controller | skipping: [instance]
2025-10-14 07:05:33.489293 | controller |
2025-10-14 07:05:33.489588 | controller | TASK [dlrn_promote : Check for criteria file before copying] *******************
2025-10-14 07:05:33.794494 | controller | Tuesday 14 October 2025  07:05:33 +0000 (0:00:00.028)       0:00:00.865 *******
2025-10-14 07:05:33.794530 | controller | ok: [instance]
2025-10-14 07:05:33.824663 | controller |
2025-10-14 07:05:33.824695 | controller | TASK [dlrn_promote : Abort the role on missing criteria file] ******************
2025-10-14 07:05:33.824703 | controller | Tuesday 14 October 2025  07:05:33 +0000 (0:00:00.304)       0:00:01.170 *******
2025-10-14 07:05:33.824713 | controller | skipping: [instance]
2025-10-14 07:05:34.118163 | controller |
2025-10-14 07:05:34.118195 | controller | TASK [dlrn_promote : Slurp criteria file] **************************************
2025-10-14 07:05:34.118203 | controller | Tuesday 14 October 2025  07:05:33 +0000 (0:00:00.030)       0:00:01.200 *******
2025-10-14 07:05:34.118213 | controller | ok: [instance]
2025-10-14 07:05:34.150237 | controller |
2025-10-14 07:05:34.150269 | controller | TASK [dlrn_promote : Set fact for criteria] ************************************
2025-10-14 07:05:34.150284 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.293)       0:00:01.494 *******
2025-10-14 07:05:34.150297 | controller | ok: [instance]
2025-10-14 07:05:34.150621 | controller |
2025-10-14 07:05:34.150639 | controller | TASK [dlrn_promote : Query to match promotion criteria] ************************
2025-10-14 07:05:34.208885 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.032)       0:00:01.526 *******
2025-10-14 07:05:34.208915 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/query_criteria.yml for instance => (item=periodic-podified-edpm-baremetal-antelope-ocp-crc)
2025-10-14 07:05:34.241093 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/query_criteria.yml for instance => (item=periodic-podified-edpm-deployment-antelope-ocp-crc-1cs9)
2025-10-14 07:05:34.241117 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/query_criteria.yml for instance => (item=periodic-data-plane-adoption-github-rdo-centos-9-crc-single-node-antelope)
2025-10-14 07:05:34.241130 | controller |
2025-10-14 07:05:34.241136 | controller | TASK [dlrn_promote : Debug criteria job] ***************************************
2025-10-14 07:05:34.241142 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.058)       0:00:01.584 *******
2025-10-14 07:05:34.241167 | controller | ok: [instance] =>
2025-10-14 07:05:34.272919 | controller |   msg: 'DEBUG: criteria job --->periodic-podified-edpm-baremetal-antelope-ocp-crc<---'
2025-10-14 07:05:34.272948 | controller |
2025-10-14 07:05:34.272956 | controller | TASK [dlrn_promote : Debug reported jobs] **************************************
2025-10-14 07:05:34.272961 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.032)       0:00:01.617 *******
2025-10-14 07:05:34.272971 | controller | ok: [instance] =>
2025-10-14 07:05:34.273189 | controller |   msg: 'DEBUG: dlrnapi reported jobs --->[''periodic-podified-edpm-baremetal-antelope-ocp-crc'', ''periodic-podified-edpm-deployment-antelope-ocp-crc-1cs9'', ''periodic-data-plane-adoption-github-rdo-centos-9-crc-single-node-antelope'']<---'
2025-10-14 07:05:34.273343 | controller |
2025-10-14 07:05:34.273488 | controller | TASK [dlrn_promote : Criteria failed?] *****************************************
2025-10-14 07:05:34.273630 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.032)       0:00:01.649 *******
2025-10-14 07:05:34.303389 | controller | skipping: [instance]
2025-10-14 07:05:34.303569 | controller |
2025-10-14 07:05:34.303722 | controller | TASK [dlrn_promote : Criteria match?] ******************************************
2025-10-14 07:05:34.303886 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.030)       0:00:01.679 *******
2025-10-14 07:05:34.338071 | controller | ok: [instance] =>
2025-10-14 07:05:34.338278 | controller |   msg: SUCCESS! :) Promotion criteria match!
2025-10-14 07:05:34.338424 | controller |
2025-10-14 07:05:34.338568 | controller | TASK [dlrn_promote : Debug criteria job] ***************************************
2025-10-14 07:05:34.338713 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.034)       0:00:01.714 *******
2025-10-14 07:05:34.370591 | controller | ok: [instance] =>
2025-10-14 07:05:34.370789 | controller |   msg: 'DEBUG: criteria job --->periodic-podified-edpm-deployment-antelope-ocp-crc-1cs9<---'
2025-10-14 07:05:34.370980 | controller |
2025-10-14 07:05:34.371167 | controller | TASK [dlrn_promote : Debug reported jobs] **************************************
2025-10-14 07:05:34.371325 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.032)       0:00:01.747 *******
2025-10-14 07:05:34.403076 | controller | ok: [instance] =>
2025-10-14 07:05:34.403287 | controller |   msg: 'DEBUG: dlrnapi reported jobs --->[''periodic-podified-edpm-baremetal-antelope-ocp-crc'', ''periodic-podified-edpm-deployment-antelope-ocp-crc-1cs9'', ''periodic-data-plane-adoption-github-rdo-centos-9-crc-single-node-antelope'']<---'
2025-10-14 07:05:34.403437 | controller |
2025-10-14 07:05:34.403577 | controller | TASK [dlrn_promote : Criteria failed?] *****************************************
2025-10-14 07:05:34.403716 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.032)       0:00:01.779 *******
2025-10-14 07:05:34.434278 | controller | skipping: [instance]
2025-10-14 07:05:34.434453 | controller |
2025-10-14 07:05:34.434610 | controller | TASK [dlrn_promote : Criteria match?] ******************************************
2025-10-14 07:05:34.434758 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.031)       0:00:01.810 *******
2025-10-14 07:05:34.467370 | controller | ok: [instance] =>
2025-10-14 07:05:34.467547 | controller |   msg: SUCCESS! :) Promotion criteria match!
2025-10-14 07:05:34.467688 | controller |
2025-10-14 07:05:34.467852 | controller | TASK [dlrn_promote : Debug criteria job] ***************************************
2025-10-14 07:05:34.467997 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.033)       0:00:01.843 *******
2025-10-14 07:05:34.499559 | controller | ok: [instance] =>
2025-10-14 07:05:34.499749 | controller |   msg: 'DEBUG: criteria job --->periodic-data-plane-adoption-github-rdo-centos-9-crc-single-node-antelope<---'
2025-10-14 07:05:34.499902 | controller |
2025-10-14 07:05:34.500044 | controller | TASK [dlrn_promote : Debug reported jobs] **************************************
2025-10-14 07:05:34.500218 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.032)       0:00:01.875 *******
2025-10-14 07:05:34.532801 | controller | ok: [instance] =>
2025-10-14 07:05:34.532986 | controller |   msg: 'DEBUG: dlrnapi reported jobs --->[''periodic-podified-edpm-baremetal-antelope-ocp-crc'', ''periodic-podified-edpm-deployment-antelope-ocp-crc-1cs9'', ''periodic-data-plane-adoption-github-rdo-centos-9-crc-single-node-antelope'']<---'
2025-10-14 07:05:34.533129 | controller |
2025-10-14 07:05:34.533293 | controller | TASK [dlrn_promote : Criteria failed?] *****************************************
2025-10-14 07:05:34.533436 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.033)       0:00:01.909 *******
2025-10-14 07:05:34.564228 | controller | skipping: [instance]
2025-10-14 07:05:34.564386 | controller |
2025-10-14 07:05:34.564534 | controller | TASK [dlrn_promote : Criteria match?] ******************************************
2025-10-14 07:05:34.564681 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.031)       0:00:01.940 *******
2025-10-14 07:05:34.613641 | controller | ok: [instance] =>
2025-10-14 07:05:34.613832 | controller |   msg: SUCCESS! :) Promotion criteria match!
2025-10-14 07:05:34.613989 | controller |
2025-10-14 07:05:34.614138 | controller | PLAY RECAP *********************************************************************
2025-10-14 07:05:34.614331 | controller | instance                   : ok=16   changed=0    unreachable=0    failed=0    skipped=5    rescued=0    ignored=0
2025-10-14 07:05:34.614470 | controller |
2025-10-14 07:05:34.614618 | controller | Tuesday 14 October 2025  07:05:34 +0000 (0:00:00.049)       0:00:01.990 *******
2025-10-14 07:05:34.614753 | controller | ===============================================================================
2025-10-14 07:05:34.614910 | controller | Gathering Facts --------------------------------------------------------- 0.77s
2025-10-14 07:05:34.615046 | controller | dlrn_promote : Check for criteria file before copying ------------------- 0.30s
2025-10-14 07:05:34.615212 | controller | dlrn_promote : Slurp criteria file -------------------------------------- 0.29s
2025-10-14 07:05:34.615357 | controller | dlrn_promote : Query to match promotion criteria ------------------------ 0.06s
2025-10-14 07:05:34.615500 | controller | dlrn_promote : Criteria match? ------------------------------------------ 0.05s
2025-10-14 07:05:34.615635 | controller | dlrn_promote : Criteria match? ------------------------------------------ 0.03s
2025-10-14 07:05:34.615768 | controller | dlrn_promote : Debug reported jobs -------------------------------------- 0.03s
2025-10-14 07:05:34.615934 | controller | dlrn_promote : Criteria match? ------------------------------------------ 0.03s
2025-10-14 07:05:34.616071 | controller | dlrn_promote : Debug criteria job --------------------------------------- 0.03s
2025-10-14 07:05:34.616230 | controller | dlrn_promote : Debug reported jobs -------------------------------------- 0.03s
2025-10-14 07:05:34.616377 | controller | dlrn_promote : Debug criteria job --------------------------------------- 0.03s
2025-10-14 07:05:34.616524 | controller | dlrn_promote : Set fact for criteria ------------------------------------ 0.03s
2025-10-14 07:05:34.616970 | controller | dlrn_promote : Debug reported jobs -------------------------------------- 0.03s
2025-10-14 07:05:34.617120 | controller | dlrn_promote : Debug criteria job --------------------------------------- 0.03s
2025-10-14 07:05:34.617282 | controller | dlrn_promote : Criteria failed? ----------------------------------------- 0.03s
2025-10-14 07:05:34.617424 | controller | dlrn_promote : Criteria failed? ----------------------------------------- 0.03s
2025-10-14 07:05:34.617558 | controller | dlrn_promote : Criteria failed? ----------------------------------------- 0.03s
2025-10-14 07:05:34.617693 | controller | dlrn_promote : Abort the role on missing criteria file ------------------ 0.03s
2025-10-14 07:05:34.617855 | controller | dlrn_promote : Empty dlrnapi output (no jobs reported) ------------------ 0.03s
2025-10-14 07:05:34.617993 | controller | Check check_promotion_criteria playbook --------------------------------- 0.03s
2025-10-14 07:05:34.668730 | controller | INFO     Running check_criteria > cleanup
2025-10-14 07:05:34.669234 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-14 07:05:34.669697 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-14 07:05:53.163221 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.163805 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.164345 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.164853 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.165382 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+2ef920f0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.0.0+2ef920f0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.165884 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.166377 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.166874 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.167369 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.167866 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.168367 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.168866 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.169369 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.169864 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.170363 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/087b64/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-14 07:05:53.179141 | controller | INFO     Running default > prepare
2025-10-14 07:05:53.601691 | controller |
2025-10-14 07:05:53.601908 | controller | PLAY [Prepare] *****************************************************************
2025-10-14 07:05:53.602043 | controller |
2025-10-14 07:05:53.602199 | controller | TASK [Gathering Facts] *********************************************************
2025-10-14 07:05:53.602344 | controller | Tuesday 14 October 2025  07:05:53 +0000 (0:00:00.015)       0:00:00.015 *******
2025-10-14 07:05:54.392716 | controller | ok: [instance]
2025-10-14 07:05:54.408299 | controller |
2025-10-14 07:05:54.408335 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2025-10-14 07:05:54.408343 | controller | Tuesday 14 October 2025  07:05:54 +0000 (0:00:00.791)       0:00:00.807 *******
2025-10-14 07:05:54.408354 | controller | skipping: [instance]
2025-10-14 07:05:54.408557 | controller |
2025-10-14 07:05:54.408583 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2025-10-14 07:05:54.446951 | controller | Tuesday 14 October 2025  07:05:54 +0000 (0:00:00.015)       0:00:00.823 *******
2025-10-14 07:05:54.446980 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2025-10-14 07:05:54.719240 | controller |
2025-10-14 07:05:54.719273 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2025-10-14 07:05:54.719281 | controller | Tuesday 14 October 2025  07:05:54 +0000 (0:00:00.038)       0:00:00.861 *******
2025-10-14 07:05:54.719291 | controller | ok: [instance]
2025-10-14 07:05:54.719532 | controller |
2025-10-14 07:05:54.719545 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2025-10-14 07:05:55.030971 | controller | Tuesday 14 October 2025  07:05:54 +0000 (0:00:00.272)       0:00:01.133 *******
2025-10-14 07:05:55.031005 | controller | ok: [instance]
2025-10-14 07:05:55.728182 | controller |
2025-10-14 07:05:55.728211 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2025-10-14 07:05:55.728220 | controller | Tuesday 14 October 2025  07:05:55 +0000 (0:00:00.311)       0:00:01.445 *******
2025-10-14 07:05:55.728230 | controller | ok: [instance] => (item=ubi-9-appstream)
2025-10-14 07:05:55.789299 | controller | ok: [instance] => (item=ubi-9-baseos)
2025-10-14 07:05:55.789338 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2025-10-14 07:05:55.789347 | controller |
2025-10-14 07:05:55.789355 | controller | TASK [Deploy repo-setup] *******************************************************
2025-10-14 07:05:55.789363 | controller | Tuesday 14 October 2025  07:05:55 +0000 (0:00:00.696)       0:00:02.142 *******
2025-10-14 07:05:55.789376 | controller |
2025-10-14 07:05:56.325420 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-10-14 07:05:56.325449 | controller | Tuesday 14 October 2025  07:05:55 +0000 (0:00:00.061)       0:00:02.203 *******
2025-10-14 07:05:56.325461 | controller | ok: [instance] => (item=tmp)
2025-10-14 07:05:57.671142 | controller | ok: [instance] => (item=artifacts/repositories)
2025-10-14 07:05:57.671194 | controller | ok: [instance] => (item=venv/repo_setup)
2025-10-14 07:05:57.671202 | controller |
2025-10-14 07:05:57.671208 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-10-14 07:05:57.671215 | controller | Tuesday 14 October 2025  07:05:56 +0000 (0:00:00.535)       0:00:02.739 *******
2025-10-14 07:05:57.671224 | controller | ok: [instance]
2025-10-14 07:05:58.277131 | controller |
2025-10-14 07:05:58.277213 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-10-14 07:05:58.277225 | controller | Tuesday 14 October 2025  07:05:57 +0000 (0:00:01.346)       0:00:04.085 *******
2025-10-14 07:05:58.277235 | controller | ok: [instance]
2025-10-14 07:05:59.546414 | controller |
2025-10-14 07:05:59.546443 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-10-14 07:05:59.546452 | controller | Tuesday 14 October 2025  07:05:58 +0000 (0:00:00.605)       0:00:04.691 *******
2025-10-14 07:05:59.546462 | controller | ok: [instance]
2025-10-14 07:05:59.833254 | controller |
2025-10-14 07:05:59.833287 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-10-14 07:05:59.833296 | controller | Tuesday 14 October 2025  07:05:59 +0000 (0:00:01.269)       0:00:05.960 *******
2025-10-14 07:05:59.833308 | controller | ok: [instance]
2025-10-14 07:05:59.856006 | controller |
2025-10-14 07:05:59.856036 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-10-14 07:05:59.856045 | controller | Tuesday 14 October 2025  07:05:59 +0000 (0:00:00.286)       0:00:06.247 *******
2025-10-14 07:05:59.856057 | controller | skipping: [instance]
2025-10-14 07:06:00.752984 | controller |
2025-10-14 07:06:00.753014 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-10-14 07:06:00.753022 | controller | Tuesday 14 October 2025  07:05:59 +0000 (0:00:00.022)       0:00:06.270 *******
2025-10-14 07:06:00.753032 | controller | changed: [instance]
2025-10-14 07:06:00.789254 | controller |
2025-10-14 07:06:00.789284 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-10-14 07:06:00.789292 | controller | Tuesday 14 October 2025  07:06:00 +0000 (0:00:00.897)       0:00:07.167 *******
2025-10-14 07:06:00.789302 | controller | skipping: [instance]
2025-10-14 07:06:00.826440 | controller |
2025-10-14 07:06:00.826469 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-10-14 07:06:00.826477 | controller | Tuesday 14 October 2025  07:06:00 +0000 (0:00:00.036)       0:00:07.203 *******
2025-10-14 07:06:00.826486 | controller | skipping: [instance]
2025-10-14 07:06:00.864248 | controller |
2025-10-14 07:06:00.864281 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-10-14 07:06:00.864291 | controller | Tuesday 14 October 2025  07:06:00 +0000 (0:00:00.037)       0:00:07.240 *******
2025-10-14 07:06:00.864302 | controller | skipping: [instance]
2025-10-14 07:06:00.864332 | controller |
2025-10-14 07:06:00.864491 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-10-14 07:06:01.431205 | controller | Tuesday 14 October 2025  07:06:00 +0000 (0:00:00.038)       0:00:07.279 *******
2025-10-14 07:06:01.431243 | controller | changed: [instance]
2025-10-14 07:06:01.779247 | controller |
2025-10-14 07:06:01.779277 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-10-14 07:06:01.779286 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.566)       0:00:07.845 *******
2025-10-14 07:06:01.779295 | controller | ok: [instance]
2025-10-14 07:06:01.779314 | controller |
2025-10-14 07:06:01.779368 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-10-14 07:06:01.779480 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.348)       0:00:08.194 *******
2025-10-14 07:06:01.806450 | controller | skipping: [instance]
2025-10-14 07:06:01.806531 | controller |
2025-10-14 07:06:01.806662 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-10-14 07:06:01.806788 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.027)       0:00:08.221 *******
2025-10-14 07:06:01.833679 | controller | skipping: [instance]
2025-10-14 07:06:01.833770 | controller |
2025-10-14 07:06:01.833914 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-10-14 07:06:01.834045 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.027)       0:00:08.248 *******
2025-10-14 07:06:01.861057 | controller | skipping: [instance]
2025-10-14 07:06:01.861122 | controller |
2025-10-14 07:06:01.861251 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-10-14 07:06:01.861350 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.027)       0:00:08.276 *******
2025-10-14 07:06:01.898784 | controller | ok: [instance]
2025-10-14 07:06:01.898896 | controller |
2025-10-14 07:06:01.899020 | controller | TASK [repo_setup : Create download directory] **********************************
2025-10-14 07:06:01.899143 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.037)       0:00:08.313 *******
2025-10-14 07:06:01.924920 | controller | skipping: [instance]
2025-10-14 07:06:01.925022 | controller |
2025-10-14 07:06:01.925146 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-10-14 07:06:01.925406 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.026)       0:00:08.339 *******
2025-10-14 07:06:01.951089 | controller | skipping: [instance]
2025-10-14 07:06:01.951195 | controller |
2025-10-14 07:06:01.951325 | controller | TASK [Download the RPM] ********************************************************
2025-10-14 07:06:01.951438 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.026)       0:00:08.366 *******
2025-10-14 07:06:01.976211 | controller | skipping: [instance]
2025-10-14 07:06:01.976314 | controller |
2025-10-14 07:06:01.976436 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-10-14 07:06:01.976541 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.025)       0:00:08.391 *******
2025-10-14 07:06:02.000888 | controller | skipping: [instance]
2025-10-14 07:06:02.000990 | controller |
2025-10-14 07:06:02.001114 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-10-14 07:06:02.001265 | controller | Tuesday 14 October 2025  07:06:01 +0000 (0:00:00.024)       0:00:08.416 *******
2025-10-14 07:06:02.025567 | controller | skipping: [instance]
2025-10-14 07:06:02.025656 | controller |
2025-10-14 07:06:02.025769 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-10-14 07:06:02.025880 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.024)       0:00:08.440 *******
2025-10-14 07:06:02.052271 | controller | skipping: [instance]
2025-10-14 07:06:02.052376 | controller |
2025-10-14 07:06:02.052514 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-10-14 07:06:02.052634 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.026)       0:00:08.467 *******
2025-10-14 07:06:02.077095 | controller | skipping: [instance]
2025-10-14 07:06:02.077201 | controller |
2025-10-14 07:06:02.077313 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-10-14 07:06:02.077416 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.024)       0:00:08.492 *******
2025-10-14 07:06:02.256837 | controller | ok: [instance]
2025-10-14 07:06:02.256926 | controller |
2025-10-14 07:06:02.257034 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-10-14 07:06:02.257137 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.179)       0:00:08.671 *******
2025-10-14 07:06:02.456222 | controller | changed: [instance]
2025-10-14 07:06:02.456301 | controller |
2025-10-14 07:06:02.456419 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-10-14 07:06:02.456523 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.199)       0:00:08.871 *******
2025-10-14 07:06:02.681059 | controller | changed: [instance]
2025-10-14 07:06:02.681132 | controller |
2025-10-14 07:06:02.681274 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-10-14 07:06:02.681384 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.224)       0:00:09.095 *******
2025-10-14 07:06:02.702578 | controller | skipping: [instance]
2025-10-14 07:06:02.702682 | controller |
2025-10-14 07:06:02.702828 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-10-14 07:06:02.702940 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.117 *******
2025-10-14 07:06:02.724041 | controller | skipping: [instance]
2025-10-14 07:06:02.724127 | controller |
2025-10-14 07:06:02.724304 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-10-14 07:06:02.724434 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.138 *******
2025-10-14 07:06:02.745553 | controller | skipping: [instance]
2025-10-14 07:06:02.745635 | controller |
2025-10-14 07:06:02.745751 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-10-14 07:06:02.745876 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.160 *******
2025-10-14 07:06:02.766992 | controller | skipping: [instance]
2025-10-14 07:06:02.767059 | controller |
2025-10-14 07:06:02.767182 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-10-14 07:06:02.767292 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.181 *******
2025-10-14 07:06:02.788846 | controller | skipping: [instance]
2025-10-14 07:06:02.789205 | controller |
2025-10-14 07:06:02.811017 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-10-14 07:06:02.811044 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.203 *******
2025-10-14 07:06:02.811056 | controller | skipping: [instance]
2025-10-14 07:06:02.827696 | controller |
2025-10-14 07:06:02.827719 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-10-14 07:06:02.827728 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.225 *******
2025-10-14 07:06:02.827739 | controller | skipping: [instance]
2025-10-14 07:06:02.857322 | controller |
2025-10-14 07:06:02.857354 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-10-14 07:06:02.857362 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.016)       0:00:09.242 *******
2025-10-14 07:06:02.857371 | controller | skipping: [instance]
2025-10-14 07:06:02.874577 | controller |
2025-10-14 07:06:02.874599 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-10-14 07:06:02.874608 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.029)       0:00:09.271 *******
2025-10-14 07:06:02.874619 | controller | skipping: [instance]
2025-10-14 07:06:02.895761 | controller |
2025-10-14 07:06:02.895782 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-10-14 07:06:02.895790 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.017)       0:00:09.289 *******
2025-10-14 07:06:02.895801 | controller | skipping: [instance]
2025-10-14 07:06:02.927520 | controller |
2025-10-14 07:06:02.927548 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2025-10-14 07:06:02.927557 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.021)       0:00:09.310 *******
2025-10-14 07:06:02.927568 | controller | skipping: [instance]
2025-10-14 07:06:02.927735 | controller |
2025-10-14 07:06:02.927935 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2025-10-14 07:06:02.928108 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.031)       0:00:09.342 *******
2025-10-14 07:06:02.957781 | controller | skipping: [instance]
2025-10-14 07:06:02.988020 | controller |
2025-10-14 07:06:02.988048 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2025-10-14 07:06:02.988058 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.029)       0:00:09.372 *******
2025-10-14 07:06:02.988069 | controller | skipping: [instance]
2025-10-14 07:06:03.016966 | controller |
2025-10-14 07:06:03.016992 | controller | TASK [test_deps : Install additional packages] *********************************
2025-10-14 07:06:03.017000 | controller | Tuesday 14 October 2025  07:06:02 +0000 (0:00:00.030)       0:00:09.402 *******
2025-10-14 07:06:03.017009 | controller | skipping: [instance]
2025-10-14 07:06:43.195895 | controller |
2025-10-14 07:06:43.195927 | controller | TASK [test_deps : Install selinux python libs] *********************************
2025-10-14 07:06:43.195935 | controller | Tuesday 14 October 2025  07:06:03 +0000 (0:00:00.028)       0:00:09.431 *******
2025-10-14 07:06:43.195945 | controller | ok: [instance]
2025-10-14 07:06:44.380111 | controller |
2025-10-14 07:06:44.380216 | controller | TASK [test_deps : Install python yaml libs] ************************************
2025-10-14 07:06:44.380229 | controller | Tuesday 14 October 2025  07:06:43 +0000 (0:00:40.178)       0:00:49.610 *******
2025-10-14 07:06:44.380246 | controller | ok: [instance]
2025-10-14 07:06:44.410915 | controller |
2025-10-14 07:06:44.410931 | controller | TASK [test_deps : Install extra packages] **************************************
2025-10-14 07:06:44.410939 | controller | Tuesday 14 October 2025  07:06:44 +0000 (0:00:01.184)       0:00:50.794 *******
2025-10-14 07:06:44.410947 | controller | skipping: [instance]
2025-10-14 07:06:46.477253 | controller |
2025-10-14 07:06:46.477292 | controller | TASK [Get the zuul/zuul-jobs repo] *********************************************
2025-10-14 07:06:46.477301 | controller | Tuesday 14 October 2025  07:06:44 +0000 (0:00:00.031)       0:00:50.825 *******
2025-10-14 07:06:46.477311 | controller | ok: [instance]
2025-10-14 07:06:46.477330 | controller |
2025-10-14 07:06:46.479270 | controller | PLAY RECAP *********************************************************************
2025-10-14 07:06:46.479326 | controller | instance                   : ok=20   changed=4    unreachable=0    failed=0    skipped=30   rescued=0    ignored=0
2025-10-14 07:06:46.479337 | controller |
2025-10-14 07:06:46.479345 | controller | Tuesday 14 October 2025  07:06:46 +0000 (0:00:02.066)       0:00:52.891 *******
2025-10-14 07:06:46.479352 | controller | ===============================================================================
2025-10-14 07:06:46.479358 | controller | test_deps : Install selinux python libs -------------------------------- 40.18s
2025-10-14 07:06:46.479371 | controller | Get the zuul/zuul-jobs repo --------------------------------------------- 2.07s
2025-10-14 07:06:46.479378 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.35s
2025-10-14 07:06:46.479385 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.27s
2025-10-14 07:06:46.479392 | controller | test_deps : Install python yaml libs ------------------------------------ 1.18s
2025-10-14 07:06:46.479398 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.90s
2025-10-14 07:06:46.479405 | controller | Gathering Facts --------------------------------------------------------- 0.79s
2025-10-14 07:06:46.479411 | controller | test_deps : Disable ubi 9 repos ----------------------------------------- 0.70s
2025-10-14 07:06:46.479418 | controller | repo_setup : Get repo-setup repository ---------------------------------- 0.61s
2025-10-14 07:06:46.479424 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.57s
2025-10-14 07:06:46.479431 | controller | repo_setup : Ensure directories are present ----------------------------- 0.54s
2025-10-14 07:06:46.479437 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.35s
2025-10-14 07:06:46.479444 | controller | test_deps : Disable ubi host subscription-manager integration ----------- 0.31s
2025-10-14 07:06:46.479450 | controller | repo_setup : Install repo-setup package --------------------------------- 0.29s
2025-10-14 07:06:46.479459 | controller | test_deps : Detect mirrors file ----------------------------------------- 0.27s
2025-10-14 07:06:46.479486 | controller | repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist) --- 0.22s
2025-10-14 07:06:46.479816 | controller | repo_setup : Use RDO proxy mirrors -------------------------------------- 0.20s
2025-10-14 07:06:46.479848 | controller | repo_setup : Check for /etc/ci/mirror_info.sh --------------------------- 0.18s
2025-10-14 07:06:46.539367 | controller | Deploy repo-setup ------------------------------------------------------- 0.06s
2025-10-14 07:06:46.539390 | controller | test_deps : Gather variables for each operating system ------------------ 0.04s
2025-10-14 07:06:46.539402 | controller | INFO     Running default > converge
2025-10-14 07:06:46.953114 | controller |
2025-10-14 07:06:46.953350 | controller | PLAY [Converge] ****************************************************************
2025-10-14 07:06:46.953493 | controller |
2025-10-14 07:06:46.953637 | controller | TASK [Gathering Facts] *********************************************************
2025-10-14 07:06:46.953792 | controller | Tuesday 14 October 2025  07:06:46 +0000 (0:00:00.035)       0:00:00.035 *******
2025-10-14 07:06:47.731638 | controller | ok: [instance]
2025-10-14 07:06:47.792248 | controller |
2025-10-14 07:06:47.792278 | controller | TASK [Run repo-setup role] *****************************************************
2025-10-14 07:06:47.792288 | controller | Tuesday 14 October 2025  07:06:47 +0000 (0:00:00.778)       0:00:00.814 *******
2025-10-14 07:06:47.792311 | controller |
2025-10-14 07:06:48.423797 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-10-14 07:06:48.423826 | controller | Tuesday 14 October 2025  07:06:47 +0000 (0:00:00.060)       0:00:00.875 *******
2025-10-14 07:06:48.423838 | controller | ok: [instance] => (item=tmp)
2025-10-14 07:06:49.745431 | controller | ok: [instance] => (item=artifacts/repositories)
2025-10-14 07:06:49.745461 | controller | ok: [instance] => (item=venv/repo_setup)
2025-10-14 07:06:49.745468 | controller |
2025-10-14 07:06:49.745475 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-10-14 07:06:49.745481 | controller | Tuesday 14 October 2025  07:06:48 +0000 (0:00:00.630)       0:00:01.506 *******
2025-10-14 07:06:49.745490 | controller | ok: [instance]
2025-10-14 07:06:50.351669 | controller |
2025-10-14 07:06:50.351699 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-10-14 07:06:50.351707 | controller | Tuesday 14 October 2025  07:06:49 +0000 (0:00:01.321)       0:00:02.828 *******
2025-10-14 07:06:50.351727 | controller | ok: [instance]
2025-10-14 07:06:51.667246 | controller |
2025-10-14 07:06:51.667279 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-10-14 07:06:51.667287 | controller | Tuesday 14 October 2025  07:06:50 +0000 (0:00:00.606)       0:00:03.434 *******
2025-10-14 07:06:51.667302 | controller | ok: [instance]
2025-10-14 07:06:51.667651 | controller |
2025-10-14 07:06:51.970192 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-10-14 07:06:51.970223 | controller | Tuesday 14 October 2025  07:06:51 +0000 (0:00:01.315)       0:00:04.750 *******
2025-10-14 07:06:51.970234 | controller | ok: [instance]
2025-10-14 07:06:52.001872 | controller |
2025-10-14 07:06:52.001897 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-10-14 07:06:52.001906 | controller | Tuesday 14 October 2025  07:06:51 +0000 (0:00:00.302)       0:00:05.052 *******
2025-10-14 07:06:52.001918 | controller | skipping: [instance]
2025-10-14 07:06:52.864444 | controller |
2025-10-14 07:06:52.864475 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-10-14 07:06:52.864483 | controller | Tuesday 14 October 2025  07:06:51 +0000 (0:00:00.031)       0:00:05.084 *******
2025-10-14 07:06:52.864493 | controller | changed: [instance]
2025-10-14 07:06:52.906951 | controller |
2025-10-14 07:06:52.906983 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-10-14 07:06:52.906990 | controller | Tuesday 14 October 2025  07:06:52 +0000 (0:00:00.862)       0:00:05.947 *******
2025-10-14 07:06:52.907000 | controller | skipping: [instance]
2025-10-14 07:06:52.949753 | controller |
2025-10-14 07:06:52.949789 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-10-14 07:06:52.949799 | controller | Tuesday 14 October 2025  07:06:52 +0000 (0:00:00.042)       0:00:05.989 *******
2025-10-14 07:06:52.949813 | controller | skipping: [instance]
2025-10-14 07:06:52.992282 | controller |
2025-10-14 07:06:52.992309 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-10-14 07:06:52.992317 | controller | Tuesday 14 October 2025  07:06:52 +0000 (0:00:00.042)       0:00:06.032 *******
2025-10-14 07:06:52.992326 | controller | skipping: [instance]
2025-10-14 07:06:53.571833 | controller |
2025-10-14 07:06:53.571864 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-10-14 07:06:53.571872 | controller | Tuesday 14 October 2025  07:06:52 +0000 (0:00:00.042)       0:00:06.075 *******
2025-10-14 07:06:53.571881 | controller | changed: [instance]
2025-10-14 07:06:54.125962 | controller |
2025-10-14 07:06:54.125993 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-10-14 07:06:54.126001 | controller | Tuesday 14 October 2025  07:06:53 +0000 (0:00:00.579)       0:00:06.654 *******
2025-10-14 07:06:54.126011 | controller | changed: [instance]
2025-10-14 07:06:54.156085 | controller |
2025-10-14 07:06:54.156111 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-10-14 07:06:54.156119 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.554)       0:00:07.208 *******
2025-10-14 07:06:54.156128 | controller | skipping: [instance]
2025-10-14 07:06:54.185892 | controller |
2025-10-14 07:06:54.185917 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-10-14 07:06:54.185925 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.030)       0:00:07.239 *******
2025-10-14 07:06:54.185935 | controller | skipping: [instance]
2025-10-14 07:06:54.214760 | controller |
2025-10-14 07:06:54.214785 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-10-14 07:06:54.214792 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.029)       0:00:07.269 *******
2025-10-14 07:06:54.214802 | controller | skipping: [instance]
2025-10-14 07:06:54.253927 | controller |
2025-10-14 07:06:54.253953 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-10-14 07:06:54.253962 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.028)       0:00:07.297 *******
2025-10-14 07:06:54.253971 | controller | ok: [instance]
2025-10-14 07:06:54.282622 | controller |
2025-10-14 07:06:54.282649 | controller | TASK [repo_setup : Create download directory] **********************************
2025-10-14 07:06:54.282657 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.039)       0:00:07.337 *******
2025-10-14 07:06:54.282666 | controller | skipping: [instance]
2025-10-14 07:06:54.309964 | controller |
2025-10-14 07:06:54.309987 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-10-14 07:06:54.309995 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.028)       0:00:07.365 *******
2025-10-14 07:06:54.310005 | controller | skipping: [instance]
2025-10-14 07:06:54.338056 | controller |
2025-10-14 07:06:54.338086 | controller | TASK [Download the RPM] ********************************************************
2025-10-14 07:06:54.338094 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.027)       0:00:07.393 *******
2025-10-14 07:06:54.338104 | controller | skipping: [instance]
2025-10-14 07:06:54.365589 | controller |
2025-10-14 07:06:54.365620 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-10-14 07:06:54.365634 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.027)       0:00:07.420 *******
2025-10-14 07:06:54.365645 | controller | skipping: [instance]
2025-10-14 07:06:54.393835 | controller |
2025-10-14 07:06:54.393866 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-10-14 07:06:54.393874 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.027)       0:00:07.448 *******
2025-10-14 07:06:54.393883 | controller | skipping: [instance]
2025-10-14 07:06:54.423267 | controller |
2025-10-14 07:06:54.423306 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-10-14 07:06:54.423316 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.028)       0:00:07.476 *******
2025-10-14 07:06:54.423328 | controller | skipping: [instance]
2025-10-14 07:06:54.450619 | controller |
2025-10-14 07:06:54.450650 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-10-14 07:06:54.450658 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.029)       0:00:07.506 *******
2025-10-14 07:06:54.450669 | controller | skipping: [instance]
2025-10-14 07:06:54.636474 | controller |
2025-10-14 07:06:54.636504 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-10-14 07:06:54.636512 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.027)       0:00:07.533 *******
2025-10-14 07:06:54.636522 | controller | ok: [instance]
2025-10-14 07:06:54.843973 | controller |
2025-10-14 07:06:54.844006 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-10-14 07:06:54.844014 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.185)       0:00:07.719 *******
2025-10-14 07:06:54.844024 | controller | changed: [instance]
2025-10-14 07:06:55.053912 | controller |
2025-10-14 07:06:55.053942 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-10-14 07:06:55.053949 | controller | Tuesday 14 October 2025  07:06:54 +0000 (0:00:00.207)       0:00:07.926 *******
2025-10-14 07:06:55.053959 | controller | changed: [instance]
2025-10-14 07:06:55.075259 | controller |
2025-10-14 07:06:55.075293 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-10-14 07:06:55.075303 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.209)       0:00:08.136 *******
2025-10-14 07:06:55.075325 | controller | skipping: [instance]
2025-10-14 07:06:55.075354 | controller |
2025-10-14 07:06:55.075364 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-10-14 07:06:55.075435 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.021)       0:00:08.158 *******
2025-10-14 07:06:55.109239 | controller | skipping: [instance]
2025-10-14 07:06:55.109284 | controller |
2025-10-14 07:06:55.109296 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-10-14 07:06:55.109402 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.033)       0:00:08.192 *******
2025-10-14 07:06:55.160570 | controller | skipping: [instance]
2025-10-14 07:06:55.194003 | controller |
2025-10-14 07:06:55.194024 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-10-14 07:06:55.194033 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.051)       0:00:08.243 *******
2025-10-14 07:06:55.194044 | controller | skipping: [instance]
2025-10-14 07:06:55.226778 | controller |
2025-10-14 07:06:55.226797 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-10-14 07:06:55.226806 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.033)       0:00:08.277 *******
2025-10-14 07:06:55.226817 | controller | skipping: [instance]
2025-10-14 07:06:55.259839 | controller |
2025-10-14 07:06:55.259859 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-10-14 07:06:55.259868 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.032)       0:00:08.309 *******
2025-10-14 07:06:55.259878 | controller | skipping: [instance]
2025-10-14 07:06:55.547232 | controller |
2025-10-14 07:06:55.547267 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-10-14 07:06:55.547275 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.032)       0:00:08.342 *******
2025-10-14 07:06:55.547285 | controller | ok: [instance]
2025-10-14 07:06:57.070543 | controller |
2025-10-14 07:06:57.070580 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-10-14 07:06:57.070588 | controller | Tuesday 14 October 2025  07:06:55 +0000 (0:00:00.287)       0:00:08.630 *******
2025-10-14 07:06:57.070598 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos-addons.repo)
2025-10-14 07:06:57.512099 | controller | changed: [instance] => (item=/etc/yum.repos.d/centos.repo)
2025-10-14 07:06:57.512129 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-appstream.repo)
2025-10-14 07:06:57.512138 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-baseos.repo)
2025-10-14 07:06:57.512144 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean.repo)
2025-10-14 07:06:57.512172 | controller | changed: [instance] => (item=/etc/yum.repos.d/delorean-master-testing.repo)
2025-10-14 07:06:57.512184 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-highavailability.repo)
2025-10-14 07:06:57.512190 | controller | changed: [instance] => (item=/etc/yum.repos.d/repo-setup-centos-powertools.repo)
2025-10-14 07:06:57.512195 | controller |
2025-10-14 07:06:57.512201 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-10-14 07:06:57.512206 | controller | Tuesday 14 October 2025  07:06:57 +0000 (0:00:01.522)       0:00:10.152 *******
2025-10-14 07:06:57.512217 | controller | changed: [instance]
2025-10-14 07:06:57.738885 | controller |
2025-10-14 07:06:57.738916 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-10-14 07:06:57.738930 | controller | Tuesday 14 October 2025  07:06:57 +0000 (0:00:00.442)       0:00:10.595 *******
2025-10-14 07:06:57.738940 | controller | changed: [instance]
2025-10-14 07:06:57.793758 | controller |
2025-10-14 07:06:57.793788 | controller | TASK [Check get_hashes playbook] ***********************************************
2025-10-14 07:06:57.793796 | controller | Tuesday 14 October 2025  07:06:57 +0000 (0:00:00.226)       0:00:10.821 *******
2025-10-14 07:06:57.793805 | controller |
2025-10-14 07:06:58.003020 | controller | TASK [dlrn_promote : Make sure delorean.repo exists] ***************************
2025-10-14 07:06:58.003052 | controller | Tuesday 14 October 2025  07:06:57 +0000 (0:00:00.055)       0:00:10.876 *******
2025-10-14 07:06:58.003068 | controller | ok: [instance]
2025-10-14 07:06:58.295042 | controller |
2025-10-14 07:06:58.295074 | controller | TASK [dlrn_promote : Get baseurls from delorean.repo] **************************
2025-10-14 07:06:58.295082 | controller | Tuesday 14 October 2025  07:06:58 +0000 (0:00:00.209)       0:00:11.085 *******
2025-10-14 07:06:58.295092 | controller | ok: [instance]
2025-10-14 07:06:58.508246 | controller |
2025-10-14 07:06:58.508280 | controller | TASK [dlrn_promote : Get urls from baseurls list] ******************************
2025-10-14 07:06:58.508288 | controller | Tuesday 14 October 2025  07:06:58 +0000 (0:00:00.292)       0:00:11.378 *******
2025-10-14 07:06:58.508298 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/barbican/42/b4/42b4c41831408a8e323fec3c8983b5c793b64874_08052e9d)
2025-10-14 07:06:58.508322 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/baremetal/10/df/10df0bd91b9bc5c9fd9cc02d75c0084cd4da29a7_36137eb3)
2025-10-14 07:06:58.508329 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/cinder/1c/00/1c00d6490d88e436f26efb71f2ac96e75252e97c_f716f000)
2025-10-14 07:06:58.508335 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/clients/c4/ac/c4acc5639fd2329372142e39464fcca0209b0018_d3ef8337)
2025-10-14 07:06:58.508340 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/cloudops/2f/31/2f31846d73c044740ccaaa4204720f0b94d64145_c2222caa)
2025-10-14 07:06:58.508345 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/common/c5/c1/c5c11964947c40ba70b2632fc83b98a9d01ca138_f77934fb)
2025-10-14 07:06:58.508356 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/compute/6f/8d/6f8decf0b4f1aa2e96292b6a2ffc28249fe4af5e_dc05b899)
2025-10-14 07:06:58.508362 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/designate/34/7f/347fdbc9b4595a10b726526b3c0b5928e5b7fcf2_3fd39337)
2025-10-14 07:06:58.508370 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/glance/1f/d1/1fd12c29b339f30fe823e2b5beba14b5f241e52a_0d693729)
2025-10-14 07:06:58.508397 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/keystone/e4/b4/e4b40af0ae3698fbbbbfb8c22468b33aae80e6d7_264c03cc)
2025-10-14 07:06:58.509035 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/manila/3c/01/3c01b7181572c95dac462eb19c3121e36cb0fe95_912dfd18)
2025-10-14 07:06:58.509082 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/network/d9/ea/d9ea9e7bae2aa29d59ccfd2dbe6cc04824f7746f_1e622c15)
2025-10-14 07:06:58.509090 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/octavia/ba/39/ba397f07a7331190208c93368ee23826ac4e2707_9d6e596a)
2025-10-14 07:06:58.509096 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/optimize/c0/14/c014f81a8647287f6dcc339321c1256f5a2e82d5_bcbfdccc)
2025-10-14 07:06:58.509102 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/podified/ff/70/ff70d03bf5bc0bb6f3540a02d301b5c6775e6022_dbfdef11)
2025-10-14 07:06:58.509107 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/puppet/91/ba/91ba84bc002c318a7f961d084e992b2e88ffd5b3_7cde1ad1)
2025-10-14 07:06:58.509119 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/swift/dc/98/dc98a8463506ac520c469adb0ef47d0f7753905a_9d02f069)
2025-10-14 07:06:58.509196 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/tempest/85/15/8515371b7cceebd4282e09f1d8f0cc842df82855_a1e336c7)
2025-10-14 07:06:58.509327 | controller | ok: [instance] => (item=baseurl=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/ui/01/3a/013accbfd179753bc3f0d1f4e5bed07a4fd9f771_0c88e467)
2025-10-14 07:06:58.509448 | controller |
2025-10-14 07:06:58.509566 | controller | TASK [dlrn_promote : Run promotion for each base component urls] ***************
2025-10-14 07:06:58.509681 | controller | Tuesday 14 October 2025  07:06:58 +0000 (0:00:00.212)       0:00:11.590 *******
2025-10-14 07:06:58.701303 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/barbican/42/b4/42b4c41831408a8e323fec3c8983b5c793b64874_08052e9d)
2025-10-14 07:06:58.702449 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/baremetal/10/df/10df0bd91b9bc5c9fd9cc02d75c0084cd4da29a7_36137eb3)
2025-10-14 07:06:58.702472 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/cinder/1c/00/1c00d6490d88e436f26efb71f2ac96e75252e97c_f716f000)
2025-10-14 07:06:58.702480 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/clients/c4/ac/c4acc5639fd2329372142e39464fcca0209b0018_d3ef8337)
2025-10-14 07:06:58.702486 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/cloudops/2f/31/2f31846d73c044740ccaaa4204720f0b94d64145_c2222caa)
2025-10-14 07:06:58.702491 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/common/c5/c1/c5c11964947c40ba70b2632fc83b98a9d01ca138_f77934fb)
2025-10-14 07:06:58.702496 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/compute/6f/8d/6f8decf0b4f1aa2e96292b6a2ffc28249fe4af5e_dc05b899)
2025-10-14 07:06:58.702506 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/designate/34/7f/347fdbc9b4595a10b726526b3c0b5928e5b7fcf2_3fd39337)
2025-10-14 07:06:58.702529 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/glance/1f/d1/1fd12c29b339f30fe823e2b5beba14b5f241e52a_0d693729)
2025-10-14 07:06:58.702535 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/keystone/e4/b4/e4b40af0ae3698fbbbbfb8c22468b33aae80e6d7_264c03cc)
2025-10-14 07:06:58.702544 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/manila/3c/01/3c01b7181572c95dac462eb19c3121e36cb0fe95_912dfd18)
2025-10-14 07:06:58.702549 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/network/d9/ea/d9ea9e7bae2aa29d59ccfd2dbe6cc04824f7746f_1e622c15)
2025-10-14 07:06:58.702554 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/octavia/ba/39/ba397f07a7331190208c93368ee23826ac4e2707_9d6e596a)
2025-10-14 07:06:58.702560 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/optimize/c0/14/c014f81a8647287f6dcc339321c1256f5a2e82d5_bcbfdccc)
2025-10-14 07:06:58.702569 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/podified/ff/70/ff70d03bf5bc0bb6f3540a02d301b5c6775e6022_dbfdef11)
2025-10-14 07:06:58.702574 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/puppet/91/ba/91ba84bc002c318a7f961d084e992b2e88ffd5b3_7cde1ad1)
2025-10-14 07:06:58.702580 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/swift/dc/98/dc98a8463506ac520c469adb0ef47d0f7753905a_9d02f069)
2025-10-14 07:06:58.702585 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/tempest/85/15/8515371b7cceebd4282e09f1d8f0cc842df82855_a1e336c7)
2025-10-14 07:06:58.702592 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/dlrn_promote/tasks/get_hash_from_commit.yaml for instance => (item=http://mirror.regionone.ibm-bm4-nodepool.rdoproject.org:8080/rdo//centos9-antelope/component/ui/01/3a/013accbfd179753bc3f0d1f4e5bed07a4fd9f771_0c88e467)
2025-10-14 07:06:58.702614 | controller |
2025-10-14 07:06:58.702843 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:06:59.313098 | controller | Tuesday 14 October 2025  07:06:58 +0000 (0:00:00.193)       0:00:11.783 *******
2025-10-14 07:06:59.313131 | controller | changed: [instance]
2025-10-14 07:06:59.499740 | controller |
2025-10-14 07:06:59.499765 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:06:59.499773 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.612)       0:00:12.396 *******
2025-10-14 07:06:59.499783 | controller | ok: [instance]
2025-10-14 07:06:59.535681 | controller |
2025-10-14 07:06:59.535699 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:06:59.535706 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.186)       0:00:12.582 *******
2025-10-14 07:06:59.535726 | controller | ok: [instance]
2025-10-14 07:06:59.572230 | controller |
2025-10-14 07:06:59.572248 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:06:59.572260 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.036)       0:00:12.619 *******
2025-10-14 07:06:59.572269 | controller | ok: [instance]
2025-10-14 07:06:59.607106 | controller |
2025-10-14 07:06:59.607126 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:06:59.607135 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.036)       0:00:12.655 *******
2025-10-14 07:06:59.607145 | controller | skipping: [instance]
2025-10-14 07:06:59.638751 | controller |
2025-10-14 07:06:59.638767 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:06:59.638773 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.034)       0:00:12.690 *******
2025-10-14 07:06:59.638782 | controller | skipping: [instance]
2025-10-14 07:06:59.677101 | controller |
2025-10-14 07:06:59.677118 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:06:59.677125 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.031)       0:00:12.721 *******
2025-10-14 07:06:59.677133 | controller | ok: [instance] =>
2025-10-14 07:06:59.708640 | controller |   msg:
2025-10-14 07:06:59.708660 | controller |   - 'Commit Hash: 42b4c41831408a8e323fec3c8983b5c793b64874'
2025-10-14 07:06:59.708669 | controller |   - 'Distro Hash: 08052e9d9b38c81a7a6dd20de6e13eb78b3a47a6'
2025-10-14 07:06:59.708676 | controller |   - 'Extended Hash: '
2025-10-14 07:06:59.708683 | controller |   - 'Full Hash: 42b4c41831408a8e323fec3c8983b5c793b64874_08052e9d'
2025-10-14 07:06:59.708690 | controller |
2025-10-14 07:06:59.708696 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:06:59.708703 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.037)       0:00:12.759 *******
2025-10-14 07:06:59.708733 | controller | skipping: [instance]
2025-10-14 07:06:59.708912 | controller |
2025-10-14 07:06:59.709086 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:06:59.709285 | controller | Tuesday 14 October 2025  07:06:59 +0000 (0:00:00.032)       0:00:12.792 *******
2025-10-14 07:07:00.198133 | controller | changed: [instance]
2025-10-14 07:07:00.405104 | controller |
2025-10-14 07:07:00.405134 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:00.405142 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.488)       0:00:13.281 *******
2025-10-14 07:07:00.405180 | controller | ok: [instance]
2025-10-14 07:07:00.440976 | controller |
2025-10-14 07:07:00.441000 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:00.441009 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.206)       0:00:13.488 *******
2025-10-14 07:07:00.441020 | controller | ok: [instance]
2025-10-14 07:07:00.476926 | controller |
2025-10-14 07:07:00.476944 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:00.476952 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.035)       0:00:13.524 *******
2025-10-14 07:07:00.476960 | controller | ok: [instance]
2025-10-14 07:07:00.509234 | controller |
2025-10-14 07:07:00.509253 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:00.509260 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.036)       0:00:13.560 *******
2025-10-14 07:07:00.509269 | controller | skipping: [instance]
2025-10-14 07:07:00.509292 | controller |
2025-10-14 07:07:00.509585 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:00.541555 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.032)       0:00:13.592 *******
2025-10-14 07:07:00.541576 | controller | skipping: [instance]
2025-10-14 07:07:00.579004 | controller |
2025-10-14 07:07:00.579021 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:00.579029 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.032)       0:00:13.624 *******
2025-10-14 07:07:00.579037 | controller | ok: [instance] =>
2025-10-14 07:07:00.613071 | controller |   msg:
2025-10-14 07:07:00.613091 | controller |   - 'Commit Hash: 10df0bd91b9bc5c9fd9cc02d75c0084cd4da29a7'
2025-10-14 07:07:00.613099 | controller |   - 'Distro Hash: 36137eb30d837aacacddce802b71e00e1144495f'
2025-10-14 07:07:00.613107 | controller |   - 'Extended Hash: '
2025-10-14 07:07:00.613119 | controller |   - 'Full Hash: 10df0bd91b9bc5c9fd9cc02d75c0084cd4da29a7_36137eb3'
2025-10-14 07:07:00.613126 | controller |
2025-10-14 07:07:00.613133 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:00.613140 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.036)       0:00:13.661 *******
2025-10-14 07:07:00.613170 | controller | skipping: [instance]
2025-10-14 07:07:01.104759 | controller |
2025-10-14 07:07:01.104790 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:01.104798 | controller | Tuesday 14 October 2025  07:07:00 +0000 (0:00:00.034)       0:00:13.696 *******
2025-10-14 07:07:01.104808 | controller | changed: [instance]
2025-10-14 07:07:01.287084 | controller |
2025-10-14 07:07:01.287113 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:01.287121 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.491)       0:00:14.187 *******
2025-10-14 07:07:01.287131 | controller | ok: [instance]
2025-10-14 07:07:01.321607 | controller |
2025-10-14 07:07:01.321635 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:01.321644 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.182)       0:00:14.370 *******
2025-10-14 07:07:01.321656 | controller | ok: [instance]
2025-10-14 07:07:01.357676 | controller |
2025-10-14 07:07:01.357706 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:01.357742 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.034)       0:00:14.404 *******
2025-10-14 07:07:01.357755 | controller | ok: [instance]
2025-10-14 07:07:01.389294 | controller |
2025-10-14 07:07:01.389317 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:01.389324 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.035)       0:00:14.440 *******
2025-10-14 07:07:01.389334 | controller | skipping: [instance]
2025-10-14 07:07:01.419830 | controller |
2025-10-14 07:07:01.419855 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:01.419863 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.031)       0:00:14.472 *******
2025-10-14 07:07:01.419872 | controller | skipping: [instance]
2025-10-14 07:07:01.420017 | controller |
2025-10-14 07:07:01.420187 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:01.420340 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.030)       0:00:14.503 *******
2025-10-14 07:07:01.455445 | controller | ok: [instance] =>
2025-10-14 07:07:01.455612 | controller |   msg:
2025-10-14 07:07:01.455773 | controller |   - 'Commit Hash: 1c00d6490d88e436f26efb71f2ac96e75252e97c'
2025-10-14 07:07:01.455917 | controller |   - 'Distro Hash: f716f000a1f5c1bfea628f5aa01cee6a846fdc83'
2025-10-14 07:07:01.456053 | controller |   - 'Extended Hash: '
2025-10-14 07:07:01.456213 | controller |   - 'Full Hash: 1c00d6490d88e436f26efb71f2ac96e75252e97c_f716f000'
2025-10-14 07:07:01.456349 | controller |
2025-10-14 07:07:01.456483 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:01.456614 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.035)       0:00:14.538 *******
2025-10-14 07:07:01.486197 | controller | skipping: [instance]
2025-10-14 07:07:01.486359 | controller |
2025-10-14 07:07:01.486513 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:01.486659 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.030)       0:00:14.569 *******
2025-10-14 07:07:01.966241 | controller | changed: [instance]
2025-10-14 07:07:01.966283 | controller |
2025-10-14 07:07:01.966293 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:01.966394 | controller | Tuesday 14 October 2025  07:07:01 +0000 (0:00:00.479)       0:00:15.049 *******
2025-10-14 07:07:02.151699 | controller | ok: [instance]
2025-10-14 07:07:02.188575 | controller |
2025-10-14 07:07:02.188602 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:02.188610 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.185)       0:00:15.234 *******
2025-10-14 07:07:02.188619 | controller | ok: [instance]
2025-10-14 07:07:02.226585 | controller |
2025-10-14 07:07:02.226609 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:02.226621 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.036)       0:00:15.271 *******
2025-10-14 07:07:02.226632 | controller | ok: [instance]
2025-10-14 07:07:02.259684 | controller |
2025-10-14 07:07:02.259727 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:02.259737 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.038)       0:00:15.309 *******
2025-10-14 07:07:02.259747 | controller | skipping: [instance]
2025-10-14 07:07:02.292095 | controller |
2025-10-14 07:07:02.292119 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:02.292128 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.033)       0:00:15.342 *******
2025-10-14 07:07:02.292139 | controller | skipping: [instance]
2025-10-14 07:07:02.329342 | controller |
2025-10-14 07:07:02.329370 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:02.329378 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.032)       0:00:15.375 *******
2025-10-14 07:07:02.329387 | controller | ok: [instance] =>
2025-10-14 07:07:02.329538 | controller |   msg:
2025-10-14 07:07:02.329691 | controller |   - 'Commit Hash: c4acc5639fd2329372142e39464fcca0209b0018'
2025-10-14 07:07:02.329851 | controller |   - 'Distro Hash: d3ef83374427f80feb30d6883ae9dd9d85110091'
2025-10-14 07:07:02.330002 | controller |   - 'Extended Hash: '
2025-10-14 07:07:02.330142 | controller |   - 'Full Hash: c4acc5639fd2329372142e39464fcca0209b0018_d3ef8337'
2025-10-14 07:07:02.330301 | controller |
2025-10-14 07:07:02.330442 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:02.330576 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.037)       0:00:15.412 *******
2025-10-14 07:07:02.362063 | controller | skipping: [instance]
2025-10-14 07:07:02.362257 | controller |
2025-10-14 07:07:02.362412 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:02.362552 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.032)       0:00:15.445 *******
2025-10-14 07:07:02.850315 | controller | changed: [instance]
2025-10-14 07:07:03.040760 | controller |
2025-10-14 07:07:03.040790 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:03.040799 | controller | Tuesday 14 October 2025  07:07:02 +0000 (0:00:00.487)       0:00:15.933 *******
2025-10-14 07:07:03.040809 | controller | ok: [instance]
2025-10-14 07:07:03.076945 | controller |
2025-10-14 07:07:03.076968 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:03.076976 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.190)       0:00:16.123 *******
2025-10-14 07:07:03.076985 | controller | ok: [instance]
2025-10-14 07:07:03.113909 | controller |
2025-10-14 07:07:03.113935 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:03.113942 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.036)       0:00:16.160 *******
2025-10-14 07:07:03.113952 | controller | ok: [instance]
2025-10-14 07:07:03.148990 | controller |
2025-10-14 07:07:03.149016 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:03.149023 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.036)       0:00:16.196 *******
2025-10-14 07:07:03.149033 | controller | skipping: [instance]
2025-10-14 07:07:03.182190 | controller |
2025-10-14 07:07:03.182219 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:03.182227 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.035)       0:00:16.232 *******
2025-10-14 07:07:03.182237 | controller | skipping: [instance]
2025-10-14 07:07:03.220235 | controller |
2025-10-14 07:07:03.220267 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:03.220275 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.033)       0:00:16.265 *******
2025-10-14 07:07:03.220285 | controller | ok: [instance] =>
2025-10-14 07:07:03.220308 | controller |   msg:
2025-10-14 07:07:03.220315 | controller |   - 'Commit Hash: 2f31846d73c044740ccaaa4204720f0b94d64145'
2025-10-14 07:07:03.220320 | controller |   - 'Distro Hash: c2222caab5f6844f7cc1a222b43bcf297c390d95'
2025-10-14 07:07:03.220326 | controller |   - 'Extended Hash: '
2025-10-14 07:07:03.220337 | controller |   - 'Full Hash: 2f31846d73c044740ccaaa4204720f0b94d64145_c2222caa'
2025-10-14 07:07:03.220345 | controller |
2025-10-14 07:07:03.220529 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:03.252703 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.037)       0:00:16.303 *******
2025-10-14 07:07:03.252738 | controller | skipping: [instance]
2025-10-14 07:07:03.750368 | controller |
2025-10-14 07:07:03.750398 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:03.750406 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.032)       0:00:16.335 *******
2025-10-14 07:07:03.750422 | controller | changed: [instance]
2025-10-14 07:07:03.942027 | controller |
2025-10-14 07:07:03.942055 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:03.942063 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.497)       0:00:16.833 *******
2025-10-14 07:07:03.942073 | controller | ok: [instance]
2025-10-14 07:07:03.978830 | controller |
2025-10-14 07:07:03.978852 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:03.978860 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.191)       0:00:17.024 *******
2025-10-14 07:07:03.978869 | controller | ok: [instance]
2025-10-14 07:07:04.017240 | controller |
2025-10-14 07:07:04.017273 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:04.017281 | controller | Tuesday 14 October 2025  07:07:03 +0000 (0:00:00.036)       0:00:17.061 *******
2025-10-14 07:07:04.017291 | controller | ok: [instance]
2025-10-14 07:07:04.017316 | controller |
2025-10-14 07:07:04.017322 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:04.017330 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.038)       0:00:17.100 *******
2025-10-14 07:07:04.052655 | controller | skipping: [instance]
2025-10-14 07:07:04.088259 | controller |
2025-10-14 07:07:04.088288 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:04.088296 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.035)       0:00:17.135 *******
2025-10-14 07:07:04.088306 | controller | skipping: [instance]
2025-10-14 07:07:04.127265 | controller |
2025-10-14 07:07:04.127300 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:04.127310 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.035)       0:00:17.171 *******
2025-10-14 07:07:04.127322 | controller | ok: [instance] =>
2025-10-14 07:07:04.161667 | controller |   msg:
2025-10-14 07:07:04.161699 | controller |   - 'Commit Hash: c5c11964947c40ba70b2632fc83b98a9d01ca138'
2025-10-14 07:07:04.161707 | controller |   - 'Distro Hash: f77934fbd9bbd9df4322c84df180d383a04a5f90'
2025-10-14 07:07:04.161736 | controller |   - 'Extended Hash: '
2025-10-14 07:07:04.161743 | controller |   - 'Full Hash: c5c11964947c40ba70b2632fc83b98a9d01ca138_f77934fb'
2025-10-14 07:07:04.161749 | controller |
2025-10-14 07:07:04.161756 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:04.161762 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.038)       0:00:17.209 *******
2025-10-14 07:07:04.161771 | controller | skipping: [instance]
2025-10-14 07:07:04.651141 | controller |
2025-10-14 07:07:04.651190 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:04.651199 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.034)       0:00:17.244 *******
2025-10-14 07:07:04.651209 | controller | changed: [instance]
2025-10-14 07:07:04.845645 | controller |
2025-10-14 07:07:04.845676 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:04.845684 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.489)       0:00:17.734 *******
2025-10-14 07:07:04.845693 | controller | ok: [instance]
2025-10-14 07:07:04.882059 | controller |
2025-10-14 07:07:04.882090 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:04.882100 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.194)       0:00:17.928 *******
2025-10-14 07:07:04.882112 | controller | ok: [instance]
2025-10-14 07:07:04.919805 | controller |
2025-10-14 07:07:04.919837 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:04.919853 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.036)       0:00:17.964 *******
2025-10-14 07:07:04.919863 | controller | ok: [instance]
2025-10-14 07:07:04.953138 | controller |
2025-10-14 07:07:04.953194 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:04.953203 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.037)       0:00:18.002 *******
2025-10-14 07:07:04.953215 | controller | skipping: [instance]
2025-10-14 07:07:04.986092 | controller |
2025-10-14 07:07:04.986114 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:04.986123 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.033)       0:00:18.036 *******
2025-10-14 07:07:04.986134 | controller | skipping: [instance]
2025-10-14 07:07:04.986331 | controller |
2025-10-14 07:07:04.986508 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:04.986669 | controller | Tuesday 14 October 2025  07:07:04 +0000 (0:00:00.033)       0:00:18.069 *******
2025-10-14 07:07:05.026258 | controller | ok: [instance] =>
2025-10-14 07:07:05.026435 | controller |   msg:
2025-10-14 07:07:05.026580 | controller |   - 'Commit Hash: 6f8decf0b4f1aa2e96292b6a2ffc28249fe4af5e'
2025-10-14 07:07:05.026733 | controller |   - 'Distro Hash: dc05b8990d42402ddb4135e94728608511ecf5b4'
2025-10-14 07:07:05.026870 | controller |   - 'Extended Hash: '
2025-10-14 07:07:05.027011 | controller |   - 'Full Hash: 6f8decf0b4f1aa2e96292b6a2ffc28249fe4af5e_dc05b899'
2025-10-14 07:07:05.027137 | controller |
2025-10-14 07:07:05.027292 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:05.027428 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.039)       0:00:18.109 *******
2025-10-14 07:07:05.059484 | controller | skipping: [instance]
2025-10-14 07:07:05.059672 | controller |
2025-10-14 07:07:05.059851 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:05.060004 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.033)       0:00:18.142 *******
2025-10-14 07:07:05.554344 | controller | changed: [instance]
2025-10-14 07:07:05.758137 | controller |
2025-10-14 07:07:05.758185 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:05.758193 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.494)       0:00:18.637 *******
2025-10-14 07:07:05.758203 | controller | ok: [instance]
2025-10-14 07:07:05.799851 | controller |
2025-10-14 07:07:05.799882 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:05.799890 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.203)       0:00:18.840 *******
2025-10-14 07:07:05.799900 | controller | ok: [instance]
2025-10-14 07:07:05.840577 | controller |
2025-10-14 07:07:05.840609 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:05.840617 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.041)       0:00:18.882 *******
2025-10-14 07:07:05.840627 | controller | ok: [instance]
2025-10-14 07:07:05.877300 | controller |
2025-10-14 07:07:05.877346 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:05.877357 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.040)       0:00:18.923 *******
2025-10-14 07:07:05.877370 | controller | skipping: [instance]
2025-10-14 07:07:05.877404 | controller |
2025-10-14 07:07:05.877562 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:05.877602 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.036)       0:00:18.960 *******
2025-10-14 07:07:05.913870 | controller | skipping: [instance]
2025-10-14 07:07:05.914068 | controller |
2025-10-14 07:07:05.914288 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:05.914460 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.036)       0:00:18.996 *******
2025-10-14 07:07:05.956360 | controller | ok: [instance] =>
2025-10-14 07:07:05.956533 | controller |   msg:
2025-10-14 07:07:05.956672 | controller |   - 'Commit Hash: 347fdbc9b4595a10b726526b3c0b5928e5b7fcf2'
2025-10-14 07:07:05.956825 | controller |   - 'Distro Hash: 3fd39337c631f89be60419b65642da6b614e1f63'
2025-10-14 07:07:05.956957 | controller |   - 'Extended Hash: '
2025-10-14 07:07:05.957104 | controller |   - 'Full Hash: 347fdbc9b4595a10b726526b3c0b5928e5b7fcf2_3fd39337'
2025-10-14 07:07:05.957259 | controller |
2025-10-14 07:07:05.957410 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:05.957545 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.042)       0:00:19.039 *******
2025-10-14 07:07:05.993947 | controller | skipping: [instance]
2025-10-14 07:07:05.994110 | controller |
2025-10-14 07:07:05.994279 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:05.994422 | controller | Tuesday 14 October 2025  07:07:05 +0000 (0:00:00.037)       0:00:19.077 *******
2025-10-14 07:07:06.509010 | controller | changed: [instance]
2025-10-14 07:07:06.709425 | controller |
2025-10-14 07:07:06.709454 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:06.709462 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.514)       0:00:19.591 *******
2025-10-14 07:07:06.709472 | controller | ok: [instance]
2025-10-14 07:07:06.751800 | controller |
2025-10-14 07:07:06.751826 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:06.751834 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.200)       0:00:19.792 *******
2025-10-14 07:07:06.751844 | controller | ok: [instance]
2025-10-14 07:07:06.792843 | controller |
2025-10-14 07:07:06.792868 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:06.792876 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.042)       0:00:19.834 *******
2025-10-14 07:07:06.792885 | controller | ok: [instance]
2025-10-14 07:07:06.830415 | controller |
2025-10-14 07:07:06.830442 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:06.830450 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.041)       0:00:19.875 *******
2025-10-14 07:07:06.830461 | controller | skipping: [instance]
2025-10-14 07:07:06.866888 | controller |
2025-10-14 07:07:06.866925 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:06.866933 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.037)       0:00:19.913 *******
2025-10-14 07:07:06.866943 | controller | skipping: [instance]
2025-10-14 07:07:06.912587 | controller |
2025-10-14 07:07:06.912613 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:06.912621 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.036)       0:00:19.949 *******
2025-10-14 07:07:06.912631 | controller | ok: [instance] =>
2025-10-14 07:07:06.949687 | controller |   msg:
2025-10-14 07:07:06.949714 | controller |   - 'Commit Hash: 1fd12c29b339f30fe823e2b5beba14b5f241e52a'
2025-10-14 07:07:06.949741 | controller |   - 'Distro Hash: 0d69372941efaea8b5f054a1deea5da22dcf719f'
2025-10-14 07:07:06.949746 | controller |   - 'Extended Hash: '
2025-10-14 07:07:06.949758 | controller |   - 'Full Hash: 1fd12c29b339f30fe823e2b5beba14b5f241e52a_0d693729'
2025-10-14 07:07:06.949764 | controller |
2025-10-14 07:07:06.949769 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:06.949775 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.045)       0:00:19.995 *******
2025-10-14 07:07:06.949786 | controller | skipping: [instance]
2025-10-14 07:07:07.468680 | controller |
2025-10-14 07:07:07.468714 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:07.468740 | controller | Tuesday 14 October 2025  07:07:06 +0000 (0:00:00.037)       0:00:20.032 *******
2025-10-14 07:07:07.468750 | controller | changed: [instance]
2025-10-14 07:07:07.680821 | controller |
2025-10-14 07:07:07.680853 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:07.680861 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.518)       0:00:20.551 *******
2025-10-14 07:07:07.680871 | controller | ok: [instance]
2025-10-14 07:07:07.721806 | controller |
2025-10-14 07:07:07.721842 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:07.721850 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.212)       0:00:20.763 *******
2025-10-14 07:07:07.721861 | controller | ok: [instance]
2025-10-14 07:07:07.764795 | controller |
2025-10-14 07:07:07.764830 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:07.764846 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.040)       0:00:20.804 *******
2025-10-14 07:07:07.764856 | controller | ok: [instance]
2025-10-14 07:07:07.802614 | controller |
2025-10-14 07:07:07.802646 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:07.802654 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.043)       0:00:20.847 *******
2025-10-14 07:07:07.802664 | controller | skipping: [instance]
2025-10-14 07:07:07.839370 | controller |
2025-10-14 07:07:07.839400 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:07.839407 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.037)       0:00:20.885 *******
2025-10-14 07:07:07.839417 | controller | skipping: [instance]
2025-10-14 07:07:07.881513 | controller |
2025-10-14 07:07:07.881546 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:07.881554 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.036)       0:00:20.922 *******
2025-10-14 07:07:07.881564 | controller | ok: [instance] =>
2025-10-14 07:07:07.881749 | controller |   msg:
2025-10-14 07:07:07.881903 | controller |   - 'Commit Hash: e4b40af0ae3698fbbbbfb8c22468b33aae80e6d7'
2025-10-14 07:07:07.882047 | controller |   - 'Distro Hash: 264c03cc165183f13c27593de11341e21fc08637'
2025-10-14 07:07:07.882209 | controller |   - 'Extended Hash: '
2025-10-14 07:07:07.882352 | controller |   - 'Full Hash: e4b40af0ae3698fbbbbfb8c22468b33aae80e6d7_264c03cc'
2025-10-14 07:07:07.882479 | controller |
2025-10-14 07:07:07.882615 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:07.882769 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.042)       0:00:20.964 *******
2025-10-14 07:07:07.921300 | controller | skipping: [instance]
2025-10-14 07:07:07.921490 | controller |
2025-10-14 07:07:07.921642 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:07.921813 | controller | Tuesday 14 October 2025  07:07:07 +0000 (0:00:00.039)       0:00:21.004 *******
2025-10-14 07:07:08.444476 | controller | changed: [instance]
2025-10-14 07:07:08.647822 | controller |
2025-10-14 07:07:08.647855 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:08.647863 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.522)       0:00:21.527 *******
2025-10-14 07:07:08.647873 | controller | ok: [instance]
2025-10-14 07:07:08.689049 | controller |
2025-10-14 07:07:08.689080 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:08.689088 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.203)       0:00:21.730 *******
2025-10-14 07:07:08.689097 | controller | ok: [instance]
2025-10-14 07:07:08.731423 | controller |
2025-10-14 07:07:08.731455 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:08.731463 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.041)       0:00:21.772 *******
2025-10-14 07:07:08.731473 | controller | ok: [instance]
2025-10-14 07:07:08.769786 | controller |
2025-10-14 07:07:08.769818 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:08.769826 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.042)       0:00:21.814 *******
2025-10-14 07:07:08.769836 | controller | skipping: [instance]
2025-10-14 07:07:08.807731 | controller |
2025-10-14 07:07:08.807768 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:08.807778 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.038)       0:00:21.852 *******
2025-10-14 07:07:08.807790 | controller | skipping: [instance]
2025-10-14 07:07:08.852565 | controller |
2025-10-14 07:07:08.852598 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:08.852606 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.037)       0:00:21.890 *******
2025-10-14 07:07:08.852616 | controller | ok: [instance] =>
2025-10-14 07:07:08.889561 | controller |   msg:
2025-10-14 07:07:08.889595 | controller |   - 'Commit Hash: 3c01b7181572c95dac462eb19c3121e36cb0fe95'
2025-10-14 07:07:08.889605 | controller |   - 'Distro Hash: 912dfd188ece75998eaa520827a3687e49d47907'
2025-10-14 07:07:08.889612 | controller |   - 'Extended Hash: '
2025-10-14 07:07:08.889627 | controller |   - 'Full Hash: 3c01b7181572c95dac462eb19c3121e36cb0fe95_912dfd18'
2025-10-14 07:07:08.889634 | controller |
2025-10-14 07:07:08.889641 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:08.889653 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.044)       0:00:21.934 *******
2025-10-14 07:07:08.889664 | controller | skipping: [instance]
2025-10-14 07:07:08.889858 | controller |
2025-10-14 07:07:08.890035 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:08.890202 | controller | Tuesday 14 October 2025  07:07:08 +0000 (0:00:00.037)       0:00:21.972 *******
2025-10-14 07:07:09.399259 | controller | changed: [instance]
2025-10-14 07:07:09.399381 | controller |
2025-10-14 07:07:09.399412 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:09.399424 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.508)       0:00:22.481 *******
2025-10-14 07:07:09.616915 | controller | ok: [instance]
2025-10-14 07:07:09.653956 | controller |
2025-10-14 07:07:09.653984 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:09.653993 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.218)       0:00:22.699 *******
2025-10-14 07:07:09.654004 | controller | ok: [instance]
2025-10-14 07:07:09.693264 | controller |
2025-10-14 07:07:09.693299 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:09.693307 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.037)       0:00:22.737 *******
2025-10-14 07:07:09.693318 | controller | ok: [instance]
2025-10-14 07:07:09.693345 | controller |
2025-10-14 07:07:09.693632 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:09.728138 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.039)       0:00:22.776 *******
2025-10-14 07:07:09.728199 | controller | skipping: [instance]
2025-10-14 07:07:09.761818 | controller |
2025-10-14 07:07:09.761844 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:09.761852 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.034)       0:00:22.811 *******
2025-10-14 07:07:09.761861 | controller | skipping: [instance]
2025-10-14 07:07:09.801612 | controller |
2025-10-14 07:07:09.801636 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:09.801644 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.033)       0:00:22.844 *******
2025-10-14 07:07:09.801653 | controller | ok: [instance] =>
2025-10-14 07:07:09.837248 | controller |   msg:
2025-10-14 07:07:09.837280 | controller |   - 'Commit Hash: d9ea9e7bae2aa29d59ccfd2dbe6cc04824f7746f'
2025-10-14 07:07:09.837288 | controller |   - 'Distro Hash: 1e622c15deac7470572c348edc30963e4f38b364'
2025-10-14 07:07:09.837294 | controller |   - 'Extended Hash: '
2025-10-14 07:07:09.837300 | controller |   - 'Full Hash: d9ea9e7bae2aa29d59ccfd2dbe6cc04824f7746f_1e622c15'
2025-10-14 07:07:09.837306 | controller |
2025-10-14 07:07:09.837311 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:09.837317 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.039)       0:00:22.884 *******
2025-10-14 07:07:09.837326 | controller | skipping: [instance]
2025-10-14 07:07:09.837354 | controller |
2025-10-14 07:07:09.837362 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:10.346964 | controller | Tuesday 14 October 2025  07:07:09 +0000 (0:00:00.036)       0:00:22.920 *******
2025-10-14 07:07:10.346999 | controller | changed: [instance]
2025-10-14 07:07:10.542235 | controller |
2025-10-14 07:07:10.542264 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:10.542272 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.509)       0:00:23.429 *******
2025-10-14 07:07:10.542282 | controller | ok: [instance]
2025-10-14 07:07:10.542596 | controller |
2025-10-14 07:07:10.578123 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:10.578146 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.195)       0:00:23.625 *******
2025-10-14 07:07:10.578171 | controller | ok: [instance]
2025-10-14 07:07:10.614008 | controller |
2025-10-14 07:07:10.614029 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:10.614044 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.035)       0:00:23.661 *******
2025-10-14 07:07:10.614055 | controller | ok: [instance]
2025-10-14 07:07:10.645982 | controller |
2025-10-14 07:07:10.646009 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:10.646018 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.035)       0:00:23.697 *******
2025-10-14 07:07:10.646029 | controller | skipping: [instance]
2025-10-14 07:07:10.678104 | controller |
2025-10-14 07:07:10.678131 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:10.678138 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.031)       0:00:23.729 *******
2025-10-14 07:07:10.678148 | controller | skipping: [instance]
2025-10-14 07:07:10.715178 | controller |
2025-10-14 07:07:10.715203 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:10.715210 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.032)       0:00:23.761 *******
2025-10-14 07:07:10.715224 | controller | ok: [instance] =>
2025-10-14 07:07:10.748100 | controller |   msg:
2025-10-14 07:07:10.748123 | controller |   - 'Commit Hash: ba397f07a7331190208c93368ee23826ac4e2707'
2025-10-14 07:07:10.748130 | controller |   - 'Distro Hash: 9d6e596a15e166e2cafd87cd8c461148f963eb24'
2025-10-14 07:07:10.748136 | controller |   - 'Extended Hash: '
2025-10-14 07:07:10.748142 | controller |   - 'Full Hash: ba397f07a7331190208c93368ee23826ac4e2707_9d6e596a'
2025-10-14 07:07:10.748164 | controller |
2025-10-14 07:07:10.748173 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:10.748179 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.036)       0:00:23.797 *******
2025-10-14 07:07:10.748188 | controller | skipping: [instance]
2025-10-14 07:07:11.243326 | controller |
2025-10-14 07:07:11.243355 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:11.243363 | controller | Tuesday 14 October 2025  07:07:10 +0000 (0:00:00.033)       0:00:23.831 *******
2025-10-14 07:07:11.243373 | controller | changed: [instance]
2025-10-14 07:07:11.433896 | controller |
2025-10-14 07:07:11.433926 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:11.433935 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.495)       0:00:24.326 *******
2025-10-14 07:07:11.433944 | controller | ok: [instance]
2025-10-14 07:07:11.472232 | controller |
2025-10-14 07:07:11.472263 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:11.472271 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.190)       0:00:24.516 *******
2025-10-14 07:07:11.472282 | controller | ok: [instance]
2025-10-14 07:07:11.509710 | controller |
2025-10-14 07:07:11.509763 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:11.509774 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.038)       0:00:24.555 *******
2025-10-14 07:07:11.509786 | controller | ok: [instance]
2025-10-14 07:07:11.543353 | controller |
2025-10-14 07:07:11.543376 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:11.543383 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.037)       0:00:24.592 *******
2025-10-14 07:07:11.543393 | controller | skipping: [instance]
2025-10-14 07:07:11.575792 | controller |
2025-10-14 07:07:11.575814 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:11.575823 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.033)       0:00:24.626 *******
2025-10-14 07:07:11.575834 | controller | skipping: [instance]
2025-10-14 07:07:11.576004 | controller |
2025-10-14 07:07:11.576197 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:11.576346 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.032)       0:00:24.659 *******
2025-10-14 07:07:11.614538 | controller | ok: [instance] =>
2025-10-14 07:07:11.614750 | controller |   msg:
2025-10-14 07:07:11.614933 | controller |   - 'Commit Hash: c014f81a8647287f6dcc339321c1256f5a2e82d5'
2025-10-14 07:07:11.615103 | controller |   - 'Distro Hash: bcbfdccc8f5b03eea0d8708dcfc1123a723c6be6'
2025-10-14 07:07:11.615289 | controller |   - 'Extended Hash: '
2025-10-14 07:07:11.615444 | controller |   - 'Full Hash: c014f81a8647287f6dcc339321c1256f5a2e82d5_bcbfdccc'
2025-10-14 07:07:11.615576 | controller |
2025-10-14 07:07:11.615711 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:11.615864 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.038)       0:00:24.697 *******
2025-10-14 07:07:11.647765 | controller | skipping: [instance]
2025-10-14 07:07:11.647947 | controller |
2025-10-14 07:07:11.648120 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:11.648312 | controller | Tuesday 14 October 2025  07:07:11 +0000 (0:00:00.033)       0:00:24.731 *******
2025-10-14 07:07:12.150120 | controller | changed: [instance]
2025-10-14 07:07:12.346597 | controller |
2025-10-14 07:07:12.346627 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:12.346634 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.501)       0:00:25.233 *******
2025-10-14 07:07:12.346644 | controller | ok: [instance]
2025-10-14 07:07:12.384115 | controller |
2025-10-14 07:07:12.384139 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:12.384147 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.196)       0:00:25.429 *******
2025-10-14 07:07:12.384178 | controller | ok: [instance]
2025-10-14 07:07:12.422792 | controller |
2025-10-14 07:07:12.422818 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:12.422826 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.037)       0:00:25.467 *******
2025-10-14 07:07:12.422835 | controller | ok: [instance]
2025-10-14 07:07:12.457406 | controller |
2025-10-14 07:07:12.457429 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:12.457438 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.038)       0:00:25.505 *******
2025-10-14 07:07:12.457449 | controller | skipping: [instance]
2025-10-14 07:07:12.490225 | controller |
2025-10-14 07:07:12.490257 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:12.490265 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.034)       0:00:25.540 *******
2025-10-14 07:07:12.490275 | controller | skipping: [instance]
2025-10-14 07:07:12.490299 | controller |
2025-10-14 07:07:12.490308 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:12.490450 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.032)       0:00:25.573 *******
2025-10-14 07:07:12.529273 | controller | ok: [instance] =>
2025-10-14 07:07:12.562643 | controller |   msg:
2025-10-14 07:07:12.562670 | controller |   - 'Commit Hash: ff70d03bf5bc0bb6f3540a02d301b5c6775e6022'
2025-10-14 07:07:12.562679 | controller |   - 'Distro Hash: dbfdef113e9e01d0e769892fee3106e524d23dd9'
2025-10-14 07:07:12.562686 | controller |   - 'Extended Hash: '
2025-10-14 07:07:12.562694 | controller |   - 'Full Hash: ff70d03bf5bc0bb6f3540a02d301b5c6775e6022_dbfdef11'
2025-10-14 07:07:12.562701 | controller |
2025-10-14 07:07:12.562715 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:12.562747 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.038)       0:00:25.611 *******
2025-10-14 07:07:12.562758 | controller | skipping: [instance]
2025-10-14 07:07:12.562934 | controller |
2025-10-14 07:07:12.563254 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:12.563412 | controller | Tuesday 14 October 2025  07:07:12 +0000 (0:00:00.034)       0:00:25.646 *******
2025-10-14 07:07:13.058581 | controller | changed: [instance]
2025-10-14 07:07:13.247935 | controller |
2025-10-14 07:07:13.247965 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:13.247973 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.495)       0:00:26.141 *******
2025-10-14 07:07:13.247982 | controller | ok: [instance]
2025-10-14 07:07:13.284089 | controller |
2025-10-14 07:07:13.284115 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:13.284123 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.189)       0:00:26.330 *******
2025-10-14 07:07:13.284132 | controller | ok: [instance]
2025-10-14 07:07:13.322278 | controller |
2025-10-14 07:07:13.322301 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:13.322315 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.036)       0:00:26.367 *******
2025-10-14 07:07:13.322325 | controller | ok: [instance]
2025-10-14 07:07:13.355326 | controller |
2025-10-14 07:07:13.355350 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:13.355357 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.038)       0:00:26.405 *******
2025-10-14 07:07:13.355367 | controller | skipping: [instance]
2025-10-14 07:07:13.386886 | controller |
2025-10-14 07:07:13.386920 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:13.386928 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.033)       0:00:26.438 *******
2025-10-14 07:07:13.386939 | controller | skipping: [instance]
2025-10-14 07:07:13.424261 | controller |
2025-10-14 07:07:13.424295 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:13.424303 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.031)       0:00:26.470 *******
2025-10-14 07:07:13.424314 | controller | ok: [instance] =>
2025-10-14 07:07:13.455916 | controller |   msg:
2025-10-14 07:07:13.455946 | controller |   - 'Commit Hash: 91ba84bc002c318a7f961d084e992b2e88ffd5b3'
2025-10-14 07:07:13.455954 | controller |   - 'Distro Hash: 7cde1ad1a2bae194d58954938ee5a3fb267415a1'
2025-10-14 07:07:13.455959 | controller |   - 'Extended Hash: '
2025-10-14 07:07:13.455965 | controller |   - 'Full Hash: 91ba84bc002c318a7f961d084e992b2e88ffd5b3_7cde1ad1'
2025-10-14 07:07:13.455971 | controller |
2025-10-14 07:07:13.455977 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:13.455982 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.036)       0:00:26.506 *******
2025-10-14 07:07:13.455992 | controller | skipping: [instance]
2025-10-14 07:07:13.957118 | controller |
2025-10-14 07:07:13.957147 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:13.957173 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.032)       0:00:26.539 *******
2025-10-14 07:07:13.957184 | controller | changed: [instance]
2025-10-14 07:07:14.146224 | controller |
2025-10-14 07:07:14.146254 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:14.146262 | controller | Tuesday 14 October 2025  07:07:13 +0000 (0:00:00.500)       0:00:27.040 *******
2025-10-14 07:07:14.146272 | controller | ok: [instance]
2025-10-14 07:07:14.146604 | controller |
2025-10-14 07:07:14.182842 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:14.182869 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.189)       0:00:27.229 *******
2025-10-14 07:07:14.182881 | controller | ok: [instance]
2025-10-14 07:07:14.220971 | controller |
2025-10-14 07:07:14.221002 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:14.221012 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.036)       0:00:27.265 *******
2025-10-14 07:07:14.221023 | controller | ok: [instance]
2025-10-14 07:07:14.254122 | controller |
2025-10-14 07:07:14.254148 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:14.254179 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.038)       0:00:27.303 *******
2025-10-14 07:07:14.254189 | controller | skipping: [instance]
2025-10-14 07:07:14.286407 | controller |
2025-10-14 07:07:14.286431 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:14.286439 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.033)       0:00:27.337 *******
2025-10-14 07:07:14.286452 | controller | skipping: [instance]
2025-10-14 07:07:14.323275 | controller |
2025-10-14 07:07:14.323303 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:14.323311 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.032)       0:00:27.369 *******
2025-10-14 07:07:14.323320 | controller | ok: [instance] =>
2025-10-14 07:07:14.323468 | controller |   msg:
2025-10-14 07:07:14.323610 | controller |   - 'Commit Hash: dc98a8463506ac520c469adb0ef47d0f7753905a'
2025-10-14 07:07:14.323759 | controller |   - 'Distro Hash: 9d02f069373e2f7552c7b73356c279dc6478ea42'
2025-10-14 07:07:14.323892 | controller |   - 'Extended Hash: '
2025-10-14 07:07:14.324033 | controller |   - 'Full Hash: dc98a8463506ac520c469adb0ef47d0f7753905a_9d02f069'
2025-10-14 07:07:14.324185 | controller |
2025-10-14 07:07:14.324334 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:14.324468 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.037)       0:00:27.406 *******
2025-10-14 07:07:14.356193 | controller | skipping: [instance]
2025-10-14 07:07:14.356396 | controller |
2025-10-14 07:07:14.356542 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:14.356678 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.032)       0:00:27.439 *******
2025-10-14 07:07:14.851296 | controller | changed: [instance]
2025-10-14 07:07:15.040108 | controller |
2025-10-14 07:07:15.040136 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:15.040144 | controller | Tuesday 14 October 2025  07:07:14 +0000 (0:00:00.494)       0:00:27.934 *******
2025-10-14 07:07:15.040172 | controller | ok: [instance]
2025-10-14 07:07:15.076274 | controller |
2025-10-14 07:07:15.076301 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:15.076311 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.188)       0:00:28.123 *******
2025-10-14 07:07:15.076323 | controller | ok: [instance]
2025-10-14 07:07:15.076350 | controller |
2025-10-14 07:07:15.076360 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:15.076430 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.036)       0:00:28.159 *******
2025-10-14 07:07:15.112861 | controller | ok: [instance]
2025-10-14 07:07:15.166232 | controller |
2025-10-14 07:07:15.166261 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:15.166269 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.036)       0:00:28.196 *******
2025-10-14 07:07:15.166279 | controller | skipping: [instance]
2025-10-14 07:07:15.166301 | controller |
2025-10-14 07:07:15.166505 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:15.199390 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.053)       0:00:28.249 *******
2025-10-14 07:07:15.199412 | controller | skipping: [instance]
2025-10-14 07:07:15.236869 | controller |
2025-10-14 07:07:15.236894 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:15.236901 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.032)       0:00:28.282 *******
2025-10-14 07:07:15.236910 | controller | ok: [instance] =>
2025-10-14 07:07:15.269076 | controller |   msg:
2025-10-14 07:07:15.269101 | controller |   - 'Commit Hash: 8515371b7cceebd4282e09f1d8f0cc842df82855'
2025-10-14 07:07:15.269110 | controller |   - 'Distro Hash: a1e336c76d2cdd49a53051230126c07d71e5dd67'
2025-10-14 07:07:15.269118 | controller |   - 'Extended Hash: '
2025-10-14 07:07:15.269125 | controller |   - 'Full Hash: 8515371b7cceebd4282e09f1d8f0cc842df82855_a1e336c7'
2025-10-14 07:07:15.269130 | controller |
2025-10-14 07:07:15.269136 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:15.269141 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.037)       0:00:28.319 *******
2025-10-14 07:07:15.269165 | controller | skipping: [instance]
2025-10-14 07:07:15.770226 | controller |
2025-10-14 07:07:15.770255 | controller | TASK [dlrn_promote : Get commit.yaml file] *************************************
2025-10-14 07:07:15.770263 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.032)       0:00:28.352 *******
2025-10-14 07:07:15.770272 | controller | changed: [instance]
2025-10-14 07:07:15.770295 | controller |
2025-10-14 07:07:15.770523 | controller | TASK [dlrn_promote : Load data from commit.yaml file] **************************
2025-10-14 07:07:15.960883 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.501)       0:00:28.853 *******
2025-10-14 07:07:15.960916 | controller | ok: [instance]
2025-10-14 07:07:15.997758 | controller |
2025-10-14 07:07:15.997789 | controller | TASK [dlrn_promote : Filter slurp data from commit.yaml] ***********************
2025-10-14 07:07:15.997797 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.190)       0:00:29.043 *******
2025-10-14 07:07:15.997808 | controller | ok: [instance]
2025-10-14 07:07:16.036182 | controller |
2025-10-14 07:07:16.036216 | controller | TASK [dlrn_promote : Get individual commit/distro hashes] **********************
2025-10-14 07:07:16.036235 | controller | Tuesday 14 October 2025  07:07:15 +0000 (0:00:00.036)       0:00:29.080 *******
2025-10-14 07:07:16.036248 | controller | ok: [instance]
2025-10-14 07:07:16.069933 | controller |
2025-10-14 07:07:16.069962 | controller | TASK [dlrn_promote : Get individual extended hash - if it is not None] *********
2025-10-14 07:07:16.069969 | controller | Tuesday 14 October 2025  07:07:16 +0000 (0:00:00.038)       0:00:29.119 *******
2025-10-14 07:07:16.069979 | controller | skipping: [instance]
2025-10-14 07:07:16.104513 | controller |
2025-10-14 07:07:16.104547 | controller | TASK [dlrn_promote : Add extended_hash to full_hash if defined] ****************
2025-10-14 07:07:16.104561 | controller | Tuesday 14 October 2025  07:07:16 +0000 (0:00:00.033)       0:00:29.152 *******
2025-10-14 07:07:16.104573 | controller | skipping: [instance]
2025-10-14 07:07:16.104757 | controller |
2025-10-14 07:07:16.104900 | controller | TASK [dlrn_promote : Print hash infos] *****************************************
2025-10-14 07:07:16.105039 | controller | Tuesday 14 October 2025  07:07:16 +0000 (0:00:00.034)       0:00:29.187 *******
2025-10-14 07:07:16.145023 | controller | ok: [instance] =>
2025-10-14 07:07:16.145248 | controller |   msg:
2025-10-14 07:07:16.145425 | controller |   - 'Commit Hash: 013accbfd179753bc3f0d1f4e5bed07a4fd9f771'
2025-10-14 07:07:16.145590 | controller |   - 'Distro Hash: 0c88e46727170fa3619380fe22c70ce33ea3c02a'
2025-10-14 07:07:16.145765 | controller |   - 'Extended Hash: '
2025-10-14 07:07:16.145906 | controller |   - 'Full Hash: 013accbfd179753bc3f0d1f4e5bed07a4fd9f771_0c88e467'
2025-10-14 07:07:16.146032 | controller |
2025-10-14 07:07:16.146186 | controller | TASK [dlrn_promote : Run promotion] ********************************************
2025-10-14 07:07:16.146334 | controller | Tuesday 14 October 2025  07:07:16 +0000 (0:00:00.040)       0:00:29.228 *******
2025-10-14 07:07:16.180140 | controller | skipping: [instance]
2025-10-14 07:07:16.180397 | controller |
2025-10-14 07:07:16.180570 | controller | TASK [dlrn_promote : Promote hash for component line] **************************
2025-10-14 07:07:16.180751 | controller | Tuesday 14 October 2025  07:07:16 +0000 (0:00:00.035)       0:00:29.263 *******
2025-10-14 07:07:16.216412 | controller | skipping: [instance]
2025-10-14 07:07:16.216595 | controller |
2025-10-14 07:07:16.216779 | controller | PLAY RECAP *********************************************************************
2025-10-14 07:07:16.216955 | controller | instance                   : ok=134  changed=27   unreachable=0    failed=0    skipped=78   rescued=0    ignored=0
2025-10-14 07:07:16.217084 | controller |
2025-10-14 07:07:16.217243 | controller | Tuesday 14 October 2025  07:07:16 +0000 (0:00:00.035)       0:00:29.299 *******
2025-10-14 07:07:16.217379 | controller | ===============================================================================
2025-10-14 07:07:16.217512 | controller | repo_setup : Remove existing repos from /etc/yum.repos.d directory ------ 1.52s
2025-10-14 07:07:16.217641 | controller | repo_setup : Make sure git-core package is installed -------------------- 1.32s
2025-10-14 07:07:16.217789 | controller | repo_setup : Initialize python venv and install requirements ------------ 1.32s
2025-10-14 07:07:16.217921 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.86s
2025-10-14 07:07:16.218052 | controller | Gathering Facts --------------------------------------------------------- 0.78s
2025-10-14 07:07:16.218203 | controller | repo_setup : Ensure directories are present ----------------------------- 0.63s
2025-10-14 07:07:16.218341 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.61s
2025-10-14 07:07:16.218482 | controller | repo_setup : Get repo-setup repository ---------------------------------- 0.61s
2025-10-14 07:07:16.218615 | controller | repo_setup : Run repo-setup-get-hash ------------------------------------ 0.58s
2025-10-14 07:07:16.218764 | controller | repo_setup : Dump full hash in delorean.repo.md5 file ------------------- 0.55s
2025-10-14 07:07:16.218900 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.52s
2025-10-14 07:07:16.219031 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.52s
2025-10-14 07:07:16.219187 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.51s
2025-10-14 07:07:16.219333 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.51s
2025-10-14 07:07:16.219477 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.51s
2025-10-14 07:07:16.219611 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.50s
2025-10-14 07:07:16.219753 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.50s
2025-10-14 07:07:16.219889 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.50s
2025-10-14 07:07:16.220020 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.50s
2025-10-14 07:07:16.220167 | controller | dlrn_promote : Get commit.yaml file ------------------------------------- 0.50s
2025-10-14 07:07:16.272077 | controller | INFO     Running default > cleanup
2025-10-14 07:07:16.272623 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-14 07:07:16.273359 | controller | INFO     Writing /tmp/report.html report.
2025-10-14 07:07:16.709050 | controller | changed
2025-10-14 07:07:16.783616 | 
2025-10-14 07:07:16.783710 | PLAY RECAP
2025-10-14 07:07:16.783756 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-14 07:07:16.783780 | 
2025-10-14 07:07:17.008489 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-14 07:07:17.013734 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-14 07:07:18.070761 | 
2025-10-14 07:07:18.070872 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-14 07:07:18.136555 | 
2025-10-14 07:07:18.136660 | TASK [Filter out host if needed]
2025-10-14 07:07:18.153643 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-14 07:07:18.158483 | 
2025-10-14 07:07:18.158555 | TASK [Ensure file is present]
2025-10-14 07:07:18.527983 | controller | ok
2025-10-14 07:07:18.534676 | 
2025-10-14 07:07:18.534763 | TASK [Manage molecule report file]
2025-10-14 07:07:19.100512 | controller | changed
2025-10-14 07:07:19.107297 | 
2025-10-14 07:07:19.107390 | TASK [Check if we get ci-framework-data basedir]
2025-10-14 07:07:19.322616 | controller | ok
2025-10-14 07:07:19.327666 | 
2025-10-14 07:07:19.327739 | TASK [Create ci-framework-data log directory for zuul]
2025-10-14 07:07:19.897348 | controller | changed
2025-10-14 07:07:19.905316 | 
2025-10-14 07:07:19.905393 | TASK [Copy ci-framework interesting files]
2025-10-14 07:07:20.156402 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-14 07:07:20.449903 | controller | changed
2025-10-14 07:07:20.471784 | 
2025-10-14 07:07:20.471897 | TASK [Get SELinux listing]
2025-10-14 07:07:21.003579 | controller | changed
2025-10-14 07:07:21.010051 | 
2025-10-14 07:07:21.010122 | TASK [Generate log index]
2025-10-14 07:07:21.889377 | controller | changed
2025-10-14 07:07:21.901084 | 
2025-10-14 07:07:21.901160 | TASK [Get some env related data]
2025-10-14 07:07:22.510642 | controller | /home/zuul/.local/bin/ansible
2025-10-14 07:07:23.451265 | controller | changed
2025-10-14 07:07:23.457193 | 
2025-10-14 07:07:23.457263 | TASK [Generate list of logs to collect in home directory]
2025-10-14 07:07:23.818998 | controller | ok: All paths examined
2025-10-14 07:07:23.864177 | 
2025-10-14 07:07:23.864277 | LOOP [Copy logs from home directory]
2025-10-14 07:07:24.230211 | controller | changed:
2025-10-14 07:07:24.230416 | controller | {
2025-10-14 07:07:24.230447 | controller |   "atime": 1760425414.738501,
2025-10-14 07:07:24.230469 | controller |   "ctime": 1760425433.4947014,
2025-10-14 07:07:24.230489 | controller |   "dev": 64513,
2025-10-14 07:07:24.230508 | controller |   "gid": 1000,
2025-10-14 07:07:24.230526 | controller |   "gr_name": "zuul",
2025-10-14 07:07:24.230544 | controller |   "inode": 4428946,
2025-10-14 07:07:24.230561 | controller |   "isblk": false,
2025-10-14 07:07:24.230579 | controller |   "ischr": false,
2025-10-14 07:07:24.230596 | controller |   "isdir": false,
2025-10-14 07:07:24.230613 | controller |   "isfifo": false,
2025-10-14 07:07:24.230629 | controller |   "isgid": false,
2025-10-14 07:07:24.230646 | controller |   "islnk": false,
2025-10-14 07:07:24.230667 | controller |   "isreg": true,
2025-10-14 07:07:24.230683 | controller |   "issock": false,
2025-10-14 07:07:24.230698 | controller |   "isuid": false,
2025-10-14 07:07:24.230714 | controller |   "mode": "0644",
2025-10-14 07:07:24.230742 | controller |   "mtime": 1760425433.4947014,
2025-10-14 07:07:24.230760 | controller |   "nlink": 1,
2025-10-14 07:07:24.230777 | controller |   "path": "/home/zuul/ansible.log",
2025-10-14 07:07:24.230799 | controller |   "pw_name": "zuul",
2025-10-14 07:07:24.230816 | controller |   "rgrp": true,
2025-10-14 07:07:24.230832 | controller |   "roth": true,
2025-10-14 07:07:24.230848 | controller |   "rusr": true,
2025-10-14 07:07:24.230863 | controller |   "size": 6749,
2025-10-14 07:07:24.230878 | controller |   "uid": 1000,
2025-10-14 07:07:24.230894 | controller |   "wgrp": false,
2025-10-14 07:07:24.230927 | controller |   "woth": false,
2025-10-14 07:07:24.230951 | controller |   "wusr": true,
2025-10-14 07:07:24.230968 | controller |   "xgrp": false,
2025-10-14 07:07:24.230985 | controller |   "xoth": false,
2025-10-14 07:07:24.231001 | controller |   "xusr": false
2025-10-14 07:07:24.231017 | controller | }
2025-10-14 07:07:24.244869 | 
2025-10-14 07:07:24.244976 | TASK [Copy crio stats log file]
2025-10-14 07:07:24.289681 | controller | skipping: Conditional result was False
2025-10-14 07:07:24.295957 | 
2025-10-14 07:07:24.296033 | TASK [Get SELinux related data]
2025-10-14 07:07:24.601255 | controller | <no matches>
2025-10-14 07:07:24.864371 | controller | ERROR
2025-10-14 07:07:24.864549 | controller | {
2025-10-14 07:07:24.864582 | controller |   "delta": "0:00:00.008982",
2025-10-14 07:07:24.864605 | controller |   "end": "2025-10-14 07:07:24.602262",
2025-10-14 07:07:24.864624 | controller |   "msg": "non-zero return code",
2025-10-14 07:07:24.864642 | controller |   "rc": 1,
2025-10-14 07:07:24.864660 | controller |   "start": "2025-10-14 07:07:24.593280"
2025-10-14 07:07:24.864678 | controller | }
2025-10-14 07:07:24.864704 | controller | ERROR: Ignoring Errors
2025-10-14 07:07:24.869928 | 
2025-10-14 07:07:24.869995 | TASK [Create system configuration directory]
2025-10-14 07:07:25.056553 | controller | changed
2025-10-14 07:07:25.062556 | 
2025-10-14 07:07:25.062644 | TASK [Get some of the system configurations]
2025-10-14 07:07:25.589286 | controller | changed
2025-10-14 07:07:25.595714 | 
2025-10-14 07:07:25.595820 | TASK [Copy generated documentation if available]
2025-10-14 07:07:25.609453 | controller | skipping: Conditional result was False
2025-10-14 07:07:25.625516 | 
2025-10-14 07:07:25.625617 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-14 07:07:25.640924 | controller | skipping: Conditional result was False
2025-10-14 07:07:25.646888 | 
2025-10-14 07:07:25.646974 | TASK [Compress logs bigger than 2MB]
2025-10-14 07:07:26.181119 | controller | changed
2025-10-14 07:07:26.186364 | 
2025-10-14 07:07:26.186431 | TASK [Copy files from workspace on node]
2025-10-14 07:07:26.225490 | controller | ok
2025-10-14 07:07:26.256052 | 
2025-10-14 07:07:26.256133 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-14 07:07:26.290662 | controller | skipping: Conditional result was False
2025-10-14 07:07:26.297117 | 
2025-10-14 07:07:26.297189 | TASK [fetch-output : Set log path for single node]
2025-10-14 07:07:26.369543 | controller | ok
2025-10-14 07:07:26.377494 | 
2025-10-14 07:07:26.377562 | LOOP [fetch-output : Ensure local output dirs]
2025-10-14 07:07:26.728031 | controller -> localhost | ok: "/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/logs"
2025-10-14 07:07:26.728250 | controller -> localhost | changed: All items complete
2025-10-14 07:07:26.728285 | 
2025-10-14 07:07:27.093179 | controller -> localhost | changed: "/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/artifacts"
2025-10-14 07:07:27.517527 | controller -> localhost | changed: "/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/docs"
2025-10-14 07:07:27.527284 | 
2025-10-14 07:07:27.527391 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-14 07:07:28.440702 | controller | changed:
2025-10-14 07:07:28.440899 | controller | .d..t...... ./
2025-10-14 07:07:28.441036 | controller | >f+++++++++ README.html
2025-10-14 07:07:28.441068 | controller | >f+++++++++ ansible-execution.log
2025-10-14 07:07:28.441091 | controller | >f+++++++++ ansible.log
2025-10-14 07:07:28.441111 | controller | >f+++++++++ dmesg.log
2025-10-14 07:07:28.441130 | controller | >f+++++++++ installed-pkgs.log
2025-10-14 07:07:28.441154 | controller | >f+++++++++ python.log
2025-10-14 07:07:28.441175 | controller | >f+++++++++ registries.conf
2025-10-14 07:07:28.441194 | controller | >f+++++++++ report.html
2025-10-14 07:07:28.441262 | controller | >f+++++++++ selinux-denials.log
2025-10-14 07:07:28.441294 | controller | >f+++++++++ selinux-listing.log
2025-10-14 07:07:28.441317 | controller | cd+++++++++ ci-framework-data/
2025-10-14 07:07:28.441336 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-14 07:07:28.441354 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-14 07:07:28.441373 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-14 07:07:28.441391 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-14 07:07:28.441408 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2025-10-14 07:07:28.441424 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean-antelope-testing.repo
2025-10-14 07:07:28.441441 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo
2025-10-14 07:07:28.441458 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2025-10-14 07:07:28.441475 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-appstream.repo
2025-10-14 07:07:28.441491 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-baseos.repo
2025-10-14 07:07:28.441508 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-highavailability.repo
2025-10-14 07:07:28.441525 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/repo-setup-centos-powertools.repo
2025-10-14 07:07:28.441542 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-14 07:07:28.441559 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-14 07:07:28.441576 | controller | cd+++++++++ registries.conf.d/
2025-10-14 07:07:28.441592 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-14 07:07:28.441608 | controller | cd+++++++++ system-config/
2025-10-14 07:07:28.441624 | controller | cd+++++++++ system-config/libvirt/
2025-10-14 07:07:28.441639 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-14 07:07:28.441655 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-14 07:07:29.101755 | controller | changed: .d..t...... ./
2025-10-14 07:07:29.800584 | controller | changed: .d..t...... ./
2025-10-14 07:07:29.817457 | 
2025-10-14 07:07:29.817574 | TASK [Return artifact to Zuul]
2025-10-14 07:07:29.880011 | controller | ok
2025-10-14 07:07:29.921184 | 
2025-10-14 07:07:29.921254 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-14 07:07:29.921357 | 
2025-10-14 07:07:29.921386 | PLAY RECAP
2025-10-14 07:07:29.921426 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-14 07:07:29.921449 | 
2025-10-14 07:07:30.022653 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-14 07:07:30.023427 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-14 07:07:30.649527 | 
2025-10-14 07:07:30.649638 | PLAY [all]
2025-10-14 07:07:30.670022 | 
2025-10-14 07:07:30.670114 | TASK [include_role : fetch-output]
2025-10-14 07:07:30.699382 | controller | ok
2025-10-14 07:07:30.717418 | 
2025-10-14 07:07:30.717524 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-14 07:07:30.762157 | controller | skipping: Conditional result was False
2025-10-14 07:07:30.767788 | 
2025-10-14 07:07:30.767877 | TASK [fetch-output : Set log path for single node]
2025-10-14 07:07:30.807224 | controller | ok
2025-10-14 07:07:30.812558 | 
2025-10-14 07:07:30.812640 | LOOP [fetch-output : Ensure local output dirs]
2025-10-14 07:07:31.189607 | controller -> localhost | ok: "/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/logs"
2025-10-14 07:07:31.400708 | controller -> localhost | ok: "/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/artifacts"
2025-10-14 07:07:31.601575 | controller -> localhost | ok: "/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/docs"
2025-10-14 07:07:31.611106 | 
2025-10-14 07:07:31.611208 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-14 07:07:32.165519 | controller | ok
2025-10-14 07:07:32.165700 | controller | ok: All items complete
2025-10-14 07:07:32.165735 | 
2025-10-14 07:07:32.661174 | controller | ok
2025-10-14 07:07:33.098079 | controller | ok
2025-10-14 07:07:33.113219 | 
2025-10-14 07:07:33.113323 | TASK [include_role : fetch-output-openshift]
2025-10-14 07:07:33.136606 | controller | skipping: Conditional result was False
2025-10-14 07:07:33.148109 | 
2025-10-14 07:07:33.148190 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-14 07:07:33.800007 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007013
2025-10-14 07:07:34.055236 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008739
2025-10-14 07:07:34.094494 | 
2025-10-14 07:07:34.094571 | PLAY [all]
2025-10-14 07:07:34.117983 | 
2025-10-14 07:07:34.118061 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-14 07:07:34.524813 | controller | changed
2025-10-14 07:07:34.554930 | 
2025-10-14 07:07:34.555039 | PLAY RECAP
2025-10-14 07:07:34.555088 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-14 07:07:34.555112 | 
2025-10-14 07:07:34.630998 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-14 07:07:34.631770 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-14 07:07:35.219579 | 
2025-10-14 07:07:35.219686 | PLAY [localhost]
2025-10-14 07:07:35.237042 | 
2025-10-14 07:07:35.237123 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-14 07:07:35.549645 | localhost | changed
2025-10-14 07:07:35.554469 | 
2025-10-14 07:07:35.554546 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-14 07:07:35.581950 | localhost | ok
2025-10-14 07:07:35.590170 | 
2025-10-14 07:07:35.590240 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-14 07:07:35.922712 | localhost | changed
2025-10-14 07:07:35.928715 | 
2025-10-14 07:07:35.928801 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-14 07:07:36.519487 | localhost | changed
2025-10-14 07:07:36.526270 | 
2025-10-14 07:07:36.526438 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-14 07:07:36.903511 | localhost | Identity added: /var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/tmp/ansible.vn37rmxi (/var/lib/zuul/builds/75f4865c001647798a89c41e1ff488e8/work/tmp/ansible.vn37rmxi)
2025-10-14 07:07:36.903769 | localhost | ok: Runtime: 0:00:00.007275
2025-10-14 07:07:36.909448 | 
2025-10-14 07:07:36.909524 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-14 07:07:37.192679 | localhost | ok: Runtime: 0:00:00.004474
2025-10-14 07:07:37.197970 | 
2025-10-14 07:07:37.198062 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-14 07:07:37.280442 | localhost | changed
2025-10-14 07:07:37.286384 | 
2025-10-14 07:07:37.286463 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-14 07:07:37.707318 | localhost | changed
2025-10-14 07:07:37.743353 | 
2025-10-14 07:07:37.743450 | PLAY [localhost]
2025-10-14 07:07:37.757019 | 
2025-10-14 07:07:37.757091 | TASK [Generate bulk log download script]
2025-10-14 07:07:37.775214 | localhost | ok
2025-10-14 07:07:37.786893 | 
2025-10-14 07:07:37.786981 | TASK [local-log-download : Check API endpoint is defined]
2025-10-14 07:07:37.818983 | localhost | ok: All assertions passed
2025-10-14 07:07:37.824665 | 
2025-10-14 07:07:37.824731 | TASK [local-log-download : Create download script]
2025-10-14 07:07:38.277013 | localhost -> localhost | changed
2025-10-14 07:07:38.290282 | 
2025-10-14 07:07:38.290381 | TASK [Register quick-download link]
2025-10-14 07:07:38.329160 | localhost | ok
2025-10-14 07:07:38.394029 | 
2025-10-14 07:07:38.394144 | PLAY [logserver.rdoproject.org]
2025-10-14 07:07:38.404406 | 
2025-10-14 07:07:38.404474 | TASK [Set zuul-log-path fact]
2025-10-14 07:07:38.422097 | logserver.rdoproject.org | ok
2025-10-14 07:07:38.431724 | 
2025-10-14 07:07:38.431803 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-14 07:07:38.468664 | logserver.rdoproject.org | ok
2025-10-14 07:07:38.474265 | 
2025-10-14 07:07:38.474334 | TASK [upload-logs : Create log directories]
2025-10-14 07:07:40.119197 | logserver.rdoproject.org | changed
2025-10-14 07:07:40.122641 | 
2025-10-14 07:07:40.122709 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-14 07:07:40.365336 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005521
2025-10-14 07:07:40.372136 | 
2025-10-14 07:07:40.372230 | TASK [upload-logs : Upload logs to log server]
2025-10-14 07:07:41.996060 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-14 07:07:41.999550 | 
2025-10-14 07:07:41.999616 | LOOP [upload-logs : Compress console log and json output]
2025-10-14 07:07:42.089666 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 07:07:42.098511 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 07:07:42.112627 | 
2025-10-14 07:07:42.112729 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-14 07:07:42.200792 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 07:07:42.201031 | 
2025-10-14 07:07:42.208618 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-14 07:07:42.222616 | 
2025-10-14 07:07:42.222730 | LOOP [upload-logs : Upload console log and json output]