2025-10-08 15:56:46.957807 | Job console starting...
2025-10-08 15:56:47.203139 | Updating repositories
2025-10-08 15:56:47.959274 | Preparing job workspace
2025-10-08 15:56:56.802779 | Running Ansible setup...
2025-10-08 15:56:59.857108 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-08 15:57:00.402662 | 
2025-10-08 15:57:00.402760 | PLAY [localhost]
2025-10-08 15:57:00.411398 | 
2025-10-08 15:57:00.411473 | TASK [Gathering Facts]
2025-10-08 15:57:01.268650 | localhost | ok
2025-10-08 15:57:01.282031 | 
2025-10-08 15:57:01.282138 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-08 15:57:01.630120 | localhost -> localhost | changed
2025-10-08 15:57:01.635656 | 
2025-10-08 15:57:01.635729 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-08 15:57:02.368228 | localhost -> localhost | changed
2025-10-08 15:57:02.377027 | 
2025-10-08 15:57:02.377096 | TASK [Setup log path fact]
2025-10-08 15:57:02.394529 | localhost | ok
2025-10-08 15:57:02.405960 | 
2025-10-08 15:57:02.406034 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-08 15:57:02.432804 | localhost | ok
2025-10-08 15:57:02.440383 | 
2025-10-08 15:57:02.440453 | TASK [emit-job-header : Print job information]
2025-10-08 15:57:02.467738 | # Job Information
2025-10-08 15:57:02.467870 | Ansible Version: 2.15.12
2025-10-08 15:57:02.467901 | Job: cifmw-molecule-ci_gen_kustomize_values
2025-10-08 15:57:02.467955 | Pipeline: github-check
2025-10-08 15:57:02.467979 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-08 15:57:02.467999 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3368
2025-10-08 15:57:02.468019 | Log URL (when completed): https://logserver.rdoproject.org/453/rdoproject.org/45334f33ea8f4935b30dbb80e11513c4/
2025-10-08 15:57:02.468038 | Event ID: b612d780-a45c-11f0-87cb-9ea07ef2b05c
2025-10-08 15:57:02.471599 | 
2025-10-08 15:57:02.471666 | LOOP [emit-job-header : Print node information]
2025-10-08 15:57:02.568071 | localhost | ok:
2025-10-08 15:57:02.568280 | localhost | # Node Information
2025-10-08 15:57:02.568313 | localhost | Inventory Hostname: controller
2025-10-08 15:57:02.568339 | localhost | Hostname: np0005477331
2025-10-08 15:57:02.568362 | localhost | Username: zuul
2025-10-08 15:57:02.568384 | localhost | Distro: CentOS 9
2025-10-08 15:57:02.568402 | localhost | Provider: ibm-bm4-nodepool
2025-10-08 15:57:02.568421 | localhost | Region: regionOne
2025-10-08 15:57:02.568437 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-08 15:57:02.568454 | localhost | Product Name: OpenStack Compute
2025-10-08 15:57:02.568471 | localhost | Interface IP: 192.168.26.99
2025-10-08 15:57:02.595077 | 
2025-10-08 15:57:02.595174 | PLAY [all]
2025-10-08 15:57:02.602105 | 
2025-10-08 15:57:02.602172 | TASK [Gather network facts]
2025-10-08 15:57:02.957651 | controller | ok
2025-10-08 15:57:02.974068 | 
2025-10-08 15:57:02.974170 | TASK [include_role : start-zuul-console]
2025-10-08 15:57:02.991995 | controller | ok
2025-10-08 15:57:03.004072 | 
2025-10-08 15:57:03.004140 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-08 15:57:03.329356 | controller | ok
2025-10-08 15:57:03.338603 | 
2025-10-08 15:57:03.338665 | TASK [include_role : add-build-sshkey]
2025-10-08 15:57:03.356600 | controller | ok
2025-10-08 15:57:03.371468 | 
2025-10-08 15:57:03.371537 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-08 15:57:03.572120 | controller -> localhost | ok
2025-10-08 15:57:03.577838 | 
2025-10-08 15:57:03.577938 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-08 15:57:03.597043 | controller | ok
2025-10-08 15:57:03.611662 | controller | included: /var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-08 15:57:03.617727 | 
2025-10-08 15:57:03.617808 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-08 15:57:04.071459 | controller -> localhost | Generating public/private rsa key pair.
2025-10-08 15:57:04.071650 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/45334f33ea8f4935b30dbb80e11513c4_id_rsa.
2025-10-08 15:57:04.071688 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/45334f33ea8f4935b30dbb80e11513c4_id_rsa.pub.
2025-10-08 15:57:04.071713 | controller -> localhost | The key fingerprint is:
2025-10-08 15:57:04.071736 | controller -> localhost | SHA256:okYLuVo3Ezm7KN222rMdog7rjj8SfXqMz65AxICvrQc zuul-build-sshkey
2025-10-08 15:57:04.071757 | controller -> localhost | The key's randomart image is:
2025-10-08 15:57:04.071777 | controller -> localhost | +---[RSA 3072]----+
2025-10-08 15:57:04.071797 | controller -> localhost | |o                |
2025-10-08 15:57:04.071816 | controller -> localhost | |+                |
2025-10-08 15:57:04.071835 | controller -> localhost | | +               |
2025-10-08 15:57:04.071854 | controller -> localhost | |. .. .           |
2025-10-08 15:57:04.071871 | controller -> localhost | | =o = . S        |
2025-10-08 15:57:04.071888 | controller -> localhost | |E o+.* .         |
2025-10-08 15:57:04.071905 | controller -> localhost | |o=o*X .          |
2025-10-08 15:57:04.071981 | controller -> localhost | |=**B** .         |
2025-10-08 15:57:04.072004 | controller -> localhost | |*OBOO+.          |
2025-10-08 15:57:04.072022 | controller -> localhost | +----[SHA256]-----+
2025-10-08 15:57:04.072067 | controller -> localhost | ok: Runtime: 0:00:00.117244
2025-10-08 15:57:04.078068 | 
2025-10-08 15:57:04.078134 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-08 15:57:04.096081 | controller | ok
2025-10-08 15:57:04.106075 | controller | included: /var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-08 15:57:04.114522 | 
2025-10-08 15:57:04.114600 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-08 15:57:04.127858 | controller | skipping: Conditional result was False
2025-10-08 15:57:04.133490 | 
2025-10-08 15:57:04.133567 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-08 15:57:04.483931 | controller | changed
2025-10-08 15:57:04.490179 | 
2025-10-08 15:57:04.490281 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-08 15:57:04.686380 | controller | ok
2025-10-08 15:57:04.691159 | 
2025-10-08 15:57:04.691243 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-08 15:57:05.257067 | controller | changed
2025-10-08 15:57:05.261902 | 
2025-10-08 15:57:05.262004 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-08 15:57:05.850746 | controller | changed
2025-10-08 15:57:05.855611 | 
2025-10-08 15:57:05.855682 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-08 15:57:05.879273 | controller | skipping: Conditional result was False
2025-10-08 15:57:05.885138 | 
2025-10-08 15:57:05.885227 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-08 15:57:06.235233 | controller -> localhost | changed
2025-10-08 15:57:06.255790 | 
2025-10-08 15:57:06.255894 | TASK [add-build-sshkey : Add back temp key]
2025-10-08 15:57:06.516405 | controller -> localhost | Identity added: /var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/45334f33ea8f4935b30dbb80e11513c4_id_rsa (zuul-build-sshkey)
2025-10-08 15:57:06.516581 | controller -> localhost | ok: Runtime: 0:00:00.015733
2025-10-08 15:57:06.523068 | 
2025-10-08 15:57:06.523133 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-08 15:57:06.817433 | controller | ok
2025-10-08 15:57:06.823824 | 
2025-10-08 15:57:06.823898 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-08 15:57:06.848002 | controller | skipping: Conditional result was False
2025-10-08 15:57:06.863403 | 
2025-10-08 15:57:06.863484 | TASK [include_role : validate-host]
2025-10-08 15:57:06.892718 | controller | ok
2025-10-08 15:57:06.928653 | 
2025-10-08 15:57:06.928830 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-08 15:57:06.957488 | controller | ok
2025-10-08 15:57:06.962560 | 
2025-10-08 15:57:06.962629 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-08 15:57:07.185653 | controller -> localhost | ok
2025-10-08 15:57:07.191786 | 
2025-10-08 15:57:07.191874 | TASK [validate-host : Collect information about the host]
2025-10-08 15:57:07.798289 | controller | ok
2025-10-08 15:57:07.807150 | 
2025-10-08 15:57:07.807235 | TASK [validate-host : Sanitize hostname]
2025-10-08 15:57:07.887943 | controller | ok
2025-10-08 15:57:07.910245 | 
2025-10-08 15:57:07.910334 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-08 15:57:08.425281 | controller -> localhost | changed
2025-10-08 15:57:08.431128 | 
2025-10-08 15:57:08.431213 | TASK [validate-host : Collect information about zuul worker]
2025-10-08 15:57:08.744579 | controller | ok
2025-10-08 15:57:08.749897 | 
2025-10-08 15:57:08.750009 | TASK [validate-host : Write out all zuul information for each host]
2025-10-08 15:57:09.182146 | controller -> localhost | changed
2025-10-08 15:57:09.192260 | 
2025-10-08 15:57:09.192348 | TASK [include_role : prepare-workspace-openshift]
2025-10-08 15:57:09.205718 | controller | skipping: Conditional result was False
2025-10-08 15:57:09.211628 | 
2025-10-08 15:57:09.211707 | TASK [include_role : remove-zuul-sshkey]
2025-10-08 15:57:09.224987 | controller | skipping: Conditional result was False
2025-10-08 15:57:09.230119 | 
2025-10-08 15:57:09.230214 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-08 15:57:09.428323 | controller | ok: "logs"
2025-10-08 15:57:09.428540 | controller | ok: All items complete
2025-10-08 15:57:09.428576 | 
2025-10-08 15:57:09.608976 | controller | ok: "artifacts"
2025-10-08 15:57:09.785961 | controller | ok: "docs"
2025-10-08 15:57:09.795656 | 
2025-10-08 15:57:09.795766 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-08 15:57:10.002227 | controller | changed: "logs"
2025-10-08 15:57:10.186159 | controller | changed: "artifacts"
2025-10-08 15:57:10.365329 | controller | changed: "docs"
2025-10-08 15:57:10.394437 | 
2025-10-08 15:57:10.394519 | PLAY RECAP
2025-10-08 15:57:10.394564 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-08 15:57:10.394592 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-08 15:57:10.394612 | 
2025-10-08 15:57:10.535004 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-08 15:57:10.535798 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-08 15:57:11.180099 | 
2025-10-08 15:57:11.180239 | PLAY [all]
2025-10-08 15:57:11.200008 | 
2025-10-08 15:57:11.200093 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-08 15:57:11.269069 | controller | ok
2025-10-08 15:57:11.274071 | 
2025-10-08 15:57:11.274151 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-08 15:57:11.650601 | controller | changed
2025-10-08 15:57:11.656269 | 
2025-10-08 15:57:11.656344 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-08 15:57:12.465729 | controller | changed
2025-10-08 15:57:12.481318 | 
2025-10-08 15:57:12.481414 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-08 15:57:12.844606 | controller | changed:
2025-10-08 15:57:12.844770 | controller | {
2025-10-08 15:57:12.844800 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-08 15:57:12.844831 | controller | }
2025-10-08 15:57:13.052503 | controller | changed:
2025-10-08 15:57:13.052589 | controller | {
2025-10-08 15:57:13.052619 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-08 15:57:13.052642 | controller | }
2025-10-08 15:57:13.264773 | controller | changed:
2025-10-08 15:57:13.264865 | controller | {
2025-10-08 15:57:13.264894 | 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-08 15:57:13.264972 | controller | }
2025-10-08 15:57:13.468645 | controller | changed:
2025-10-08 15:57:13.468762 | controller | {
2025-10-08 15:57:13.468794 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-08 15:57:13.468816 | controller | }
2025-10-08 15:57:13.674622 | controller | changed:
2025-10-08 15:57:13.674760 | controller | {
2025-10-08 15:57:13.674794 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-08 15:57:13.674818 | controller | }
2025-10-08 15:57:13.882597 | controller | changed:
2025-10-08 15:57:13.882695 | controller | {
2025-10-08 15:57:13.882724 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-08 15:57:13.882745 | controller | }
2025-10-08 15:57:14.089046 | controller | changed:
2025-10-08 15:57:14.089138 | controller | {
2025-10-08 15:57:14.089166 | 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-08 15:57:14.089189 | controller | }
2025-10-08 15:57:14.304355 | controller | changed:
2025-10-08 15:57:14.304445 | controller | {
2025-10-08 15:57:14.304474 | 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-08 15:57:14.304497 | controller | }
2025-10-08 15:57:14.533162 | controller | changed:
2025-10-08 15:57:14.533269 | controller | {
2025-10-08 15:57:14.533298 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-08 15:57:14.533321 | controller | }
2025-10-08 15:57:14.741482 | controller | changed:
2025-10-08 15:57:14.741560 | controller | {
2025-10-08 15:57:14.741587 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-08 15:57:14.741609 | controller | }
2025-10-08 15:57:14.961064 | controller | changed:
2025-10-08 15:57:14.961151 | controller | {
2025-10-08 15:57:14.961177 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-08 15:57:14.961210 | controller | }
2025-10-08 15:57:15.198537 | controller | changed:
2025-10-08 15:57:15.198626 | controller | {
2025-10-08 15:57:15.198655 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-08 15:57:15.198679 | controller | }
2025-10-08 15:57:15.392032 | controller | changed:
2025-10-08 15:57:15.392128 | controller | {
2025-10-08 15:57:15.392157 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-08 15:57:15.392179 | controller | }
2025-10-08 15:57:15.603289 | controller | changed:
2025-10-08 15:57:15.603435 | controller | {
2025-10-08 15:57:15.603467 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-08 15:57:15.603491 | controller | }
2025-10-08 15:57:15.835983 | controller | changed:
2025-10-08 15:57:15.836083 | controller | {
2025-10-08 15:57:15.836111 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-08 15:57:15.836132 | controller | }
2025-10-08 15:57:16.048241 | controller | changed:
2025-10-08 15:57:16.048319 | controller | {
2025-10-08 15:57:16.048348 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-08 15:57:16.048370 | controller | }
2025-10-08 15:57:16.269506 | controller | changed:
2025-10-08 15:57:16.269590 | controller | {
2025-10-08 15:57:16.269618 | 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-08 15:57:16.269640 | controller | }
2025-10-08 15:57:16.480083 | controller | changed:
2025-10-08 15:57:16.480174 | controller | {
2025-10-08 15:57:16.480215 | 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-08 15:57:16.480248 | controller | }
2025-10-08 15:57:16.714342 | controller | changed:
2025-10-08 15:57:16.714427 | controller | {
2025-10-08 15:57:16.714454 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-08 15:57:16.714475 | controller | }
2025-10-08 15:57:16.941484 | controller | changed:
2025-10-08 15:57:16.941561 | controller | {
2025-10-08 15:57:16.941588 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-08 15:57:16.941610 | controller | }
2025-10-08 15:57:17.157141 | controller | changed:
2025-10-08 15:57:17.157238 | controller | {
2025-10-08 15:57:17.157266 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-08 15:57:17.157287 | controller | }
2025-10-08 15:57:17.378095 | controller | changed:
2025-10-08 15:57:17.378182 | controller | {
2025-10-08 15:57:17.378220 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-08 15:57:17.378242 | controller | }
2025-10-08 15:57:17.592442 | controller | changed:
2025-10-08 15:57:17.592531 | controller | {
2025-10-08 15:57:17.592558 | 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-08 15:57:17.592580 | controller | }
2025-10-08 15:57:17.827679 | controller | changed:
2025-10-08 15:57:17.827769 | controller | {
2025-10-08 15:57:17.827796 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-08 15:57:17.827817 | controller | }
2025-10-08 15:57:18.038548 | controller | changed:
2025-10-08 15:57:18.038634 | controller | {
2025-10-08 15:57:18.038664 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-08 15:57:18.038686 | controller | }
2025-10-08 15:57:18.252348 | controller | changed:
2025-10-08 15:57:18.252520 | controller | {
2025-10-08 15:57:18.252557 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-08 15:57:18.252580 | controller | }
2025-10-08 15:57:18.270237 | 
2025-10-08 15:57:18.270332 | TASK [Set timezone to UTC]
2025-10-08 15:57:18.698757 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-08 15:57:18.707545 | 
2025-10-08 15:57:18.707632 | TASK [Create nodepool directory]
2025-10-08 15:57:18.918416 | controller | changed
2025-10-08 15:57:18.925175 | 
2025-10-08 15:57:18.925300 | TASK [Create nodepool sub_nodes file]
2025-10-08 15:57:19.463180 | controller | changed
2025-10-08 15:57:19.468296 | 
2025-10-08 15:57:19.468380 | TASK [Create nodepool sub_nodes_private file]
2025-10-08 15:57:19.984407 | controller | changed
2025-10-08 15:57:19.990765 | 
2025-10-08 15:57:19.990848 | LOOP [Populate nodepool sub_nodes file]
2025-10-08 15:57:20.022155 | 
2025-10-08 15:57:20.022323 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-08 15:57:20.050800 | 
2025-10-08 15:57:20.050958 | TASK [Create nodepool primary file]
2025-10-08 15:57:20.097296 | controller | skipping: Conditional result was False
2025-10-08 15:57:20.110397 | 
2025-10-08 15:57:20.110487 | TASK [Create nodepool node_private for this node]
2025-10-08 15:57:20.662830 | controller | changed
2025-10-08 15:57:20.675810 | 
2025-10-08 15:57:20.675891 | LOOP [Copy ssh keys to nodepool directory]
2025-10-08 15:57:21.022448 | controller | ok: Item: id_rsa Runtime: 0:00:00.005294
2025-10-08 15:57:21.022806 | 
2025-10-08 15:57:21.184573 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004375
2025-10-08 15:57:21.199019 | 
2025-10-08 15:57:21.199118 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-08 15:57:21.752645 | controller | changed
2025-10-08 15:57:21.760531 | 
2025-10-08 15:57:21.760613 | TASK [Validate sudoers config after edits]
2025-10-08 15:57:21.983224 | controller | /etc/sudoers: parsed OK
2025-10-08 15:57:21.983294 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-08 15:57:21.983306 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-08 15:57:21.983312 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-08 15:57:22.288870 | controller | ok: Runtime: 0:00:00.004997
2025-10-08 15:57:22.294750 | 
2025-10-08 15:57:22.294822 | TASK [Show the environment passed in to job shell scripts]
2025-10-08 15:57:22.500634 | controller | SHELL=/bin/bash
2025-10-08 15:57:22.500719 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-08 15:57:22.500772 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-08 15:57:22.500781 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/85/3385/f8a3c957fc51bd892aee4b1f66ce262682944823^openstack-k8s-operators/ci-framework:main:refs/changes/68/3368/127d45eecba72e2daf3d33e73e380ccf7b6e7649
2025-10-08 15:57:22.500790 | controller | PWD=/home/zuul
2025-10-08 15:57:22.500796 | controller | ZUUL_PIPELINE=github-check
2025-10-08 15:57:22.500801 | controller | LOGNAME=zuul
2025-10-08 15:57:22.500806 | controller | XDG_SESSION_TYPE=tty
2025-10-08 15:57:22.500812 | controller | _=/usr/bin/env
2025-10-08 15:57:22.500817 | controller | MOTD_SHOWN=pam
2025-10-08 15:57:22.500823 | controller | HOME=/home/zuul
2025-10-08 15:57:22.500828 | controller | LANG=en_US.UTF-8
2025-10-08 15:57:22.500834 | controller | SSH_CONNECTION=192.168.26.12 53488 192.168.26.99 22
2025-10-08 15:57:22.500839 | 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-08 15:57:22.500845 | controller | ZUUL_CHANGE_IDS=3385,f8a3c957fc51bd892aee4b1f66ce262682944823 3368,127d45eecba72e2daf3d33e73e380ccf7b6e7649
2025-10-08 15:57:22.500851 | controller | WORKSPACE=/home/zuul/workspace
2025-10-08 15:57:22.500856 | controller | XDG_SESSION_CLASS=user
2025-10-08 15:57:22.500862 | controller | SELINUX_ROLE_REQUESTED=
2025-10-08 15:57:22.500867 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-08 15:57:22.500873 | controller | USER=zuul
2025-10-08 15:57:22.500879 | controller | ZUUL_VOTING=True
2025-10-08 15:57:22.500884 | controller | BUILD_TIMEOUT=1800000
2025-10-08 15:57:22.500889 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-08 15:57:22.500895 | controller | SHLVL=1
2025-10-08 15:57:22.500900 | controller | ZUUL_PATCHSET=127d45eecba72e2daf3d33e73e380ccf7b6e7649
2025-10-08 15:57:22.500906 | controller | XDG_SESSION_ID=1
2025-10-08 15:57:22.500911 | controller | ZUUL_BRANCH=main
2025-10-08 15:57:22.500916 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-08 15:57:22.500922 | controller | SSH_CLIENT=192.168.26.12 53488 22
2025-10-08 15:57:22.500927 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-08 15:57:22.500932 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-08 15:57:22.500938 | controller | which_declare=declare -f
2025-10-08 15:57:22.500944 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-08 15:57:22.500949 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-08 15:57:22.500955 | controller | ZUUL_CHANGE=3368
2025-10-08 15:57:22.500960 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-08 15:57:22.500966 | controller | ZUUL_UUID=45334f33ea8f4935b30dbb80e11513c4
2025-10-08 15:57:22.500971 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-08 15:57:22.500977 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-08 15:57:22.500982 | controller | }
2025-10-08 15:57:22.822872 | controller | ok: Runtime: 0:00:00.005692
2025-10-08 15:57:22.829739 | 
2025-10-08 15:57:22.829839 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-08 15:57:22.843159 | controller | skipping: Conditional result was False
2025-10-08 15:57:22.849838 | 
2025-10-08 15:57:22.849960 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-08 15:57:23.377617 | controller | skipping: Conditional result was False
2025-10-08 15:57:23.383089 | 
2025-10-08 15:57:23.383160 | TASK [Ensure legacy workspace directory]
2025-10-08 15:57:23.585368 | controller | changed
2025-10-08 15:57:23.604813 | 
2025-10-08 15:57:23.604936 | PLAY RECAP
2025-10-08 15:57:23.604990 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-08 15:57:23.605017 | 
2025-10-08 15:57:23.735335 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-08 15:57:23.736122 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-08 15:57:24.397371 | 
2025-10-08 15:57:24.397501 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-08 15:57:24.428159 | 
2025-10-08 15:57:24.428274 | TASK [Create zuul-output directory]
2025-10-08 15:57:24.743983 | controller | changed
2025-10-08 15:57:24.749295 | 
2025-10-08 15:57:24.749375 | TASK [Slurp Zuul inventory test]
2025-10-08 15:57:25.028753 | controller -> localhost | ok
2025-10-08 15:57:25.036554 | 
2025-10-08 15:57:25.037006 | TASK [Save zuul inventory]
2025-10-08 15:57:25.809873 | controller | changed
2025-10-08 15:57:25.815223 | 
2025-10-08 15:57:25.815303 | TASK [Save zuul vars without the change_message]
2025-10-08 15:57:26.492026 | controller | changed
2025-10-08 15:57:26.564382 | 
2025-10-08 15:57:26.564467 | PLAY RECAP
2025-10-08 15:57:26.564511 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-08 15:57:26.564534 | 
2025-10-08 15:57:26.700749 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-08 15:57:26.701817 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-08 15:57:27.349316 | 
2025-10-08 15:57:27.349433 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-08 15:57:27.380628 | 
2025-10-08 15:57:27.380728 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-08 15:57:27.409535 | controller | ok
2025-10-08 15:57:27.426441 | 
2025-10-08 15:57:27.426543 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-08 15:57:27.449899 | controller | skipping: Conditional result was False
2025-10-08 15:57:27.455986 | 
2025-10-08 15:57:27.456064 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-08 15:57:27.829600 | controller | ok
2025-10-08 15:57:27.842881 | 
2025-10-08 15:57:27.842993 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-08 15:57:28.498982 | controller | ok
2025-10-08 15:57:28.511889 | 
2025-10-08 15:57:28.512257 | TASK [Prepare workspace]
2025-10-08 15:57:28.531371 | controller | ok
2025-10-08 15:57:28.551457 | 
2025-10-08 15:57:28.551563 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-08 15:57:28.896310 | controller | ok
2025-10-08 15:57:28.907445 | 
2025-10-08 15:57:28.907554 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-08 15:57:32.105383 | controller | Output suppressed because no_log was given
2025-10-08 15:57:32.115384 | 
2025-10-08 15:57:32.115456 | LOOP [Create zuul-output directory]
2025-10-08 15:57:32.317553 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-08 15:57:32.494565 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-08 15:57:32.514559 | 
2025-10-08 15:57:32.514654 | TASK [Install required packages]
2025-10-08 15:58:35.303335 | controller | changed
2025-10-08 15:58:35.308414 | 
2025-10-08 15:58:35.308498 | TASK [Install venv]
2025-10-08 15:59:37.900626 | controller | changed
2025-10-08 15:59:37.944979 | 
2025-10-08 15:59:37.945063 | PLAY RECAP
2025-10-08 15:59:37.945106 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-08 15:59:37.945130 | 
2025-10-08 15:59:38.026732 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-08 15:59:38.027618 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-08 15:59:38.620608 | 
2025-10-08 15:59:38.620757 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-08 15:59:38.643186 | 
2025-10-08 15:59:38.643293 | TASK [Gather required facts]
2025-10-08 15:59:39.150889 | controller | ok
2025-10-08 15:59:39.156865 | 
2025-10-08 15:59:39.157003 | TASK [Load environment var if instructed to]
2025-10-08 15:59:39.181561 | controller | skipping: Conditional result was False
2025-10-08 15:59:39.187056 | 
2025-10-08 15:59:39.187124 | TASK [Ensure group_vars dir exists]
2025-10-08 15:59:39.509636 | controller | ok
2025-10-08 15:59:39.516286 | 
2025-10-08 15:59:39.516372 | TASK [Run molecule]
2025-10-08 15:59:40.470577 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-08 15:59:40.541571 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-08 15:59:57.507366 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.507804 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.508306 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.508755 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.509311 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+4772ac9e was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0+4772ac9e (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.509757 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.510233 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.510674 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.511127 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.511594 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.512035 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.512514 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.512927 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.513397 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.513832 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 15:59:57.523633 | controller | INFO     Running default > prepare
2025-10-08 15:59:58.255639 | controller |
2025-10-08 15:59:58.255705 | controller | PLAY [Prepare] *****************************************************************
2025-10-08 15:59:58.255730 | controller |
2025-10-08 15:59:58.255838 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 15:59:58.255946 | controller | Wednesday 08 October 2025  15:59:58 +0000 (0:00:00.019)       0:00:00.019 *****
2025-10-08 15:59:59.088807 | controller | ok: [instance]
2025-10-08 15:59:59.088857 | controller |
2025-10-08 15:59:59.088979 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2025-10-08 15:59:59.089087 | controller | Wednesday 08 October 2025  15:59:59 +0000 (0:00:00.833)       0:00:00.853 *****
2025-10-08 15:59:59.105326 | controller | skipping: [instance]
2025-10-08 15:59:59.105408 | controller |
2025-10-08 15:59:59.105517 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2025-10-08 15:59:59.105623 | controller | Wednesday 08 October 2025  15:59:59 +0000 (0:00:00.016)       0:00:00.870 *****
2025-10-08 15:59:59.136097 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2025-10-08 15:59:59.136195 | controller |
2025-10-08 15:59:59.136304 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2025-10-08 15:59:59.136412 | controller | Wednesday 08 October 2025  15:59:59 +0000 (0:00:00.030)       0:00:00.900 *****
2025-10-08 15:59:59.427724 | controller | ok: [instance]
2025-10-08 15:59:59.427791 | controller |
2025-10-08 15:59:59.427906 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2025-10-08 15:59:59.428014 | controller | Wednesday 08 October 2025  15:59:59 +0000 (0:00:00.291)       0:00:01.192 *****
2025-10-08 15:59:59.727980 | controller | ok: [instance]
2025-10-08 15:59:59.728058 | controller |
2025-10-08 15:59:59.728215 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2025-10-08 15:59:59.728325 | controller | Wednesday 08 October 2025  15:59:59 +0000 (0:00:00.300)       0:00:01.492 *****
2025-10-08 16:00:00.430609 | controller | ok: [instance] => (item=ubi-9-appstream)
2025-10-08 16:00:00.430718 | controller | ok: [instance] => (item=ubi-9-baseos)
2025-10-08 16:00:00.430834 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2025-10-08 16:00:00.430933 | controller |
2025-10-08 16:00:00.431037 | controller | TASK [Deploy repo-setup] *******************************************************
2025-10-08 16:00:00.431243 | controller | Wednesday 08 October 2025  16:00:00 +0000 (0:00:00.702)       0:00:02.195 *****
2025-10-08 16:00:00.489805 | controller |
2025-10-08 16:00:00.489875 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-10-08 16:00:00.489987 | controller | Wednesday 08 October 2025  16:00:00 +0000 (0:00:00.059)       0:00:02.254 *****
2025-10-08 16:00:01.022831 | controller | changed: [instance] => (item=tmp)
2025-10-08 16:00:01.022931 | controller | changed: [instance] => (item=artifacts/repositories)
2025-10-08 16:00:01.023054 | controller | changed: [instance] => (item=venv/repo_setup)
2025-10-08 16:00:01.023216 | controller |
2025-10-08 16:00:01.023326 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-10-08 16:00:01.023428 | controller | Wednesday 08 October 2025  16:00:01 +0000 (0:00:00.532)       0:00:02.787 *****
2025-10-08 16:00:01.826983 | controller | ok: [instance]
2025-10-08 16:00:01.827345 | controller |
2025-10-08 16:00:05.286713 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-10-08 16:00:05.286745 | controller | Wednesday 08 October 2025  16:00:01 +0000 (0:00:00.804)       0:00:03.591 *****
2025-10-08 16:00:05.286757 | controller | changed: [instance]
2025-10-08 16:00:13.259854 | controller |
2025-10-08 16:00:13.259918 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-10-08 16:00:13.259930 | controller | Wednesday 08 October 2025  16:00:05 +0000 (0:00:03.459)       0:00:07.051 *****
2025-10-08 16:00:13.259942 | controller | changed: [instance]
2025-10-08 16:00:13.957296 | controller |
2025-10-08 16:00:13.957336 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-10-08 16:00:13.957345 | controller | Wednesday 08 October 2025  16:00:13 +0000 (0:00:07.972)       0:00:15.024 *****
2025-10-08 16:00:13.957356 | controller | changed: [instance]
2025-10-08 16:00:13.981256 | controller |
2025-10-08 16:00:13.981286 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-10-08 16:00:13.981295 | controller | Wednesday 08 October 2025  16:00:13 +0000 (0:00:00.697)       0:00:15.721 *****
2025-10-08 16:00:13.981305 | controller | skipping: [instance]
2025-10-08 16:00:13.981510 | controller |
2025-10-08 16:00:13.981545 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-10-08 16:00:14.815229 | controller | Wednesday 08 October 2025  16:00:13 +0000 (0:00:00.024)       0:00:15.745 *****
2025-10-08 16:00:14.815264 | controller | changed: [instance]
2025-10-08 16:00:14.815291 | controller |
2025-10-08 16:00:14.815298 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-10-08 16:00:14.815305 | controller | Wednesday 08 October 2025  16:00:14 +0000 (0:00:00.833)       0:00:16.579 *****
2025-10-08 16:00:14.843824 | controller | skipping: [instance]
2025-10-08 16:00:14.872240 | controller |
2025-10-08 16:00:14.872274 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-10-08 16:00:14.872285 | controller | Wednesday 08 October 2025  16:00:14 +0000 (0:00:00.028)       0:00:16.608 *****
2025-10-08 16:00:14.872297 | controller | skipping: [instance]
2025-10-08 16:00:14.872324 | controller |
2025-10-08 16:00:14.872333 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-10-08 16:00:14.872342 | controller | Wednesday 08 October 2025  16:00:14 +0000 (0:00:00.028)       0:00:16.636 *****
2025-10-08 16:00:14.899849 | controller | skipping: [instance]
2025-10-08 16:00:15.452336 | controller |
2025-10-08 16:00:15.452369 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-10-08 16:00:15.452377 | controller | Wednesday 08 October 2025  16:00:14 +0000 (0:00:00.027)       0:00:16.664 *****
2025-10-08 16:00:15.452388 | controller | changed: [instance]
2025-10-08 16:00:15.877918 | controller |
2025-10-08 16:00:15.877948 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-10-08 16:00:15.877957 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.552)       0:00:17.216 *****
2025-10-08 16:00:15.877967 | controller | changed: [instance]
2025-10-08 16:00:15.897738 | controller |
2025-10-08 16:00:15.897763 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-10-08 16:00:15.897771 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.425)       0:00:17.642 *****
2025-10-08 16:00:15.897782 | controller | skipping: [instance]
2025-10-08 16:00:15.917122 | controller |
2025-10-08 16:00:15.917176 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-10-08 16:00:15.917188 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.019)       0:00:17.662 *****
2025-10-08 16:00:15.917201 | controller | skipping: [instance]
2025-10-08 16:00:15.936013 | controller |
2025-10-08 16:00:15.936035 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-10-08 16:00:15.936043 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.019)       0:00:17.681 *****
2025-10-08 16:00:15.936052 | controller | skipping: [instance]
2025-10-08 16:00:15.964369 | controller |
2025-10-08 16:00:15.964396 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-10-08 16:00:15.964405 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.018)       0:00:17.700 *****
2025-10-08 16:00:15.964415 | controller | ok: [instance]
2025-10-08 16:00:15.981589 | controller |
2025-10-08 16:00:15.981614 | controller | TASK [repo_setup : Create download directory] **********************************
2025-10-08 16:00:15.981621 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.028)       0:00:17.728 *****
2025-10-08 16:00:15.981631 | controller | skipping: [instance]
2025-10-08 16:00:15.998687 | controller |
2025-10-08 16:00:15.998719 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-10-08 16:00:15.998727 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.017)       0:00:17.746 *****
2025-10-08 16:00:15.998745 | controller | skipping: [instance]
2025-10-08 16:00:16.014726 | controller |
2025-10-08 16:00:16.014760 | controller | TASK [Download the RPM] ********************************************************
2025-10-08 16:00:16.014769 | controller | Wednesday 08 October 2025  16:00:15 +0000 (0:00:00.016)       0:00:17.763 *****
2025-10-08 16:00:16.014779 | controller | skipping: [instance]
2025-10-08 16:00:16.031746 | controller |
2025-10-08 16:00:16.031779 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-10-08 16:00:16.031787 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.015)       0:00:17.779 *****
2025-10-08 16:00:16.031797 | controller | skipping: [instance]
2025-10-08 16:00:16.031965 | controller |
2025-10-08 16:00:16.032123 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-10-08 16:00:16.032313 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.017)       0:00:17.796 *****
2025-10-08 16:00:16.047872 | controller | skipping: [instance]
2025-10-08 16:00:16.048044 | controller |
2025-10-08 16:00:16.048244 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-10-08 16:00:16.048399 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.016)       0:00:17.812 *****
2025-10-08 16:00:16.066250 | controller | skipping: [instance]
2025-10-08 16:00:16.066427 | controller |
2025-10-08 16:00:16.066587 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-10-08 16:00:16.066739 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.018)       0:00:17.831 *****
2025-10-08 16:00:16.084876 | controller | skipping: [instance]
2025-10-08 16:00:16.085045 | controller |
2025-10-08 16:00:16.085242 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-10-08 16:00:16.085396 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.018)       0:00:17.849 *****
2025-10-08 16:00:16.281650 | controller | ok: [instance]
2025-10-08 16:00:16.496816 | controller |
2025-10-08 16:00:16.496846 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-10-08 16:00:16.496855 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.196)       0:00:18.045 *****
2025-10-08 16:00:16.496865 | controller | changed: [instance]
2025-10-08 16:00:16.721073 | controller |
2025-10-08 16:00:16.721108 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-10-08 16:00:16.721117 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.215)       0:00:18.261 *****
2025-10-08 16:00:16.721126 | controller | changed: [instance]
2025-10-08 16:00:16.743237 | controller |
2025-10-08 16:00:16.743279 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-10-08 16:00:16.743288 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.224)       0:00:18.485 *****
2025-10-08 16:00:16.743298 | controller | skipping: [instance]
2025-10-08 16:00:16.743317 | controller |
2025-10-08 16:00:16.743323 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-10-08 16:00:16.743330 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.022)       0:00:18.508 *****
2025-10-08 16:00:16.765969 | controller | skipping: [instance]
2025-10-08 16:00:16.766058 | controller |
2025-10-08 16:00:16.766206 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-10-08 16:00:16.766353 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.023)       0:00:18.531 *****
2025-10-08 16:00:16.789547 | controller | skipping: [instance]
2025-10-08 16:00:16.812228 | controller |
2025-10-08 16:00:16.812253 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-10-08 16:00:16.812263 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.023)       0:00:18.554 *****
2025-10-08 16:00:16.812275 | controller | skipping: [instance]
2025-10-08 16:00:16.812304 | controller |
2025-10-08 16:00:16.812561 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-10-08 16:00:16.835613 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.022)       0:00:18.577 *****
2025-10-08 16:00:16.835641 | controller | skipping: [instance]
2025-10-08 16:00:16.858230 | controller |
2025-10-08 16:00:16.858256 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-10-08 16:00:16.858272 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.023)       0:00:18.600 *****
2025-10-08 16:00:16.858282 | controller | skipping: [instance]
2025-10-08 16:00:16.858305 | controller |
2025-10-08 16:00:16.858313 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-10-08 16:00:16.858418 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.022)       0:00:18.622 *****
2025-10-08 16:00:16.875717 | controller | skipping: [instance]
2025-10-08 16:00:16.896085 | controller |
2025-10-08 16:00:16.896105 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-10-08 16:00:16.896113 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.017)       0:00:18.640 *****
2025-10-08 16:00:16.896121 | controller | skipping: [instance]
2025-10-08 16:00:16.914119 | controller |
2025-10-08 16:00:16.914164 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-10-08 16:00:16.914187 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.020)       0:00:18.660 *****
2025-10-08 16:00:16.914197 | controller | skipping: [instance]
2025-10-08 16:00:16.935669 | controller |
2025-10-08 16:00:16.935689 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-10-08 16:00:16.935697 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.018)       0:00:18.678 *****
2025-10-08 16:00:16.935705 | controller | skipping: [instance]
2025-10-08 16:00:16.958841 | controller |
2025-10-08 16:00:16.958862 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2025-10-08 16:00:16.958869 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.021)       0:00:18.700 *****
2025-10-08 16:00:16.958879 | controller | skipping: [instance]
2025-10-08 16:00:16.980131 | controller |
2025-10-08 16:00:16.980187 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2025-10-08 16:00:16.980196 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.023)       0:00:18.723 *****
2025-10-08 16:00:16.980205 | controller | skipping: [instance]
2025-10-08 16:00:17.002899 | controller |
2025-10-08 16:00:17.002924 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2025-10-08 16:00:17.002934 | controller | Wednesday 08 October 2025  16:00:16 +0000 (0:00:00.021)       0:00:18.744 *****
2025-10-08 16:00:17.002945 | controller | skipping: [instance]
2025-10-08 16:00:17.024221 | controller |
2025-10-08 16:00:17.024252 | controller | TASK [test_deps : Install additional packages] *********************************
2025-10-08 16:00:17.024262 | controller | Wednesday 08 October 2025  16:00:17 +0000 (0:00:00.022)       0:00:18.767 *****
2025-10-08 16:00:17.024274 | controller | skipping: [instance]
2025-10-08 16:00:55.516555 | controller |
2025-10-08 16:00:55.516588 | controller | TASK [test_deps : Install selinux python libs] *********************************
2025-10-08 16:00:55.516597 | controller | Wednesday 08 October 2025  16:00:17 +0000 (0:00:00.021)       0:00:18.788 *****
2025-10-08 16:00:55.516607 | controller | ok: [instance]
2025-10-08 16:00:56.662974 | controller |
2025-10-08 16:00:56.663004 | controller | TASK [test_deps : Install python yaml libs] ************************************
2025-10-08 16:00:56.663012 | controller | Wednesday 08 October 2025  16:00:55 +0000 (0:00:38.492)       0:00:57.280 *****
2025-10-08 16:00:56.663022 | controller | ok: [instance]
2025-10-08 16:00:56.685767 | controller |
2025-10-08 16:00:56.685794 | controller | TASK [test_deps : Install extra packages] **************************************
2025-10-08 16:00:56.685802 | controller | Wednesday 08 October 2025  16:00:56 +0000 (0:00:01.146)       0:00:58.427 *****
2025-10-08 16:00:56.685812 | controller | skipping: [instance]
2025-10-08 16:00:56.719617 | controller |
2025-10-08 16:00:56.719644 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2025-10-08 16:00:56.719651 | controller | Wednesday 08 October 2025  16:00:56 +0000 (0:00:00.022)       0:00:58.450 *****
2025-10-08 16:00:56.719662 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2025-10-08 16:00:56.740251 | controller |
2025-10-08 16:00:56.740279 | controller | TASK [ci_setup : List packages to install] *************************************
2025-10-08 16:00:56.740287 | controller | Wednesday 08 October 2025  16:00:56 +0000 (0:00:00.033)       0:00:58.484 *****
2025-10-08 16:00:56.740306 | controller | ok: [instance] =>
2025-10-08 16:00:56.740466 | controller |   cifmw_ci_setup_packages:
2025-10-08 16:00:56.740483 | controller |   - bash-completion
2025-10-08 16:00:56.740491 | controller |   - ca-certificates
2025-10-08 16:00:56.740496 | controller |   - git-core
2025-10-08 16:00:56.740502 | controller |   - make
2025-10-08 16:00:56.740508 | controller |   - tar
2025-10-08 16:00:56.740513 | controller |   - tmux
2025-10-08 16:00:56.740521 | controller |   - python3-pip
2025-10-08 16:00:56.740527 | controller |
2025-10-08 16:00:56.740535 | controller | TASK [ci_setup : Install needed packages] **************************************
2025-10-08 16:01:00.736800 | controller | Wednesday 08 October 2025  16:00:56 +0000 (0:00:00.019)       0:00:58.504 *****
2025-10-08 16:01:00.736835 | controller | changed: [instance]
2025-10-08 16:01:00.915840 | controller |
2025-10-08 16:01:00.915872 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2025-10-08 16:01:00.915881 | controller | Wednesday 08 October 2025  16:01:00 +0000 (0:00:03.997)       0:01:02.501 *****
2025-10-08 16:01:00.915897 | controller | ok: [instance]
2025-10-08 16:01:01.104637 | controller |
2025-10-08 16:01:01.104671 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2025-10-08 16:01:01.104679 | controller | Wednesday 08 October 2025  16:01:00 +0000 (0:00:00.178)       0:01:02.680 *****
2025-10-08 16:01:01.104690 | controller | changed: [instance]
2025-10-08 16:01:07.003217 | controller |
2025-10-08 16:01:07.003249 | controller | TASK [ci_setup : Install openshift client] *************************************
2025-10-08 16:01:07.003258 | controller | Wednesday 08 October 2025  16:01:01 +0000 (0:00:00.188)       0:01:02.869 *****
2025-10-08 16:01:07.003267 | controller | changed: [instance]
2025-10-08 16:01:07.032117 | controller |
2025-10-08 16:01:07.032165 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2025-10-08 16:01:07.032176 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:05.898)       0:01:08.767 *****
2025-10-08 16:01:07.032186 | controller | ok: [instance]
2025-10-08 16:01:07.299044 | controller |
2025-10-08 16:01:07.299077 | controller | TASK [ci_setup : Create completion file] ***************************************
2025-10-08 16:01:07.299085 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.029)       0:01:08.796 *****
2025-10-08 16:01:07.299095 | controller | changed: [instance]
2025-10-08 16:01:07.573321 | controller |
2025-10-08 16:01:07.573351 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2025-10-08 16:01:07.573360 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.266)       0:01:09.063 *****
2025-10-08 16:01:07.573370 | controller | changed: [instance]
2025-10-08 16:01:07.590253 | controller |
2025-10-08 16:01:07.590292 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2025-10-08 16:01:07.590302 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.274)       0:01:09.337 *****
2025-10-08 16:01:07.590315 | controller | skipping: [instance]
2025-10-08 16:01:07.590346 | controller |
2025-10-08 16:01:07.590595 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2025-10-08 16:01:07.605647 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.017)       0:01:09.355 *****
2025-10-08 16:01:07.605673 | controller | skipping: [instance]
2025-10-08 16:01:07.621978 | controller |
2025-10-08 16:01:07.622000 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2025-10-08 16:01:07.622008 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.015)       0:01:09.370 *****
2025-10-08 16:01:07.622018 | controller | skipping: [instance]
2025-10-08 16:01:07.637216 | controller |
2025-10-08 16:01:07.637241 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2025-10-08 16:01:07.637249 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.016)       0:01:09.386 *****
2025-10-08 16:01:07.637259 | controller | skipping: [instance]
2025-10-08 16:01:07.637486 | controller |
2025-10-08 16:01:07.637507 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2025-10-08 16:01:07.652714 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.015)       0:01:09.402 *****
2025-10-08 16:01:07.652738 | controller | skipping: [instance]
2025-10-08 16:01:07.674991 | controller |
2025-10-08 16:01:07.675016 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2025-10-08 16:01:07.675031 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.015)       0:01:09.417 *****
2025-10-08 16:01:07.675041 | controller | skipping: [instance]
2025-10-08 16:01:08.625392 | controller |
2025-10-08 16:01:08.625424 | controller | TASK [ci_setup : Manage directories] *******************************************
2025-10-08 16:01:08.625432 | controller | Wednesday 08 October 2025  16:01:07 +0000 (0:00:00.022)       0:01:09.439 *****
2025-10-08 16:01:08.625442 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2025-10-08 16:01:08.826649 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2025-10-08 16:01:08.826680 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2025-10-08 16:01:08.826688 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2025-10-08 16:01:08.826694 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2025-10-08 16:01:08.826699 | controller |
2025-10-08 16:01:08.826705 | controller | TASK [Ensure directory exists] *************************************************
2025-10-08 16:01:08.826710 | controller | Wednesday 08 October 2025  16:01:08 +0000 (0:00:00.949)       0:01:10.389 *****
2025-10-08 16:01:08.826720 | controller | changed: [instance]
2025-10-08 16:01:09.191729 | controller |
2025-10-08 16:01:09.191760 | controller | TASK [Create nova migration keypair] *******************************************
2025-10-08 16:01:09.191768 | controller | Wednesday 08 October 2025  16:01:08 +0000 (0:00:00.201)       0:01:10.591 *****
2025-10-08 16:01:09.191778 | controller | changed: [instance]
2025-10-08 16:01:09.790615 | controller |
2025-10-08 16:01:09.790664 | controller | PLAY [Download tools] **********************************************************
2025-10-08 16:01:09.790673 | controller |
2025-10-08 16:01:09.790679 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 16:01:09.790690 | controller | Wednesday 08 October 2025  16:01:09 +0000 (0:00:00.365)       0:01:10.956 *****
2025-10-08 16:01:09.790699 | controller | ok: [localhost]
2025-10-08 16:01:14.587441 | controller |
2025-10-08 16:01:14.587473 | controller | TASK [download_tools : Install build dependencies] *****************************
2025-10-08 16:01:14.587481 | controller | Wednesday 08 October 2025  16:01:09 +0000 (0:00:00.598)       0:01:11.555 *****
2025-10-08 16:01:14.587491 | controller | changed: [localhost]
2025-10-08 16:01:14.587655 | controller |
2025-10-08 16:01:14.587668 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-10-08 16:01:14.587677 | controller | Wednesday 08 October 2025  16:01:14 +0000 (0:00:04.796)       0:01:16.351 *****
2025-10-08 16:01:14.608745 | controller | skipping: [localhost]
2025-10-08 16:01:14.633235 | controller |
2025-10-08 16:01:14.633267 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-10-08 16:01:14.633276 | controller | Wednesday 08 October 2025  16:01:14 +0000 (0:00:00.021)       0:01:16.373 *****
2025-10-08 16:01:14.633286 | controller | ok: [localhost]
2025-10-08 16:01:14.827386 | controller |
2025-10-08 16:01:14.827419 | controller | TASK [download_tools : Create $HOME/bin dir] ***********************************
2025-10-08 16:01:14.827428 | controller | Wednesday 08 October 2025  16:01:14 +0000 (0:00:00.024)       0:01:16.397 *****
2025-10-08 16:01:14.827438 | controller | ok: [localhost]
2025-10-08 16:01:15.986376 | controller |
2025-10-08 16:01:15.986410 | controller | TASK [download_tools : Download opm] *******************************************
2025-10-08 16:01:15.986419 | controller | Wednesday 08 October 2025  16:01:14 +0000 (0:00:00.194)       0:01:16.591 *****
2025-10-08 16:01:15.986428 | controller | changed: [localhost]
2025-10-08 16:01:16.006708 | controller |
2025-10-08 16:01:16.006756 | controller | TASK [download_tools : Get version from sdk_version] ***************************
2025-10-08 16:01:16.006766 | controller | Wednesday 08 October 2025  16:01:15 +0000 (0:00:01.158)       0:01:17.750 *****
2025-10-08 16:01:16.006779 | controller | ok: [localhost]
2025-10-08 16:01:16.025402 | controller |
2025-10-08 16:01:16.025423 | controller | TASK [download_tools : Set operator-sdk file for version < 1.3.0] **************
2025-10-08 16:01:16.025432 | controller | Wednesday 08 October 2025  16:01:16 +0000 (0:00:00.020)       0:01:17.771 *****
2025-10-08 16:01:16.025444 | controller | skipping: [localhost]
2025-10-08 16:01:16.045968 | controller |
2025-10-08 16:01:16.045995 | controller | TASK [download_tools : Set operator-sdk file for version >= 1.3.0] *************
2025-10-08 16:01:16.046002 | controller | Wednesday 08 October 2025  16:01:16 +0000 (0:00:00.018)       0:01:17.790 *****
2025-10-08 16:01:16.046011 | controller | ok: [localhost]
2025-10-08 16:01:17.589212 | controller |
2025-10-08 16:01:17.589242 | controller | TASK [download_tools : Download operator-sdk] **********************************
2025-10-08 16:01:17.589251 | controller | Wednesday 08 October 2025  16:01:16 +0000 (0:00:00.020)       0:01:17.810 *****
2025-10-08 16:01:17.589260 | controller | changed: [localhost]
2025-10-08 16:01:17.589319 | controller |
2025-10-08 16:01:17.589351 | controller | TASK [download_tools : Download and extract kustomize] *************************
2025-10-08 16:01:17.589363 | controller | Wednesday 08 October 2025  16:01:17 +0000 (0:00:01.543)       0:01:19.353 *****
2025-10-08 16:01:18.561927 | controller | changed: [localhost]
2025-10-08 16:01:19.045986 | controller |
2025-10-08 16:01:19.046025 | controller | TASK [download_tools : Download kubectl] ***************************************
2025-10-08 16:01:19.046035 | controller | Wednesday 08 October 2025  16:01:18 +0000 (0:00:00.972)       0:01:20.326 *****
2025-10-08 16:01:19.046045 | controller | ok: [localhost]
2025-10-08 16:01:19.975783 | controller |
2025-10-08 16:01:19.975836 | controller | TASK [download_tools : Download kuttl] *****************************************
2025-10-08 16:01:19.975844 | controller | Wednesday 08 October 2025  16:01:19 +0000 (0:00:00.483)       0:01:20.810 *****
2025-10-08 16:01:19.975854 | controller | changed: [localhost]
2025-10-08 16:01:22.943367 | controller |
2025-10-08 16:01:22.943408 | controller | TASK [download_tools : Download chainsaw] **************************************
2025-10-08 16:01:22.943417 | controller | Wednesday 08 October 2025  16:01:19 +0000 (0:00:00.929)       0:01:21.739 *****
2025-10-08 16:01:22.943427 | controller | changed: [localhost]
2025-10-08 16:01:23.966304 | controller |
2025-10-08 16:01:23.966338 | controller | TASK [download_tools : Download and extract yq] ********************************
2025-10-08 16:01:23.966347 | controller | Wednesday 08 October 2025  16:01:22 +0000 (0:00:02.967)       0:01:24.707 *****
2025-10-08 16:01:23.966358 | controller | changed: [localhost]
2025-10-08 16:01:23.966380 | controller |
2025-10-08 16:01:23.966389 | controller | TASK [download_tools : Link yq_linux_amd64 as yq] ******************************
2025-10-08 16:01:23.966452 | controller | Wednesday 08 October 2025  16:01:23 +0000 (0:00:01.023)       0:01:25.730 *****
2025-10-08 16:01:24.147250 | controller | changed: [localhost]
2025-10-08 16:01:24.147294 | controller |
2025-10-08 16:01:24.147530 | controller | TASK [download_tools : Deinstall golang] ***************************************
2025-10-08 16:01:25.622789 | controller | Wednesday 08 October 2025  16:01:24 +0000 (0:00:00.181)       0:01:25.912 *****
2025-10-08 16:01:25.622824 | controller | ok: [localhost]
2025-10-08 16:01:26.521714 | controller |
2025-10-08 16:01:26.521746 | controller | TASK [download_tools : Delete old go version installed from upstream] **********
2025-10-08 16:01:26.521754 | controller | Wednesday 08 October 2025  16:01:25 +0000 (0:00:01.475)       0:01:27.387 *****
2025-10-08 16:01:26.521765 | controller | ok: [localhost] => (item=/usr/local/go)
2025-10-08 16:01:39.287986 | controller | ok: [localhost] => (item=/home/zuul/bin/go)
2025-10-08 16:01:39.288017 | controller | ok: [localhost] => (item=/home/zuul/bin/gofmt)
2025-10-08 16:01:39.288024 | controller | ok: [localhost] => (item=/usr/local/bin/go)
2025-10-08 16:01:39.288030 | controller | ok: [localhost] => (item=/usr/local/bin/gofmt)
2025-10-08 16:01:39.288035 | controller |
2025-10-08 16:01:39.288041 | controller | TASK [download_tools : Download and extract golang] ****************************
2025-10-08 16:01:39.288047 | controller | Wednesday 08 October 2025  16:01:26 +0000 (0:00:00.898)       0:01:28.285 *****
2025-10-08 16:01:39.288057 | controller | changed: [localhost]
2025-10-08 16:01:39.661289 | controller |
2025-10-08 16:01:39.661320 | controller | TASK [download_tools : Set alternatives link to installed go version] **********
2025-10-08 16:01:39.661328 | controller | Wednesday 08 October 2025  16:01:39 +0000 (0:00:12.767)       0:01:41.052 *****
2025-10-08 16:01:39.661339 | controller | changed: [localhost] => (item=go)
2025-10-08 16:01:39.696262 | controller | changed: [localhost] => (item=gofmt)
2025-10-08 16:01:39.696303 | controller |
2025-10-08 16:01:39.696311 | controller | TASK [download_tools : Clean bash cache] ***************************************
2025-10-08 16:01:39.696326 | controller | Wednesday 08 October 2025  16:01:39 +0000 (0:00:00.373)       0:01:41.425 *****
2025-10-08 16:01:39.696337 | controller | ok: [localhost] =>
2025-10-08 16:01:39.696394 | controller |   msg: When move from rpm to upstream version, make sure to clean bash cache using `hash -d go`
2025-10-08 16:01:39.696404 | controller |
2025-10-08 16:01:39.696410 | controller | PLAY RECAP *********************************************************************
2025-10-08 16:01:39.696416 | controller | instance                   : ok=31   changed=17   unreachable=0    failed=0    skipped=36   rescued=0    ignored=0
2025-10-08 16:01:39.696422 | controller | localhost                  : ok=19   changed=10   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-08 16:01:39.696428 | controller |
2025-10-08 16:01:39.696433 | controller | Wednesday 08 October 2025  16:01:39 +0000 (0:00:00.033)       0:01:41.458 *****
2025-10-08 16:01:39.696439 | controller | ===============================================================================
2025-10-08 16:01:39.696444 | controller | test_deps : Install selinux python libs -------------------------------- 38.49s
2025-10-08 16:01:39.696450 | controller | download_tools : Download and extract golang --------------------------- 12.77s
2025-10-08 16:01:39.696455 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.97s
2025-10-08 16:01:39.696461 | controller | ci_setup : Install openshift client ------------------------------------- 5.90s
2025-10-08 16:01:39.696466 | controller | download_tools : Install build dependencies ----------------------------- 4.80s
2025-10-08 16:01:39.696472 | controller | ci_setup : Install needed packages -------------------------------------- 4.00s
2025-10-08 16:01:39.696477 | controller | repo_setup : Get repo-setup repository ---------------------------------- 3.46s
2025-10-08 16:01:39.696483 | controller | download_tools : Download chainsaw -------------------------------------- 2.97s
2025-10-08 16:01:39.696488 | controller | download_tools : Download operator-sdk ---------------------------------- 1.54s
2025-10-08 16:01:39.696494 | controller | download_tools : Deinstall golang --------------------------------------- 1.48s
2025-10-08 16:01:39.696502 | controller | download_tools : Download opm ------------------------------------------- 1.16s
2025-10-08 16:01:39.696619 | controller | test_deps : Install python yaml libs ------------------------------------ 1.15s
2025-10-08 16:01:39.696631 | controller | download_tools : Download and extract yq -------------------------------- 1.02s
2025-10-08 16:01:39.696738 | controller | download_tools : Download and extract kustomize ------------------------- 0.97s
2025-10-08 16:01:39.696851 | controller | ci_setup : Manage directories ------------------------------------------- 0.95s
2025-10-08 16:01:39.697018 | controller | download_tools : Download kuttl ----------------------------------------- 0.93s
2025-10-08 16:01:39.697155 | controller | download_tools : Delete old go version installed from upstream ---------- 0.90s
2025-10-08 16:01:39.697277 | controller | Gathering Facts --------------------------------------------------------- 0.83s
2025-10-08 16:01:39.697390 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.83s
2025-10-08 16:01:39.697504 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.80s
2025-10-08 16:01:39.757926 | controller | INFO     Running default > converge
2025-10-08 16:01:40.193239 | controller |
2025-10-08 16:01:40.991707 | controller | PLAY [Converge] ****************************************************************
2025-10-08 16:01:40.991745 | controller |
2025-10-08 16:01:40.991754 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 16:01:40.991760 | controller | Wednesday 08 October 2025  16:01:40 +0000 (0:00:00.013)       0:00:00.013 *****
2025-10-08 16:01:40.991770 | controller | ok: [instance]
2025-10-08 16:01:41.629656 | controller |
2025-10-08 16:01:41.629688 | controller | TASK [Ensure architecture repository is building] ******************************
2025-10-08 16:01:41.629696 | controller | Wednesday 08 October 2025  16:01:40 +0000 (0:00:00.798)       0:00:00.812 *****
2025-10-08 16:01:41.629706 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-10-08 16:01:42.003949 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-10-08 16:01:42.004000 | controller |
2025-10-08 16:01:42.004009 | controller | TASK [Create nova migration keypair] *******************************************
2025-10-08 16:01:42.004015 | controller | Wednesday 08 October 2025  16:01:41 +0000 (0:00:00.638)       0:00:01.450 *****
2025-10-08 16:01:42.004026 | controller | changed: [instance]
2025-10-08 16:01:42.066728 | controller |
2025-10-08 16:01:42.066775 | controller | TASK [Generate needed facts out of local files] ********************************
2025-10-08 16:01:42.066784 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.373)       0:00:01.824 *****
2025-10-08 16:01:42.066796 | controller | ok: [instance]
2025-10-08 16:01:42.093237 | controller |
2025-10-08 16:01:42.093290 | controller | TASK [Generate network-values] *************************************************
2025-10-08 16:01:42.093301 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.062)       0:00:01.887 *****
2025-10-08 16:01:42.093316 | controller |
2025-10-08 16:01:42.121261 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 16:01:42.121293 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.026)       0:00:01.914 *****
2025-10-08 16:01:42.121306 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 16:01:42.121605 | controller |
2025-10-08 16:01:42.121662 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 16:01:42.148292 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.027)       0:00:01.942 *****
2025-10-08 16:01:42.148344 | controller | ok: [instance] => changed=false
2025-10-08 16:01:42.148548 | controller |   msg: All assertions passed
2025-10-08 16:01:42.148699 | controller |
2025-10-08 16:01:42.148847 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 16:01:42.148993 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.027)       0:00:01.969 *****
2025-10-08 16:01:42.441027 | controller | ok: [instance]
2025-10-08 16:01:42.472253 | controller |
2025-10-08 16:01:42.472290 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 16:01:42.472299 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.292)       0:00:02.262 *****
2025-10-08 16:01:42.472310 | controller | ok: [instance] => changed=false
2025-10-08 16:01:42.472335 | controller |   msg: All assertions passed
2025-10-08 16:01:42.472342 | controller |
2025-10-08 16:01:42.472349 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 16:01:42.472486 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.031)       0:00:02.293 *****
2025-10-08 16:01:42.750329 | controller | ok: [instance]
2025-10-08 16:01:43.014724 | controller |
2025-10-08 16:01:43.014759 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 16:01:43.014768 | controller | Wednesday 08 October 2025  16:01:42 +0000 (0:00:00.278)       0:00:02.571 *****
2025-10-08 16:01:43.014778 | controller | ok: [instance]
2025-10-08 16:01:43.057843 | controller |
2025-10-08 16:01:43.057866 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 16:01:43.057874 | controller | Wednesday 08 October 2025  16:01:43 +0000 (0:00:00.264)       0:00:02.835 *****
2025-10-08 16:01:43.057884 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 16:01:43.082826 | controller |
2025-10-08 16:01:43.082846 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 16:01:43.082854 | controller | Wednesday 08 October 2025  16:01:43 +0000 (0:00:00.043)       0:00:02.878 *****
2025-10-08 16:01:43.082863 | controller | ok: [instance] => changed=false
2025-10-08 16:01:43.367913 | controller |   msg: All assertions passed
2025-10-08 16:01:43.367944 | controller |
2025-10-08 16:01:43.367957 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 16:01:43.367964 | controller | Wednesday 08 October 2025  16:01:43 +0000 (0:00:00.024)       0:00:02.903 *****
2025-10-08 16:01:43.367974 | controller | changed: [instance]
2025-10-08 16:01:43.924583 | controller |
2025-10-08 16:01:43.924617 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 16:01:43.924640 | controller | Wednesday 08 October 2025  16:01:43 +0000 (0:00:00.284)       0:00:03.188 *****
2025-10-08 16:01:43.924651 | controller | changed: [instance]
2025-10-08 16:01:43.960507 | controller |
2025-10-08 16:01:43.960541 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 16:01:43.960549 | controller | Wednesday 08 October 2025  16:01:43 +0000 (0:00:00.556)       0:00:03.745 *****
2025-10-08 16:01:43.960559 | controller | ok: [instance]
2025-10-08 16:01:44.303394 | controller |
2025-10-08 16:01:44.303429 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 16:01:44.303437 | controller | Wednesday 08 October 2025  16:01:43 +0000 (0:00:00.035)       0:00:03.781 *****
2025-10-08 16:01:44.303447 | controller | changed: [instance]
2025-10-08 16:01:44.652550 | controller |
2025-10-08 16:01:44.652584 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 16:01:44.652592 | controller | Wednesday 08 October 2025  16:01:44 +0000 (0:00:00.342)       0:00:04.124 *****
2025-10-08 16:01:44.652603 | controller | changed: [instance]
2025-10-08 16:01:45.005228 | controller |
2025-10-08 16:01:45.005261 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 16:01:45.005269 | controller | Wednesday 08 October 2025  16:01:44 +0000 (0:00:00.349)       0:00:04.473 *****
2025-10-08 16:01:45.005280 | controller | changed: [instance]
2025-10-08 16:01:45.005302 | controller |
2025-10-08 16:01:45.005310 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 16:01:45.005372 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.352)       0:00:04.826 *****
2025-10-08 16:01:45.032600 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 16:01:45.057450 | controller |
2025-10-08 16:01:45.057476 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 16:01:45.057484 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.027)       0:00:04.853 *****
2025-10-08 16:01:45.057494 | controller | ok: [instance] => changed=false
2025-10-08 16:01:45.335235 | controller |   msg: All assertions passed
2025-10-08 16:01:45.335268 | controller |
2025-10-08 16:01:45.335276 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 16:01:45.335283 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.024)       0:00:04.878 *****
2025-10-08 16:01:45.335299 | controller | ok: [instance]
2025-10-08 16:01:45.335326 | controller |
2025-10-08 16:01:45.335566 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 16:01:45.353432 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.278)       0:00:05.156 *****
2025-10-08 16:01:45.353468 | controller | ok: [instance]
2025-10-08 16:01:45.847239 | controller |
2025-10-08 16:01:45.847286 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 16:01:45.847294 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.018)       0:00:05.174 *****
2025-10-08 16:01:45.847306 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 16:01:45.911256 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 16:01:45.911289 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 16:01:45.911298 | controller |
2025-10-08 16:01:45.911305 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 16:01:45.911310 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.493)       0:00:05.667 *****
2025-10-08 16:01:45.911321 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 16:01:45.911344 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 16:01:45.911351 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 16:01:45.911357 | controller |
2025-10-08 16:01:45.911364 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 16:01:45.911449 | controller | Wednesday 08 October 2025  16:01:45 +0000 (0:00:00.064)       0:00:05.732 *****
2025-10-08 16:01:46.114062 | controller | changed: [instance]
2025-10-08 16:01:46.464278 | controller |
2025-10-08 16:01:46.464316 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 16:01:46.464326 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.202)       0:00:05.935 *****
2025-10-08 16:01:46.464338 | controller | changed: [instance]
2025-10-08 16:01:46.490704 | controller |
2025-10-08 16:01:46.490742 | controller | TASK [Generate edpm-nodeset-values] ********************************************
2025-10-08 16:01:46.490752 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.350)       0:00:06.285 *****
2025-10-08 16:01:46.490764 | controller |
2025-10-08 16:01:46.516069 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 16:01:46.516102 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.026)       0:00:06.311 *****
2025-10-08 16:01:46.516116 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 16:01:46.542868 | controller |
2025-10-08 16:01:46.542897 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 16:01:46.542910 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.025)       0:00:06.337 *****
2025-10-08 16:01:46.542920 | controller | ok: [instance] => changed=false
2025-10-08 16:01:46.736086 | controller |   msg: All assertions passed
2025-10-08 16:01:46.736119 | controller |
2025-10-08 16:01:46.736128 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 16:01:46.736134 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.026)       0:00:06.363 *****
2025-10-08 16:01:46.736236 | controller | ok: [instance]
2025-10-08 16:01:46.770983 | controller |
2025-10-08 16:01:46.771016 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 16:01:46.771024 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.193)       0:00:06.557 *****
2025-10-08 16:01:46.771035 | controller | ok: [instance] => changed=false
2025-10-08 16:01:46.958127 | controller |   msg: All assertions passed
2025-10-08 16:01:46.958176 | controller |
2025-10-08 16:01:46.958185 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 16:01:46.958202 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.034)       0:00:06.591 *****
2025-10-08 16:01:46.958212 | controller | ok: [instance]
2025-10-08 16:01:47.188136 | controller |
2025-10-08 16:01:47.188183 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 16:01:47.188192 | controller | Wednesday 08 October 2025  16:01:46 +0000 (0:00:00.187)       0:00:06.779 *****
2025-10-08 16:01:47.188214 | controller | ok: [instance]
2025-10-08 16:01:47.230954 | controller |
2025-10-08 16:01:47.230986 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 16:01:47.230994 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.229)       0:00:07.009 *****
2025-10-08 16:01:47.231004 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-10-08 16:01:47.265067 | controller |
2025-10-08 16:01:47.265097 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-10-08 16:01:47.265105 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.042)       0:00:07.051 *****
2025-10-08 16:01:47.265116 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-10-08 16:01:47.294741 | controller |
2025-10-08 16:01:47.294767 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-10-08 16:01:47.294775 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.034)       0:00:07.086 *****
2025-10-08 16:01:47.294785 | controller | ok: [instance] => changed=false
2025-10-08 16:01:47.319799 | controller |   msg: All assertions passed
2025-10-08 16:01:47.319823 | controller |
2025-10-08 16:01:47.319831 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-10-08 16:01:47.319845 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.029)       0:00:07.115 *****
2025-10-08 16:01:47.319855 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-10-08 16:01:47.335434 | controller |
2025-10-08 16:01:47.335456 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-10-08 16:01:47.335464 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.025)       0:00:07.140 *****
2025-10-08 16:01:47.335475 | controller | skipping: [instance]
2025-10-08 16:01:47.355050 | controller |
2025-10-08 16:01:47.355079 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-10-08 16:01:47.355087 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.015)       0:00:07.156 *****
2025-10-08 16:01:47.355097 | controller | ok: [instance]
2025-10-08 16:01:47.355303 | controller |
2025-10-08 16:01:47.355471 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-10-08 16:01:47.355617 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.019)       0:00:07.176 *****
2025-10-08 16:01:47.381520 | controller | ok: [instance] => changed=false
2025-10-08 16:01:47.381706 | controller |   msg: All assertions passed
2025-10-08 16:01:47.381845 | controller |
2025-10-08 16:01:47.381994 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 16:01:47.382166 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.026)       0:00:07.202 *****
2025-10-08 16:01:47.567798 | controller | changed: [instance]
2025-10-08 16:01:47.947393 | controller |
2025-10-08 16:01:47.947426 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 16:01:47.947434 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.185)       0:00:07.388 *****
2025-10-08 16:01:47.947444 | controller | changed: [instance]
2025-10-08 16:01:47.969565 | controller |
2025-10-08 16:01:47.969591 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 16:01:47.969599 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.379)       0:00:07.768 *****
2025-10-08 16:01:47.969609 | controller | ok: [instance]
2025-10-08 16:01:48.298682 | controller |
2025-10-08 16:01:48.298715 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 16:01:48.298723 | controller | Wednesday 08 October 2025  16:01:47 +0000 (0:00:00.022)       0:00:07.790 *****
2025-10-08 16:01:48.298734 | controller | changed: [instance]
2025-10-08 16:01:48.636625 | controller |
2025-10-08 16:01:48.636657 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 16:01:48.636665 | controller | Wednesday 08 October 2025  16:01:48 +0000 (0:00:00.328)       0:00:08.119 *****
2025-10-08 16:01:48.636675 | controller | changed: [instance]
2025-10-08 16:01:48.970769 | controller |
2025-10-08 16:01:48.970802 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 16:01:48.970810 | controller | Wednesday 08 October 2025  16:01:48 +0000 (0:00:00.337)       0:00:08.457 *****
2025-10-08 16:01:48.970826 | controller | changed: [instance]
2025-10-08 16:01:48.999688 | controller |
2025-10-08 16:01:48.999721 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 16:01:48.999729 | controller | Wednesday 08 October 2025  16:01:48 +0000 (0:00:00.334)       0:00:08.791 *****
2025-10-08 16:01:48.999739 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 16:01:49.026516 | controller |
2025-10-08 16:01:49.026548 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 16:01:49.026556 | controller | Wednesday 08 October 2025  16:01:48 +0000 (0:00:00.028)       0:00:08.820 *****
2025-10-08 16:01:49.026566 | controller | ok: [instance] => changed=false
2025-10-08 16:01:49.217430 | controller |   msg: All assertions passed
2025-10-08 16:01:49.217463 | controller |
2025-10-08 16:01:49.217470 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 16:01:49.217477 | controller | Wednesday 08 October 2025  16:01:49 +0000 (0:00:00.026)       0:00:08.847 *****
2025-10-08 16:01:49.217493 | controller | ok: [instance]
2025-10-08 16:01:49.236086 | controller |
2025-10-08 16:01:49.236106 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 16:01:49.236114 | controller | Wednesday 08 October 2025  16:01:49 +0000 (0:00:00.190)       0:00:09.038 *****
2025-10-08 16:01:49.236123 | controller | ok: [instance]
2025-10-08 16:01:49.745609 | controller |
2025-10-08 16:01:49.745641 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 16:01:49.745649 | controller | Wednesday 08 October 2025  16:01:49 +0000 (0:00:00.019)       0:00:09.057 *****
2025-10-08 16:01:49.745659 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-10-08 16:01:49.793265 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-10-08 16:01:49.793301 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-10-08 16:01:49.793311 | controller |
2025-10-08 16:01:49.793319 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 16:01:49.793327 | controller | Wednesday 08 October 2025  16:01:49 +0000 (0:00:00.509)       0:00:09.566 *****
2025-10-08 16:01:49.793338 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 16:01:49.793366 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 16:01:49.793374 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 16:01:49.793381 | controller |
2025-10-08 16:01:49.793389 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 16:01:49.793483 | controller | Wednesday 08 October 2025  16:01:49 +0000 (0:00:00.047)       0:00:09.614 *****
2025-10-08 16:01:49.989915 | controller | changed: [instance]
2025-10-08 16:01:50.334252 | controller |
2025-10-08 16:01:50.334285 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 16:01:50.334294 | controller | Wednesday 08 October 2025  16:01:49 +0000 (0:00:00.196)       0:00:09.810 *****
2025-10-08 16:01:50.334304 | controller | changed: [instance]
2025-10-08 16:01:50.664313 | controller |
2025-10-08 16:01:50.664344 | controller | TASK [Get generated files status] **********************************************
2025-10-08 16:01:50.664352 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.344)       0:00:10.155 *****
2025-10-08 16:01:50.664362 | controller | ok: [instance] => (item=network-values)
2025-10-08 16:01:50.664721 | controller | ok: [instance] => (item=edpm-nodeset-values)
2025-10-08 16:01:50.691241 | controller |
2025-10-08 16:01:50.691295 | controller | TASK [Assert generated values.yaml exists] *************************************
2025-10-08 16:01:50.691306 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.330)       0:00:10.485 *****
2025-10-08 16:01:50.691318 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml) => changed=false
2025-10-08 16:01:50.691345 | controller |   ansible_loop_var: item
2025-10-08 16:01:50.691354 | controller |   item:
2025-10-08 16:01:50.691361 | controller |     ansible_loop_var: item
2025-10-08 16:01:50.691368 | controller |     changed: false
2025-10-08 16:01:50.691374 | controller |     failed: false
2025-10-08 16:01:50.691381 | controller |     invocation:
2025-10-08 16:01:50.691389 | controller |       module_args:
2025-10-08 16:01:50.691413 | controller |         checksum_algorithm: sha1
2025-10-08 16:01:50.692170 | controller |         follow: false
2025-10-08 16:01:50.693278 | controller |         get_attributes: false
2025-10-08 16:01:50.693294 | controller |         get_checksum: false
2025-10-08 16:01:50.693301 | controller |         get_md5: false
2025-10-08 16:01:50.693307 | controller |         get_mime: false
2025-10-08 16:01:50.693312 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 16:01:50.693318 | controller |     item: network-values
2025-10-08 16:01:50.693323 | controller |     stat:
2025-10-08 16:01:50.693332 | controller |       atime: 1759939306.4253511
2025-10-08 16:01:50.693353 | controller |       block_size: 4096
2025-10-08 16:01:50.693360 | controller |       blocks: 16
2025-10-08 16:01:50.693365 | controller |       ctime: 1759939306.4283512
2025-10-08 16:01:50.693371 | controller |       dev: 64513
2025-10-08 16:01:50.693376 | controller |       device_type: 0
2025-10-08 16:01:50.693389 | controller |       executable: false
2025-10-08 16:01:50.693395 | controller |       exists: true
2025-10-08 16:01:50.693400 | controller |       gid: 1000
2025-10-08 16:01:50.693405 | controller |       gr_name: zuul
2025-10-08 16:01:50.693410 | controller |       inode: 67124386
2025-10-08 16:01:50.693416 | controller |       isblk: false
2025-10-08 16:01:50.693423 | controller |       ischr: false
2025-10-08 16:01:50.693482 | controller |       isdir: false
2025-10-08 16:01:50.693594 | controller |       isfifo: false
2025-10-08 16:01:50.693705 | controller |       isgid: false
2025-10-08 16:01:50.693813 | controller |       islnk: false
2025-10-08 16:01:50.693922 | controller |       isreg: true
2025-10-08 16:01:50.694027 | controller |       issock: false
2025-10-08 16:01:50.694137 | controller |       isuid: false
2025-10-08 16:01:50.694281 | controller |       mode: '0644'
2025-10-08 16:01:50.694411 | controller |       mtime: 1759939306.2903478
2025-10-08 16:01:50.694552 | controller |       nlink: 1
2025-10-08 16:01:50.694692 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 16:01:50.694824 | controller |       pw_name: zuul
2025-10-08 16:01:50.694954 | controller |       readable: true
2025-10-08 16:01:50.695088 | controller |       rgrp: true
2025-10-08 16:01:50.695262 | controller |       roth: true
2025-10-08 16:01:50.695410 | controller |       rusr: true
2025-10-08 16:01:50.695542 | controller |       size: 5726
2025-10-08 16:01:50.695674 | controller |       uid: 1000
2025-10-08 16:01:50.695803 | controller |       wgrp: false
2025-10-08 16:01:50.695932 | controller |       woth: false
2025-10-08 16:01:50.696060 | controller |       writeable: true
2025-10-08 16:01:50.696214 | controller |       wusr: true
2025-10-08 16:01:50.696367 | controller |       xgrp: false
2025-10-08 16:01:50.696505 | controller |       xoth: false
2025-10-08 16:01:50.696633 | controller |       xusr: false
2025-10-08 16:01:50.696765 | controller |   msg: All assertions passed
2025-10-08 16:01:50.696909 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml) => changed=false
2025-10-08 16:01:50.697050 | controller |   ansible_loop_var: item
2025-10-08 16:01:50.697202 | controller |   item:
2025-10-08 16:01:50.697356 | controller |     ansible_loop_var: item
2025-10-08 16:01:50.697487 | controller |     changed: false
2025-10-08 16:01:50.697616 | controller |     failed: false
2025-10-08 16:01:50.697742 | controller |     invocation:
2025-10-08 16:01:50.697868 | controller |       module_args:
2025-10-08 16:01:50.697997 | controller |         checksum_algorithm: sha1
2025-10-08 16:01:50.698122 | controller |         follow: false
2025-10-08 16:01:50.698288 | controller |         get_attributes: false
2025-10-08 16:01:50.698424 | controller |         get_checksum: false
2025-10-08 16:01:50.698550 | controller |         get_md5: false
2025-10-08 16:01:50.698679 | controller |         get_mime: false
2025-10-08 16:01:50.698814 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 16:01:50.698946 | controller |     item: edpm-nodeset-values
2025-10-08 16:01:50.699075 | controller |     stat:
2025-10-08 16:01:50.699225 | controller |       atime: 1759939310.2964437
2025-10-08 16:01:50.699381 | controller |       block_size: 4096
2025-10-08 16:01:50.699507 | controller |       blocks: 40
2025-10-08 16:01:50.699635 | controller |       ctime: 1759939310.2994437
2025-10-08 16:01:50.699762 | controller |       dev: 64513
2025-10-08 16:01:50.699888 | controller |       device_type: 0
2025-10-08 16:01:50.700013 | controller |       executable: false
2025-10-08 16:01:50.700152 | controller |       exists: true
2025-10-08 16:01:50.700322 | controller |       gid: 1000
2025-10-08 16:01:50.700452 | controller |       gr_name: zuul
2025-10-08 16:01:50.700578 | controller |       inode: 37764940
2025-10-08 16:01:50.700705 | controller |       isblk: false
2025-10-08 16:01:50.700840 | controller |       ischr: false
2025-10-08 16:01:50.700970 | controller |       isdir: false
2025-10-08 16:01:50.701098 | controller |       isfifo: false
2025-10-08 16:01:50.701260 | controller |       isgid: false
2025-10-08 16:01:50.701399 | controller |       islnk: false
2025-10-08 16:01:50.701524 | controller |       isreg: true
2025-10-08 16:01:50.701648 | controller |       issock: false
2025-10-08 16:01:50.701773 | controller |       isuid: false
2025-10-08 16:01:50.701900 | controller |       mode: '0644'
2025-10-08 16:01:50.702028 | controller |       mtime: 1759939310.1594405
2025-10-08 16:01:50.702174 | controller |       nlink: 1
2025-10-08 16:01:50.702333 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 16:01:50.702461 | controller |       pw_name: zuul
2025-10-08 16:01:50.702600 | controller |       readable: true
2025-10-08 16:01:50.702727 | controller |       rgrp: true
2025-10-08 16:01:50.702851 | controller |       roth: true
2025-10-08 16:01:50.702980 | controller |       rusr: true
2025-10-08 16:01:50.703103 | controller |       size: 16482
2025-10-08 16:01:50.703261 | controller |       uid: 1000
2025-10-08 16:01:50.703395 | controller |       wgrp: false
2025-10-08 16:01:50.703521 | controller |       woth: false
2025-10-08 16:01:50.703646 | controller |       writeable: true
2025-10-08 16:01:50.703770 | controller |       wusr: true
2025-10-08 16:01:50.703894 | controller |       xgrp: false
2025-10-08 16:01:50.704018 | controller |       xoth: false
2025-10-08 16:01:50.704157 | controller |       xusr: false
2025-10-08 16:01:50.704323 | controller |   msg: All assertions passed
2025-10-08 16:01:50.704450 | controller |
2025-10-08 16:01:50.704581 | controller | TASK [Ensure we have correct MAC] **********************************************
2025-10-08 16:01:50.704709 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.026)       0:00:10.512 *****
2025-10-08 16:01:50.721934 | controller | ok: [instance] => changed=false
2025-10-08 16:01:50.722097 | controller |   msg: All assertions passed
2025-10-08 16:01:50.722276 | controller |
2025-10-08 16:01:50.722424 | controller | TASK [Ensure we don't have node_1 nor node_2] **********************************
2025-10-08 16:01:50.722561 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.031)       0:00:10.543 *****
2025-10-08 16:01:50.752736 | controller | ok: [instance] => changed=false
2025-10-08 16:01:50.752946 | controller |   msg: All assertions passed
2025-10-08 16:01:50.753113 | controller |
2025-10-08 16:01:50.753328 | controller | TASK [Update cifmw_networking_env_definition] **********************************
2025-10-08 16:01:50.753473 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.030)       0:00:10.574 *****
2025-10-08 16:01:50.776558 | controller | ok: [instance]
2025-10-08 16:01:50.776757 | controller |
2025-10-08 16:01:50.776933 | controller | TASK [Regenerate network-values] ***********************************************
2025-10-08 16:01:50.777101 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.023)       0:00:10.598 *****
2025-10-08 16:01:50.798667 | controller |
2025-10-08 16:01:50.798852 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 16:01:50.798996 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.022)       0:00:10.620 *****
2025-10-08 16:01:50.822823 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 16:01:50.823022 | controller |
2025-10-08 16:01:50.823226 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 16:01:50.823427 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.024)       0:00:10.644 *****
2025-10-08 16:01:50.847007 | controller | ok: [instance] => changed=false
2025-10-08 16:01:50.847234 | controller |   msg: All assertions passed
2025-10-08 16:01:50.847421 | controller |
2025-10-08 16:01:50.847572 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 16:01:50.847709 | controller | Wednesday 08 October 2025  16:01:50 +0000 (0:00:00.024)       0:00:10.668 *****
2025-10-08 16:01:51.017720 | controller | ok: [instance]
2025-10-08 16:01:51.037604 | controller |
2025-10-08 16:01:51.037631 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 16:01:51.037639 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.170)       0:00:10.838 *****
2025-10-08 16:01:51.037650 | controller | ok: [instance] => changed=false
2025-10-08 16:01:51.204994 | controller |   msg: All assertions passed
2025-10-08 16:01:51.205024 | controller |
2025-10-08 16:01:51.205033 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 16:01:51.205039 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.019)       0:00:10.858 *****
2025-10-08 16:01:51.205049 | controller | ok: [instance]
2025-10-08 16:01:51.437129 | controller |
2025-10-08 16:01:51.437180 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 16:01:51.437189 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.167)       0:00:11.026 *****
2025-10-08 16:01:51.437199 | controller | ok: [instance]
2025-10-08 16:01:51.468350 | controller |
2025-10-08 16:01:51.468396 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 16:01:51.468419 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.231)       0:00:11.258 *****
2025-10-08 16:01:51.468431 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 16:01:51.468462 | controller |
2025-10-08 16:01:51.468469 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 16:01:51.468476 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.031)       0:00:11.289 *****
2025-10-08 16:01:51.492840 | controller | ok: [instance] => changed=false
2025-10-08 16:01:51.671395 | controller |   msg: All assertions passed
2025-10-08 16:01:51.671429 | controller |
2025-10-08 16:01:51.671437 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 16:01:51.671444 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.024)       0:00:11.313 *****
2025-10-08 16:01:51.671453 | controller | ok: [instance]
2025-10-08 16:01:52.147208 | controller |
2025-10-08 16:01:52.147245 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 16:01:52.147254 | controller | Wednesday 08 October 2025  16:01:51 +0000 (0:00:00.178)       0:00:11.492 *****
2025-10-08 16:01:52.147265 | controller | changed: [instance]
2025-10-08 16:01:52.147492 | controller |
2025-10-08 16:01:52.147527 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 16:01:52.170902 | controller | Wednesday 08 October 2025  16:01:52 +0000 (0:00:00.476)       0:00:11.968 *****
2025-10-08 16:01:52.170939 | controller | ok: [instance]
2025-10-08 16:01:52.512665 | controller |
2025-10-08 16:01:52.512699 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 16:01:52.512708 | controller | Wednesday 08 October 2025  16:01:52 +0000 (0:00:00.023)       0:00:11.991 *****
2025-10-08 16:01:52.512718 | controller | ok: [instance]
2025-10-08 16:01:52.866932 | controller |
2025-10-08 16:01:52.866975 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 16:01:52.866986 | controller | Wednesday 08 October 2025  16:01:52 +0000 (0:00:00.341)       0:00:12.333 *****
2025-10-08 16:01:52.866997 | controller | ok: [instance]
2025-10-08 16:01:53.215036 | controller |
2025-10-08 16:01:53.215067 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 16:01:53.215075 | controller | Wednesday 08 October 2025  16:01:52 +0000 (0:00:00.354)       0:00:12.687 *****
2025-10-08 16:01:53.215086 | controller | ok: [instance]
2025-10-08 16:01:53.243221 | controller |
2025-10-08 16:01:53.243253 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 16:01:53.243262 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.348)       0:00:13.036 *****
2025-10-08 16:01:53.243272 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 16:01:53.243477 | controller |
2025-10-08 16:01:53.243491 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 16:01:53.268192 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.028)       0:00:13.064 *****
2025-10-08 16:01:53.268214 | controller | ok: [instance] => changed=false
2025-10-08 16:01:53.268322 | controller |   msg: All assertions passed
2025-10-08 16:01:53.268333 | controller |
2025-10-08 16:01:53.268339 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 16:01:53.268347 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.024)       0:00:13.089 *****
2025-10-08 16:01:53.452512 | controller | ok: [instance]
2025-10-08 16:01:53.468818 | controller |
2025-10-08 16:01:53.468843 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 16:01:53.468856 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.184)       0:00:13.273 *****
2025-10-08 16:01:53.468867 | controller | ok: [instance]
2025-10-08 16:01:53.940994 | controller |
2025-10-08 16:01:53.941024 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 16:01:53.941032 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.016)       0:00:13.290 *****
2025-10-08 16:01:53.941048 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 16:01:53.994232 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 16:01:53.994267 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 16:01:53.994277 | controller |
2025-10-08 16:01:53.994286 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 16:01:53.994294 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.471)       0:00:13.761 *****
2025-10-08 16:01:53.994326 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 16:01:53.994353 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 16:01:53.994361 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 16:01:53.994370 | controller |
2025-10-08 16:01:53.994539 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 16:01:54.179026 | controller | Wednesday 08 October 2025  16:01:53 +0000 (0:00:00.053)       0:00:13.815 *****
2025-10-08 16:01:54.179061 | controller | ok: [instance]
2025-10-08 16:01:54.559699 | controller |
2025-10-08 16:01:54.559733 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 16:01:54.559742 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.184)       0:00:14.000 *****
2025-10-08 16:01:54.559752 | controller | changed: [instance]
2025-10-08 16:01:54.584745 | controller |
2025-10-08 16:01:54.584776 | controller | TASK [Regenerate edpm-nodeset-values] ******************************************
2025-10-08 16:01:54.584785 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.380)       0:00:14.380 *****
2025-10-08 16:01:54.584794 | controller |
2025-10-08 16:01:54.610193 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 16:01:54.610224 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.025)       0:00:14.405 *****
2025-10-08 16:01:54.610236 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 16:01:54.635846 | controller |
2025-10-08 16:01:54.635877 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 16:01:54.635885 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.025)       0:00:14.431 *****
2025-10-08 16:01:54.635895 | controller | ok: [instance] => changed=false
2025-10-08 16:01:54.814647 | controller |   msg: All assertions passed
2025-10-08 16:01:54.814678 | controller |
2025-10-08 16:01:54.814686 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 16:01:54.814693 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.025)       0:00:14.456 *****
2025-10-08 16:01:54.814702 | controller | ok: [instance]
2025-10-08 16:01:54.836130 | controller |
2025-10-08 16:01:54.836172 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 16:01:54.836180 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.178)       0:00:14.635 *****
2025-10-08 16:01:54.836190 | controller | ok: [instance] => changed=false
2025-10-08 16:01:55.006058 | controller |   msg: All assertions passed
2025-10-08 16:01:55.006089 | controller |
2025-10-08 16:01:55.006097 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 16:01:55.006104 | controller | Wednesday 08 October 2025  16:01:54 +0000 (0:00:00.021)       0:00:14.657 *****
2025-10-08 16:01:55.006113 | controller | ok: [instance]
2025-10-08 16:01:55.227803 | controller |
2025-10-08 16:01:55.227837 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 16:01:55.227846 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.169)       0:00:14.827 *****
2025-10-08 16:01:55.227856 | controller | ok: [instance]
2025-10-08 16:01:55.259895 | controller |
2025-10-08 16:01:55.259932 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 16:01:55.259940 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.221)       0:00:15.048 *****
2025-10-08 16:01:55.259951 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-10-08 16:01:55.283265 | controller |
2025-10-08 16:01:55.283329 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-10-08 16:01:55.283340 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.031)       0:00:15.080 *****
2025-10-08 16:01:55.283351 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-10-08 16:01:55.313291 | controller |
2025-10-08 16:01:55.313342 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-10-08 16:01:55.313351 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.023)       0:00:15.104 *****
2025-10-08 16:01:55.313366 | controller | ok: [instance] => changed=false
2025-10-08 16:01:55.336956 | controller |   msg: All assertions passed
2025-10-08 16:01:55.336987 | controller |
2025-10-08 16:01:55.336995 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-10-08 16:01:55.337001 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.029)       0:00:15.134 *****
2025-10-08 16:01:55.337012 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-10-08 16:01:55.351771 | controller |
2025-10-08 16:01:55.351798 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-10-08 16:01:55.351807 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.023)       0:00:15.158 *****
2025-10-08 16:01:55.351819 | controller | skipping: [instance]
2025-10-08 16:01:55.370200 | controller |
2025-10-08 16:01:55.370223 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-10-08 16:01:55.370240 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.014)       0:00:15.172 *****
2025-10-08 16:01:55.370250 | controller | ok: [instance]
2025-10-08 16:01:55.370385 | controller |
2025-10-08 16:01:55.370397 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-10-08 16:01:55.370406 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.018)       0:00:15.191 *****
2025-10-08 16:01:55.397543 | controller | ok: [instance] => changed=false
2025-10-08 16:01:55.397736 | controller |   msg: All assertions passed
2025-10-08 16:01:55.397877 | controller |
2025-10-08 16:01:55.398040 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 16:01:55.398204 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.027)       0:00:15.218 *****
2025-10-08 16:01:55.581124 | controller | ok: [instance]
2025-10-08 16:01:55.974648 | controller |
2025-10-08 16:01:55.974682 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 16:01:55.974691 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.182)       0:00:15.401 *****
2025-10-08 16:01:55.974701 | controller | ok: [instance]
2025-10-08 16:01:55.998310 | controller |
2025-10-08 16:01:55.998355 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 16:01:55.998363 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.393)       0:00:15.795 *****
2025-10-08 16:01:55.998373 | controller | ok: [instance]
2025-10-08 16:01:56.357578 | controller |
2025-10-08 16:01:56.357614 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 16:01:56.357623 | controller | Wednesday 08 October 2025  16:01:55 +0000 (0:00:00.023)       0:00:15.819 *****
2025-10-08 16:01:56.357638 | controller | ok: [instance]
2025-10-08 16:01:56.729328 | controller |
2025-10-08 16:01:56.729397 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 16:01:56.729406 | controller | Wednesday 08 October 2025  16:01:56 +0000 (0:00:00.359)       0:00:16.178 *****
2025-10-08 16:01:56.729418 | controller | ok: [instance]
2025-10-08 16:01:57.083365 | controller |
2025-10-08 16:01:57.083410 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 16:01:57.083419 | controller | Wednesday 08 October 2025  16:01:56 +0000 (0:00:00.371)       0:00:16.549 *****
2025-10-08 16:01:57.083431 | controller | ok: [instance]
2025-10-08 16:01:57.116868 | controller |
2025-10-08 16:01:57.116912 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 16:01:57.116921 | controller | Wednesday 08 October 2025  16:01:57 +0000 (0:00:00.353)       0:00:16.903 *****
2025-10-08 16:01:57.116933 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 16:01:57.147643 | controller |
2025-10-08 16:01:57.147685 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 16:01:57.147694 | controller | Wednesday 08 October 2025  16:01:57 +0000 (0:00:00.033)       0:00:16.937 *****
2025-10-08 16:01:57.147705 | controller | ok: [instance] => changed=false
2025-10-08 16:01:57.359793 | controller |   msg: All assertions passed
2025-10-08 16:01:57.359848 | controller |
2025-10-08 16:01:57.359856 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 16:01:57.359863 | controller | Wednesday 08 October 2025  16:01:57 +0000 (0:00:00.030)       0:00:16.968 *****
2025-10-08 16:01:57.359874 | controller | ok: [instance]
2025-10-08 16:01:57.409766 | controller |
2025-10-08 16:01:57.409811 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 16:01:57.409820 | controller | Wednesday 08 October 2025  16:01:57 +0000 (0:00:00.212)       0:00:17.180 *****
2025-10-08 16:01:57.409832 | controller | ok: [instance]
2025-10-08 16:01:57.955106 | controller |
2025-10-08 16:01:57.955174 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 16:01:57.955187 | controller | Wednesday 08 October 2025  16:01:57 +0000 (0:00:00.050)       0:00:17.230 *****
2025-10-08 16:01:57.955199 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-10-08 16:01:58.007018 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-10-08 16:01:58.007059 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-10-08 16:01:58.007067 | controller |
2025-10-08 16:01:58.007073 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 16:01:58.007079 | controller | Wednesday 08 October 2025  16:01:57 +0000 (0:00:00.544)       0:00:17.775 *****
2025-10-08 16:01:58.007089 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 16:01:58.219353 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 16:01:58.219429 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 16:01:58.219447 | controller |
2025-10-08 16:01:58.219454 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 16:01:58.219461 | controller | Wednesday 08 October 2025  16:01:58 +0000 (0:00:00.052)       0:00:17.827 *****
2025-10-08 16:01:58.219472 | controller | ok: [instance]
2025-10-08 16:01:58.576316 | controller |
2025-10-08 16:01:58.576385 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 16:01:58.576397 | controller | Wednesday 08 October 2025  16:01:58 +0000 (0:00:00.212)       0:00:18.039 *****
2025-10-08 16:01:58.576411 | controller | ok: [instance]
2025-10-08 16:01:58.576436 | controller |
2025-10-08 16:01:58.576588 | controller | TASK [Copy generated values to correct location] *******************************
2025-10-08 16:01:58.576622 | controller | Wednesday 08 October 2025  16:01:58 +0000 (0:00:00.357)       0:00:18.397 *****
2025-10-08 16:01:58.981704 | controller | changed: [instance] => (item={'key': 'network-values', 'value': 'examples/va/hci/control-plane/networking/nncp/values.yaml'})
2025-10-08 16:01:59.526242 | controller | changed: [instance] => (item={'key': 'edpm-nodeset-values', 'value': 'examples/va/hci/edpm-pre-ceph/nodeset/values.yaml'})
2025-10-08 16:01:59.526275 | controller |
2025-10-08 16:01:59.526283 | controller | TASK [Ensure kustomize is able to build] ***************************************
2025-10-08 16:01:59.526289 | controller | Wednesday 08 October 2025  16:01:58 +0000 (0:00:00.404)       0:00:18.802 *****
2025-10-08 16:01:59.526299 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-10-08 16:01:59.588981 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-10-08 16:01:59.589016 | controller |
2025-10-08 16:01:59.589024 | controller | PLAY RECAP *********************************************************************
2025-10-08 16:01:59.589030 | controller | instance                   : ok=107  changed=20   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-08 16:01:59.589036 | controller |
2025-10-08 16:01:59.589041 | controller | Wednesday 08 October 2025  16:01:59 +0000 (0:00:00.542)       0:00:19.344 *****
2025-10-08 16:01:59.589046 | controller | ===============================================================================
2025-10-08 16:01:59.589052 | controller | Gathering Facts --------------------------------------------------------- 0.80s
2025-10-08 16:01:59.589057 | controller | Ensure architecture repository is building ------------------------------ 0.64s
2025-10-08 16:01:59.589062 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.56s
2025-10-08 16:01:59.589067 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.54s
2025-10-08 16:01:59.589072 | controller | Ensure kustomize is able to build --------------------------------------- 0.54s
2025-10-08 16:01:59.589078 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.51s
2025-10-08 16:01:59.589083 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.49s
2025-10-08 16:01:59.589088 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.48s
2025-10-08 16:01:59.589093 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.47s
2025-10-08 16:01:59.589098 | controller | Copy generated values to correct location ------------------------------- 0.41s
2025-10-08 16:01:59.589104 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.39s
2025-10-08 16:01:59.589109 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.38s
2025-10-08 16:01:59.589114 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.38s
2025-10-08 16:01:59.589119 | controller | Create nova migration keypair ------------------------------------------- 0.37s
2025-10-08 16:01:59.589124 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.37s
2025-10-08 16:01:59.589130 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.36s
2025-10-08 16:01:59.589135 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.36s
2025-10-08 16:01:59.589162 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.35s
2025-10-08 16:01:59.589171 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.35s
2025-10-08 16:01:59.589176 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.35s
2025-10-08 16:01:59.589186 | controller | INFO     Running default > cleanup
2025-10-08 16:01:59.589652 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-08 16:01:59.590262 | controller | INFO     Writing /tmp/report.html report.
2025-10-08 16:01:59.708130 | controller | changed
2025-10-08 16:01:59.756323 | 
2025-10-08 16:01:59.756397 | PLAY RECAP
2025-10-08 16:01:59.756438 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-08 16:01:59.756460 | 
2025-10-08 16:01:59.846184 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-08 16:01:59.847001 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-08 16:02:00.756479 | 
2025-10-08 16:02:00.756585 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-08 16:02:00.809877 | 
2025-10-08 16:02:00.810020 | TASK [Filter out host if needed]
2025-10-08 16:02:00.828988 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-08 16:02:00.833578 | 
2025-10-08 16:02:00.833646 | TASK [Ensure file is present]
2025-10-08 16:02:01.225054 | controller | ok
2025-10-08 16:02:01.238726 | 
2025-10-08 16:02:01.238815 | TASK [Manage molecule report file]
2025-10-08 16:02:01.793037 | controller | changed
2025-10-08 16:02:01.799462 | 
2025-10-08 16:02:01.799551 | TASK [Check if we get ci-framework-data basedir]
2025-10-08 16:02:01.992039 | controller | ok
2025-10-08 16:02:01.997516 | 
2025-10-08 16:02:01.997606 | TASK [Create ci-framework-data log directory for zuul]
2025-10-08 16:02:02.528405 | controller | changed
2025-10-08 16:02:02.535472 | 
2025-10-08 16:02:02.535549 | TASK [Copy ci-framework interesting files]
2025-10-08 16:02:02.789280 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-08 16:02:03.101429 | controller | changed
2025-10-08 16:02:03.106704 | 
2025-10-08 16:02:03.106774 | TASK [Get SELinux listing]
2025-10-08 16:02:03.653971 | controller | changed
2025-10-08 16:02:03.659781 | 
2025-10-08 16:02:03.659867 | TASK [Generate log index]
2025-10-08 16:02:04.490272 | controller | changed
2025-10-08 16:02:04.495395 | 
2025-10-08 16:02:04.495465 | TASK [Get some env related data]
2025-10-08 16:02:05.071817 | controller | /home/zuul/.local/bin/ansible
2025-10-08 16:02:06.071565 | controller | changed
2025-10-08 16:02:06.084251 | 
2025-10-08 16:02:06.084344 | TASK [Generate list of logs to collect in home directory]
2025-10-08 16:02:06.406995 | controller | ok: All paths examined
2025-10-08 16:02:06.412972 | 
2025-10-08 16:02:06.413061 | LOOP [Copy logs from home directory]
2025-10-08 16:02:06.733741 | controller | changed:
2025-10-08 16:02:06.733897 | controller | {
2025-10-08 16:02:06.733989 | controller |   "atime": 1759939160.824146,
2025-10-08 16:02:06.734014 | controller |   "ctime": 1759939177.4607046,
2025-10-08 16:02:06.734033 | controller |   "dev": 64513,
2025-10-08 16:02:06.734051 | controller |   "gid": 1000,
2025-10-08 16:02:06.734066 | controller |   "gr_name": "zuul",
2025-10-08 16:02:06.734083 | controller |   "inode": 4449637,
2025-10-08 16:02:06.734098 | controller |   "isblk": false,
2025-10-08 16:02:06.734112 | controller |   "ischr": false,
2025-10-08 16:02:06.734127 | controller |   "isdir": false,
2025-10-08 16:02:06.734140 | controller |   "isfifo": false,
2025-10-08 16:02:06.734154 | controller |   "isgid": false,
2025-10-08 16:02:06.734168 | controller |   "islnk": false,
2025-10-08 16:02:06.734181 | controller |   "isreg": true,
2025-10-08 16:02:06.734194 | controller |   "issock": false,
2025-10-08 16:02:06.734208 | controller |   "isuid": false,
2025-10-08 16:02:06.734221 | controller |   "mode": "0644",
2025-10-08 16:02:06.734234 | controller |   "mtime": 1759939177.4607046,
2025-10-08 16:02:06.734247 | controller |   "nlink": 1,
2025-10-08 16:02:06.734260 | controller |   "path": "/home/zuul/ansible.log",
2025-10-08 16:02:06.734277 | controller |   "pw_name": "zuul",
2025-10-08 16:02:06.734293 | controller |   "rgrp": true,
2025-10-08 16:02:06.734324 | controller |   "roth": true,
2025-10-08 16:02:06.734340 | controller |   "rusr": true,
2025-10-08 16:02:06.734355 | controller |   "size": 6749,
2025-10-08 16:02:06.734369 | controller |   "uid": 1000,
2025-10-08 16:02:06.734383 | controller |   "wgrp": false,
2025-10-08 16:02:06.734396 | controller |   "woth": false,
2025-10-08 16:02:06.734413 | controller |   "wusr": true,
2025-10-08 16:02:06.734429 | controller |   "xgrp": false,
2025-10-08 16:02:06.734443 | controller |   "xoth": false,
2025-10-08 16:02:06.734457 | controller |   "xusr": false
2025-10-08 16:02:06.734470 | controller | }
2025-10-08 16:02:06.746420 | 
2025-10-08 16:02:06.746533 | TASK [Copy crio stats log file]
2025-10-08 16:02:06.760574 | controller | skipping: Conditional result was False
2025-10-08 16:02:06.766897 | 
2025-10-08 16:02:06.767006 | TASK [Get SELinux related data]
2025-10-08 16:02:07.006949 | controller | <no matches>
2025-10-08 16:02:07.304690 | controller | ERROR
2025-10-08 16:02:07.304884 | controller | {
2025-10-08 16:02:07.304962 | controller |   "delta": "0:00:00.009085",
2025-10-08 16:02:07.304988 | controller |   "end": "2025-10-08 16:02:07.007643",
2025-10-08 16:02:07.305010 | controller |   "msg": "non-zero return code",
2025-10-08 16:02:07.305030 | controller |   "rc": 1,
2025-10-08 16:02:07.305049 | controller |   "start": "2025-10-08 16:02:06.998558"
2025-10-08 16:02:07.305066 | controller | }
2025-10-08 16:02:07.305092 | controller | ERROR: Ignoring Errors
2025-10-08 16:02:07.343237 | 
2025-10-08 16:02:07.343358 | TASK [Create system configuration directory]
2025-10-08 16:02:07.628674 | controller | changed
2025-10-08 16:02:07.634371 | 
2025-10-08 16:02:07.634454 | TASK [Get some of the system configurations]
2025-10-08 16:02:08.162070 | controller | changed
2025-10-08 16:02:08.167657 | 
2025-10-08 16:02:08.167745 | TASK [Copy generated documentation if available]
2025-10-08 16:02:08.192364 | controller | skipping: Conditional result was False
2025-10-08 16:02:08.198383 | 
2025-10-08 16:02:08.198470 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-08 16:02:08.258589 | controller | skipping: Conditional result was False
2025-10-08 16:02:08.264643 | 
2025-10-08 16:02:08.264732 | TASK [Compress logs bigger than 2MB]
2025-10-08 16:02:08.798104 | controller | changed
2025-10-08 16:02:08.803424 | 
2025-10-08 16:02:08.803488 | TASK [Copy files from workspace on node]
2025-10-08 16:02:08.841692 | controller | ok
2025-10-08 16:02:08.882522 | 
2025-10-08 16:02:08.882611 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-08 16:02:08.920859 | controller | skipping: Conditional result was False
2025-10-08 16:02:08.926553 | 
2025-10-08 16:02:08.926624 | TASK [fetch-output : Set log path for single node]
2025-10-08 16:02:08.968616 | controller | ok
2025-10-08 16:02:08.973484 | 
2025-10-08 16:02:08.973553 | LOOP [fetch-output : Ensure local output dirs]
2025-10-08 16:02:09.416633 | controller -> localhost | ok: "/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/logs"
2025-10-08 16:02:09.416856 | controller -> localhost | changed: All items complete
2025-10-08 16:02:09.416893 | 
2025-10-08 16:02:09.771894 | controller -> localhost | changed: "/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/artifacts"
2025-10-08 16:02:10.051184 | controller -> localhost | changed: "/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/docs"
2025-10-08 16:02:10.063558 | 
2025-10-08 16:02:10.063658 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-08 16:02:10.723139 | controller | changed:
2025-10-08 16:02:10.723339 | controller | .d..t...... ./
2025-10-08 16:02:10.723378 | controller | >f+++++++++ README.html
2025-10-08 16:02:10.723402 | controller | >f+++++++++ ansible-execution.log
2025-10-08 16:02:10.723425 | controller | >f+++++++++ ansible.log
2025-10-08 16:02:10.723446 | controller | >f+++++++++ dmesg.log
2025-10-08 16:02:10.723465 | controller | >f+++++++++ installed-pkgs.log
2025-10-08 16:02:10.723487 | controller | >f+++++++++ python.log
2025-10-08 16:02:10.723509 | controller | >f+++++++++ registries.conf
2025-10-08 16:02:10.723528 | controller | >f+++++++++ report.html
2025-10-08 16:02:10.723548 | controller | >f+++++++++ selinux-denials.log
2025-10-08 16:02:10.723566 | controller | >f+++++++++ selinux-listing.log
2025-10-08 16:02:10.723586 | controller | cd+++++++++ ci-framework-data/
2025-10-08 16:02:10.723606 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-08 16:02:10.723625 | controller | >f+++++++++ ci-framework-data/artifacts/ctlplane.yaml
2025-10-08 16:02:10.723643 | controller | >f+++++++++ ci-framework-data/artifacts/dataplane.yaml
2025-10-08 16:02:10.723662 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key
2025-10-08 16:02:10.723680 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub
2025-10-08 16:02:10.723697 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-ctlplane.yaml
2025-10-08 16:02:10.723714 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-dataplane.yaml
2025-10-08 16:02:10.723731 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-08 16:02:10.723747 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/
2025-10-08 16:02:10.723764 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/
2025-10-08 16:02:10.723781 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 16:02:10.723799 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/
2025-10-08 16:02:10.723817 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 16:02:10.723836 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml.29001.2025-10-08@16:01:54~
2025-10-08 16:02:10.723854 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/
2025-10-08 16:02:10.723871 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/
2025-10-08 16:02:10.723888 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml
2025-10-08 16:02:10.723920 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml
2025-10-08 16:02:10.723949 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml
2025-10-08 16:02:10.723976 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml
2025-10-08 16:02:10.723996 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/
2025-10-08 16:02:10.724014 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml
2025-10-08 16:02:10.724031 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml
2025-10-08 16:02:10.724049 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml.28832.2025-10-08@16:01:52~
2025-10-08 16:02:10.724067 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml
2025-10-08 16:02:10.724084 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml
2025-10-08 16:02:10.724102 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2025-10-08 16:02:10.724120 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2025-10-08 16:02:10.724136 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2025-10-08 16:02:10.724154 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-08 16:02:10.724172 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-08 16:02:10.724189 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2025-10-08 16:02:10.724205 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2025-10-08 16:02:10.724223 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-08 16:02:10.724241 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-08 16:02:10.724259 | controller | cd+++++++++ registries.conf.d/
2025-10-08 16:02:10.724404 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-08 16:02:10.724435 | controller | cd+++++++++ system-config/
2025-10-08 16:02:10.724457 | controller | cd+++++++++ system-config/libvirt/
2025-10-08 16:02:10.724476 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-08 16:02:10.724795 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-08 16:02:11.171162 | controller | changed: .d..t...... ./
2025-10-08 16:02:11.539182 | controller | changed: .d..t...... ./
2025-10-08 16:02:11.561943 | 
2025-10-08 16:02:11.562060 | TASK [Return artifact to Zuul]
2025-10-08 16:02:11.592215 | controller | ok
2025-10-08 16:02:11.612602 | 
2025-10-08 16:02:11.612726 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-08 16:02:11.612836 | 
2025-10-08 16:02:11.612864 | PLAY RECAP
2025-10-08 16:02:11.612903 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-08 16:02:11.612949 | 
2025-10-08 16:02:11.709675 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-08 16:02:11.710519 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-08 16:02:12.295741 | 
2025-10-08 16:02:12.295850 | PLAY [all]
2025-10-08 16:02:12.316692 | 
2025-10-08 16:02:12.316791 | TASK [include_role : fetch-output]
2025-10-08 16:02:12.365563 | controller | ok
2025-10-08 16:02:12.382969 | 
2025-10-08 16:02:12.383066 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-08 16:02:12.426725 | controller | skipping: Conditional result was False
2025-10-08 16:02:12.432986 | 
2025-10-08 16:02:12.433075 | TASK [fetch-output : Set log path for single node]
2025-10-08 16:02:12.461645 | controller | ok
2025-10-08 16:02:12.466842 | 
2025-10-08 16:02:12.466934 | LOOP [fetch-output : Ensure local output dirs]
2025-10-08 16:02:12.837555 | controller -> localhost | ok: "/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/logs"
2025-10-08 16:02:13.119666 | controller -> localhost | ok: "/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/artifacts"
2025-10-08 16:02:13.373274 | controller -> localhost | ok: "/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/docs"
2025-10-08 16:02:13.384983 | 
2025-10-08 16:02:13.385080 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-08 16:02:14.019084 | controller | ok
2025-10-08 16:02:14.019275 | controller | ok: All items complete
2025-10-08 16:02:14.019325 | 
2025-10-08 16:02:14.574554 | controller | ok
2025-10-08 16:02:15.119021 | controller | ok
2025-10-08 16:02:15.133014 | 
2025-10-08 16:02:15.133121 | TASK [include_role : fetch-output-openshift]
2025-10-08 16:02:15.170274 | controller | skipping: Conditional result was False
2025-10-08 16:02:15.177077 | 
2025-10-08 16:02:15.177172 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-08 16:02:15.674434 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006702
2025-10-08 16:02:15.925207 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.025931
2025-10-08 16:02:15.955828 | 
2025-10-08 16:02:15.955938 | PLAY [all]
2025-10-08 16:02:15.983025 | 
2025-10-08 16:02:15.983136 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-08 16:02:16.419337 | controller | changed
2025-10-08 16:02:16.442781 | 
2025-10-08 16:02:16.442862 | PLAY RECAP
2025-10-08 16:02:16.442923 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-08 16:02:16.442954 | 
2025-10-08 16:02:16.524890 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-08 16:02:16.525683 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-08 16:02:17.139941 | 
2025-10-08 16:02:17.140064 | PLAY [localhost]
2025-10-08 16:02:17.158371 | 
2025-10-08 16:02:17.158488 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-08 16:02:17.504537 | localhost | changed
2025-10-08 16:02:17.509617 | 
2025-10-08 16:02:17.509718 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-08 16:02:17.537865 | localhost | ok
2025-10-08 16:02:17.546189 | 
2025-10-08 16:02:17.546282 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-08 16:02:17.860112 | localhost | changed
2025-10-08 16:02:17.872543 | 
2025-10-08 16:02:17.872641 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-08 16:02:18.461584 | localhost | changed
2025-10-08 16:02:18.467103 | 
2025-10-08 16:02:18.467187 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-08 16:02:18.830519 | localhost | Identity added: /var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/tmp/ansible.6tk_f_on (/var/lib/zuul/builds/45334f33ea8f4935b30dbb80e11513c4/work/tmp/ansible.6tk_f_on)
2025-10-08 16:02:18.830688 | localhost | ok: Runtime: 0:00:00.007026
2025-10-08 16:02:18.835833 | 
2025-10-08 16:02:18.836019 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-08 16:02:19.067012 | localhost | ok: Runtime: 0:00:00.004113
2025-10-08 16:02:19.071583 | 
2025-10-08 16:02:19.071655 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-08 16:02:19.125131 | localhost | changed
2025-10-08 16:02:19.130015 | 
2025-10-08 16:02:19.130109 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-08 16:02:19.480184 | localhost | changed
2025-10-08 16:02:19.502802 | 
2025-10-08 16:02:19.502896 | PLAY [localhost]
2025-10-08 16:02:19.515484 | 
2025-10-08 16:02:19.515568 | TASK [Generate bulk log download script]
2025-10-08 16:02:19.534995 | localhost | ok
2025-10-08 16:02:19.548221 | 
2025-10-08 16:02:19.548301 | TASK [local-log-download : Check API endpoint is defined]
2025-10-08 16:02:19.576466 | localhost | ok: All assertions passed
2025-10-08 16:02:19.581351 | 
2025-10-08 16:02:19.581434 | TASK [local-log-download : Create download script]
2025-10-08 16:02:19.960945 | localhost -> localhost | changed
2025-10-08 16:02:19.969966 | 
2025-10-08 16:02:19.970046 | TASK [Register quick-download link]
2025-10-08 16:02:19.987540 | localhost | ok
2025-10-08 16:02:20.022891 | 
2025-10-08 16:02:20.022997 | PLAY [logserver.rdoproject.org]
2025-10-08 16:02:20.032591 | 
2025-10-08 16:02:20.032654 | TASK [Set zuul-log-path fact]
2025-10-08 16:02:20.048842 | logserver.rdoproject.org | ok
2025-10-08 16:02:20.058427 | 
2025-10-08 16:02:20.058506 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-08 16:02:20.075441 | logserver.rdoproject.org | ok
2025-10-08 16:02:20.080875 | 
2025-10-08 16:02:20.080963 | TASK [upload-logs : Create log directories]
2025-10-08 16:02:22.026883 | logserver.rdoproject.org | changed
2025-10-08 16:02:22.029998 | 
2025-10-08 16:02:22.030084 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-08 16:02:22.267561 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005119
2025-10-08 16:02:22.272351 | 
2025-10-08 16:02:22.272420 | TASK [upload-logs : Upload logs to log server]
2025-10-08 16:02:23.902870 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-08 16:02:23.907180 | 
2025-10-08 16:02:23.907279 | LOOP [upload-logs : Compress console log and json output]
2025-10-08 16:02:23.946905 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 16:02:23.955460 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 16:02:23.965500 | 
2025-10-08 16:02:23.965600 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-08 16:02:24.004558 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 16:02:24.004795 | 
2025-10-08 16:02:24.008666 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 16:02:24.013670 | 
2025-10-08 16:02:24.013758 | LOOP [upload-logs : Upload console log and json output]