2025-12-16 11:50:37.937149 | Job console starting...
2025-12-16 11:50:38.149712 | Updating repositories
2025-12-16 11:50:38.951894 | Preparing job workspace
2025-12-16 11:50:46.506101 | Running Ansible setup...
2025-12-16 11:50:49.251335 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-16 11:50:49.751983 | 
2025-12-16 11:50:49.752073 | PLAY [localhost]
2025-12-16 11:50:49.760187 | 
2025-12-16 11:50:49.760260 | TASK [Gathering Facts]
2025-12-16 11:50:50.565240 | localhost | ok
2025-12-16 11:50:50.579580 | 
2025-12-16 11:50:50.579731 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-12-16 11:50:50.886259 | localhost -> localhost | changed
2025-12-16 11:50:50.891283 | 
2025-12-16 11:50:50.891349 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-12-16 11:50:51.562759 | localhost -> localhost | changed
2025-12-16 11:50:51.570774 | 
2025-12-16 11:50:51.570855 | TASK [Setup log path fact]
2025-12-16 11:50:51.587813 | localhost | ok
2025-12-16 11:50:51.598260 | 
2025-12-16 11:50:51.598332 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-16 11:50:51.615757 | localhost | ok
2025-12-16 11:50:51.623037 | 
2025-12-16 11:50:51.623107 | TASK [emit-job-header : Print job information]
2025-12-16 11:50:51.649947 | # Job Information
2025-12-16 11:50:51.650061 | Ansible Version: 2.15.12
2025-12-16 11:50:51.650090 | Job: cifmw-molecule-ci_gen_kustomize_values
2025-12-16 11:50:51.650112 | Pipeline: github-check
2025-12-16 11:50:51.650131 | Executor: ibm-bm3-ze.softwarefactory-project.io
2025-12-16 11:50:51.650149 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3397
2025-12-16 11:50:51.650169 | Log URL (when completed): https://logserver.rdoproject.org/b93/rdoproject.org/b9315f9ba18d4840b8f33ea60aa22d80/
2025-12-16 11:50:51.650188 | Event ID: 4d81b3e0-da75-11f0-817d-1c958e506c54
2025-12-16 11:50:51.653935 | 
2025-12-16 11:50:51.654003 | LOOP [emit-job-header : Print node information]
2025-12-16 11:50:51.737546 | localhost | ok:
2025-12-16 11:50:51.737757 | localhost | # Node Information
2025-12-16 11:50:51.737883 | localhost | Inventory Hostname: controller
2025-12-16 11:50:51.737922 | localhost | Hostname: np0005561708
2025-12-16 11:50:51.737947 | localhost | Username: zuul
2025-12-16 11:50:51.737969 | localhost | Distro: CentOS 9
2025-12-16 11:50:51.737989 | localhost | Provider: ibm-bm3-nodepool
2025-12-16 11:50:51.738007 | localhost | Region: regionOne
2025-12-16 11:50:51.738025 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-12-16 11:50:51.738043 | localhost | Product Name: OpenStack Compute
2025-12-16 11:50:51.738061 | localhost | Interface IP: 192.168.25.41
2025-12-16 11:50:51.766272 | 
2025-12-16 11:50:51.766340 | PLAY [all]
2025-12-16 11:50:51.772310 | 
2025-12-16 11:50:51.772382 | TASK [Gather network facts]
2025-12-16 11:50:52.105227 | controller | ok
2025-12-16 11:50:52.120777 | 
2025-12-16 11:50:52.121065 | TASK [include_role : start-zuul-console]
2025-12-16 11:50:52.145328 | controller | ok
2025-12-16 11:50:52.157128 | 
2025-12-16 11:50:52.157198 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-12-16 11:50:52.447786 | controller | ok
2025-12-16 11:50:52.456083 | 
2025-12-16 11:50:52.456153 | TASK [include_role : add-build-sshkey]
2025-12-16 11:50:52.473521 | controller | ok
2025-12-16 11:50:52.485690 | 
2025-12-16 11:50:52.485754 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-16 11:50:52.670881 | controller -> localhost | ok
2025-12-16 11:50:52.676201 | 
2025-12-16 11:50:52.676272 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-16 11:50:52.693778 | controller | ok
2025-12-16 11:50:52.707085 | controller | included: /var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-16 11:50:52.712456 | 
2025-12-16 11:50:52.712520 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-16 11:50:53.202770 | controller -> localhost | Generating public/private rsa key pair.
2025-12-16 11:50:53.202950 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/b9315f9ba18d4840b8f33ea60aa22d80_id_rsa.
2025-12-16 11:50:53.202984 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/b9315f9ba18d4840b8f33ea60aa22d80_id_rsa.pub.
2025-12-16 11:50:53.203008 | controller -> localhost | The key fingerprint is:
2025-12-16 11:50:53.203030 | controller -> localhost | SHA256:paly83TM6gbgBMOaHypDauLl0MF10XGb4SoMp1xOqYs zuul-build-sshkey
2025-12-16 11:50:53.203053 | controller -> localhost | The key's randomart image is:
2025-12-16 11:50:53.203073 | controller -> localhost | +---[RSA 3072]----+
2025-12-16 11:50:53.203091 | controller -> localhost | | .     .o..o     |
2025-12-16 11:50:53.203110 | controller -> localhost | |  +  . ...o +    |
2025-12-16 11:50:53.203128 | controller -> localhost | | o.o...=  .+     |
2025-12-16 11:50:53.203147 | controller -> localhost | |o..o+ X  +.      |
2025-12-16 11:50:53.203166 | controller -> localhost | |oo.+.= +S.       |
2025-12-16 11:50:53.203185 | controller -> localhost | |*o.oo o..o       |
2025-12-16 11:50:53.203203 | controller -> localhost | |=.+E..+.. +      |
2025-12-16 11:50:53.203223 | controller -> localhost | | . . o +.o       |
2025-12-16 11:50:53.203242 | controller -> localhost | |       o+        |
2025-12-16 11:50:53.203259 | controller -> localhost | +----[SHA256]-----+
2025-12-16 11:50:53.203301 | controller -> localhost | ok: Runtime: 0:00:00.169395
2025-12-16 11:50:53.208705 | 
2025-12-16 11:50:53.208769 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-16 11:50:53.226480 | controller | ok
2025-12-16 11:50:53.235569 | controller | included: /var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-16 11:50:53.242841 | 
2025-12-16 11:50:53.242904 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-16 11:50:53.256037 | controller | skipping: Conditional result was False
2025-12-16 11:50:53.261126 | 
2025-12-16 11:50:53.261196 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-16 11:50:53.607473 | controller | changed
2025-12-16 11:50:53.617760 | 
2025-12-16 11:50:53.617839 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-16 11:50:53.798049 | controller | ok
2025-12-16 11:50:53.803274 | 
2025-12-16 11:50:53.803354 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-16 11:50:54.318052 | controller | changed
2025-12-16 11:50:54.322833 | 
2025-12-16 11:50:54.322910 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-16 11:50:54.826455 | controller | changed
2025-12-16 11:50:54.831194 | 
2025-12-16 11:50:54.831259 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-16 11:50:54.844951 | controller | skipping: Conditional result was False
2025-12-16 11:50:54.850195 | 
2025-12-16 11:50:54.850258 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-16 11:50:55.148274 | controller -> localhost | changed
2025-12-16 11:50:55.157214 | 
2025-12-16 11:50:55.157293 | TASK [add-build-sshkey : Add back temp key]
2025-12-16 11:50:55.377679 | controller -> localhost | Identity added: /var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/b9315f9ba18d4840b8f33ea60aa22d80_id_rsa (zuul-build-sshkey)
2025-12-16 11:50:55.377857 | controller -> localhost | ok: Runtime: 0:00:00.006250
2025-12-16 11:50:55.384157 | 
2025-12-16 11:50:55.384231 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-16 11:50:55.655153 | controller | ok
2025-12-16 11:50:55.659567 | 
2025-12-16 11:50:55.659630 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-16 11:50:55.683311 | controller | skipping: Conditional result was False
2025-12-16 11:50:55.692909 | 
2025-12-16 11:50:55.692983 | TASK [include_role : validate-host]
2025-12-16 11:50:55.710390 | controller | ok
2025-12-16 11:50:55.730264 | 
2025-12-16 11:50:55.730340 | TASK [validate-host : Define zuul_info_dir fact]
2025-12-16 11:50:55.757923 | controller | ok
2025-12-16 11:50:55.762610 | 
2025-12-16 11:50:55.762703 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-12-16 11:50:55.968752 | controller -> localhost | ok
2025-12-16 11:50:55.974256 | 
2025-12-16 11:50:55.974330 | TASK [validate-host : Collect information about the host]
2025-12-16 11:50:56.532564 | controller | ok
2025-12-16 11:50:56.540376 | 
2025-12-16 11:50:56.540441 | TASK [validate-host : Sanitize hostname]
2025-12-16 11:50:56.609551 | controller | ok
2025-12-16 11:50:56.614322 | 
2025-12-16 11:50:56.614411 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-12-16 11:50:57.003911 | controller -> localhost | changed
2025-12-16 11:50:57.028925 | 
2025-12-16 11:50:57.029012 | TASK [validate-host : Collect information about zuul worker]
2025-12-16 11:50:57.337585 | controller | ok
2025-12-16 11:50:57.345576 | 
2025-12-16 11:50:57.345641 | TASK [validate-host : Write out all zuul information for each host]
2025-12-16 11:50:57.693155 | controller -> localhost | changed
2025-12-16 11:50:57.702704 | 
2025-12-16 11:50:57.702780 | TASK [include_role : prepare-workspace-openshift]
2025-12-16 11:50:57.716939 | controller | skipping: Conditional result was False
2025-12-16 11:50:57.722137 | 
2025-12-16 11:50:57.722203 | TASK [include_role : remove-zuul-sshkey]
2025-12-16 11:50:57.735577 | controller | skipping: Conditional result was False
2025-12-16 11:50:57.740508 | 
2025-12-16 11:50:57.740574 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-12-16 11:50:57.917940 | controller | ok: "logs"
2025-12-16 11:50:57.918169 | controller | ok: All items complete
2025-12-16 11:50:57.918202 | 
2025-12-16 11:50:58.071073 | controller | ok: "artifacts"
2025-12-16 11:50:58.220154 | controller | ok: "docs"
2025-12-16 11:50:58.225817 | 
2025-12-16 11:50:58.225883 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-12-16 11:50:58.406828 | controller | changed: "logs"
2025-12-16 11:50:58.560618 | controller | changed: "artifacts"
2025-12-16 11:50:58.715315 | controller | changed: "docs"
2025-12-16 11:50:58.745497 | 
2025-12-16 11:50:58.745557 | PLAY RECAP
2025-12-16 11:50:58.745600 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-16 11:50:58.745630 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-16 11:50:58.745666 | 
2025-12-16 11:50:58.825297 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-16 11:50:58.826043 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-16 11:50:59.361109 | 
2025-12-16 11:50:59.361208 | PLAY [all]
2025-12-16 11:50:59.402384 | 
2025-12-16 11:50:59.402460 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-16 11:50:59.450733 | controller | ok
2025-12-16 11:50:59.455502 | 
2025-12-16 11:50:59.455579 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-16 11:50:59.768042 | controller | changed
2025-12-16 11:50:59.773189 | 
2025-12-16 11:50:59.773257 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-16 11:51:00.489794 | controller | changed
2025-12-16 11:51:00.499190 | 
2025-12-16 11:51:00.499281 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-12-16 11:51:00.844120 | controller | changed:
2025-12-16 11:51:00.844409 | controller | {
2025-12-16 11:51:00.844449 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-12-16 11:51:00.844482 | controller | }
2025-12-16 11:51:01.034768 | controller | changed:
2025-12-16 11:51:01.034846 | controller | {
2025-12-16 11:51:01.034877 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-12-16 11:51:01.034901 | controller | }
2025-12-16 11:51:01.232624 | controller | changed:
2025-12-16 11:51:01.232717 | controller | {
2025-12-16 11:51:01.232757 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-12-16 11:51:01.232781 | controller | }
2025-12-16 11:51:01.430623 | controller | changed:
2025-12-16 11:51:01.430713 | controller | {
2025-12-16 11:51:01.430742 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-12-16 11:51:01.430765 | controller | }
2025-12-16 11:51:01.629886 | controller | changed:
2025-12-16 11:51:01.629957 | controller | {
2025-12-16 11:51:01.629983 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-12-16 11:51:01.630004 | controller | }
2025-12-16 11:51:01.825221 | controller | changed:
2025-12-16 11:51:01.825289 | controller | {
2025-12-16 11:51:01.825318 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-12-16 11:51:01.825340 | controller | }
2025-12-16 11:51:02.019667 | controller | changed:
2025-12-16 11:51:02.019740 | controller | {
2025-12-16 11:51:02.019768 | 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-12-16 11:51:02.019790 | controller | }
2025-12-16 11:51:02.217989 | controller | changed:
2025-12-16 11:51:02.218045 | controller | {
2025-12-16 11:51:02.218072 | 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-12-16 11:51:02.218093 | controller | }
2025-12-16 11:51:02.415712 | controller | changed:
2025-12-16 11:51:02.415804 | controller | {
2025-12-16 11:51:02.415831 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-12-16 11:51:02.415851 | controller | }
2025-12-16 11:51:02.611213 | controller | changed:
2025-12-16 11:51:02.611315 | controller | {
2025-12-16 11:51:02.611344 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-12-16 11:51:02.611378 | controller | }
2025-12-16 11:51:02.805170 | controller | changed:
2025-12-16 11:51:02.805249 | controller | {
2025-12-16 11:51:02.805275 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-12-16 11:51:02.805295 | controller | }
2025-12-16 11:51:03.021931 | controller | changed:
2025-12-16 11:51:03.022013 | controller | {
2025-12-16 11:51:03.022039 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-12-16 11:51:03.022061 | controller | }
2025-12-16 11:51:03.196820 | controller | changed:
2025-12-16 11:51:03.196907 | controller | {
2025-12-16 11:51:03.196934 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-12-16 11:51:03.196954 | controller | }
2025-12-16 11:51:03.396570 | controller | changed:
2025-12-16 11:51:03.396644 | controller | {
2025-12-16 11:51:03.396695 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-12-16 11:51:03.396718 | controller | }
2025-12-16 11:51:03.591513 | controller | changed:
2025-12-16 11:51:03.591598 | controller | {
2025-12-16 11:51:03.591624 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-12-16 11:51:03.591645 | controller | }
2025-12-16 11:51:03.784632 | controller | changed:
2025-12-16 11:51:03.784754 | controller | {
2025-12-16 11:51:03.784785 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-12-16 11:51:03.784806 | controller | }
2025-12-16 11:51:03.980101 | controller | changed:
2025-12-16 11:51:03.980181 | controller | {
2025-12-16 11:51:03.980207 | 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-12-16 11:51:03.980228 | controller | }
2025-12-16 11:51:04.176913 | controller | changed:
2025-12-16 11:51:04.177003 | controller | {
2025-12-16 11:51:04.177037 | 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-12-16 11:51:04.177065 | controller | }
2025-12-16 11:51:04.376670 | controller | changed:
2025-12-16 11:51:04.376752 | controller | {
2025-12-16 11:51:04.376778 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-12-16 11:51:04.376798 | controller | }
2025-12-16 11:51:04.573894 | controller | changed:
2025-12-16 11:51:04.573977 | controller | {
2025-12-16 11:51:04.574005 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-12-16 11:51:04.574026 | controller | }
2025-12-16 11:51:04.771804 | controller | changed:
2025-12-16 11:51:04.771891 | controller | {
2025-12-16 11:51:04.771919 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-12-16 11:51:04.771940 | controller | }
2025-12-16 11:51:04.971337 | controller | changed:
2025-12-16 11:51:04.971639 | controller | {
2025-12-16 11:51:04.971993 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-12-16 11:51:04.972028 | controller | }
2025-12-16 11:51:05.168280 | controller | changed:
2025-12-16 11:51:05.168378 | controller | {
2025-12-16 11:51:05.168406 | 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-12-16 11:51:05.168427 | controller | }
2025-12-16 11:51:05.380319 | controller | changed:
2025-12-16 11:51:05.380382 | controller | {
2025-12-16 11:51:05.380410 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-12-16 11:51:05.380431 | controller | }
2025-12-16 11:51:05.577412 | controller | changed:
2025-12-16 11:51:05.577495 | controller | {
2025-12-16 11:51:05.577523 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-12-16 11:51:05.577543 | controller | }
2025-12-16 11:51:05.775840 | controller | changed:
2025-12-16 11:51:05.775896 | controller | {
2025-12-16 11:51:05.775921 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-12-16 11:51:05.775940 | controller | }
2025-12-16 11:51:05.793433 | 
2025-12-16 11:51:05.793523 | TASK [Set timezone to UTC]
2025-12-16 11:51:06.158294 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-12-16 11:51:06.162967 | 
2025-12-16 11:51:06.163045 | TASK [Create nodepool directory]
2025-12-16 11:51:06.354103 | controller | changed
2025-12-16 11:51:06.359291 | 
2025-12-16 11:51:06.359358 | TASK [Create nodepool sub_nodes file]
2025-12-16 11:51:06.831805 | controller | changed
2025-12-16 11:51:06.836534 | 
2025-12-16 11:51:06.836611 | TASK [Create nodepool sub_nodes_private file]
2025-12-16 11:51:07.322925 | controller | changed
2025-12-16 11:51:07.328474 | 
2025-12-16 11:51:07.328548 | LOOP [Populate nodepool sub_nodes file]
2025-12-16 11:51:07.357254 | 
2025-12-16 11:51:07.357388 | LOOP [Populate nodepool sub_nodes_private file]
2025-12-16 11:51:07.385746 | 
2025-12-16 11:51:07.385872 | TASK [Create nodepool primary file]
2025-12-16 11:51:07.409076 | controller | skipping: Conditional result was False
2025-12-16 11:51:07.414316 | 
2025-12-16 11:51:07.414397 | TASK [Create nodepool node_private for this node]
2025-12-16 11:51:07.919630 | controller | changed
2025-12-16 11:51:07.924809 | 
2025-12-16 11:51:07.924872 | LOOP [Copy ssh keys to nodepool directory]
2025-12-16 11:51:08.237885 | controller | ok: Item: id_rsa Runtime: 0:00:00.004308
2025-12-16 11:51:08.238083 | 
2025-12-16 11:51:08.391143 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004025
2025-12-16 11:51:08.400087 | 
2025-12-16 11:51:08.400194 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-12-16 11:51:08.915637 | controller | changed
2025-12-16 11:51:08.920515 | 
2025-12-16 11:51:08.920591 | TASK [Validate sudoers config after edits]
2025-12-16 11:51:09.126031 | controller | /etc/sudoers: parsed OK
2025-12-16 11:51:09.126086 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-12-16 11:51:09.126096 | controller | /etc/sudoers.d/zuul: parsed OK
2025-12-16 11:51:09.126103 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-12-16 11:51:09.445535 | controller | ok: Runtime: 0:00:00.004737
2025-12-16 11:51:09.452853 | 
2025-12-16 11:51:09.452978 | TASK [Show the environment passed in to job shell scripts]
2025-12-16 11:51:09.654504 | controller | SHELL=/bin/bash
2025-12-16 11:51:09.654544 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-12-16 11:51:09.654558 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-12-16 11:51:09.654566 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/97/3397/06f8586b091fe5674ee886dadc4e7edc9cef6cbb
2025-12-16 11:51:09.654572 | controller | PWD=/home/zuul
2025-12-16 11:51:09.654577 | controller | ZUUL_PIPELINE=github-check
2025-12-16 11:51:09.654583 | controller | LOGNAME=zuul
2025-12-16 11:51:09.654588 | controller | XDG_SESSION_TYPE=tty
2025-12-16 11:51:09.654621 | controller | _=/usr/bin/env
2025-12-16 11:51:09.654628 | controller | MOTD_SHOWN=pam
2025-12-16 11:51:09.654633 | controller | HOME=/home/zuul
2025-12-16 11:51:09.654638 | controller | LANG=en_US.UTF-8
2025-12-16 11:51:09.654644 | controller | SSH_CONNECTION=192.168.25.12 39364 192.168.25.41 22
2025-12-16 11:51:09.654649 | 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-12-16 11:51:09.654657 | controller | ZUUL_CHANGE_IDS=3397,06f8586b091fe5674ee886dadc4e7edc9cef6cbb
2025-12-16 11:51:09.654662 | controller | WORKSPACE=/home/zuul/workspace
2025-12-16 11:51:09.654667 | controller | XDG_SESSION_CLASS=user
2025-12-16 11:51:09.654673 | controller | SELINUX_ROLE_REQUESTED=
2025-12-16 11:51:09.654678 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-12-16 11:51:09.654683 | controller | USER=zuul
2025-12-16 11:51:09.654688 | controller | ZUUL_VOTING=True
2025-12-16 11:51:09.654694 | controller | BUILD_TIMEOUT=1800000
2025-12-16 11:51:09.654699 | controller | SELINUX_USE_CURRENT_RANGE=
2025-12-16 11:51:09.654704 | controller | SHLVL=1
2025-12-16 11:51:09.654709 | controller | ZUUL_PATCHSET=06f8586b091fe5674ee886dadc4e7edc9cef6cbb
2025-12-16 11:51:09.654715 | controller | XDG_SESSION_ID=1
2025-12-16 11:51:09.654720 | controller | ZUUL_BRANCH=main
2025-12-16 11:51:09.654725 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-12-16 11:51:09.654730 | controller | SSH_CLIENT=192.168.25.12 39364 22
2025-12-16 11:51:09.654736 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-12-16 11:51:09.654741 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-12-16 11:51:09.654748 | controller | which_declare=declare -f
2025-12-16 11:51:09.654753 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-12-16 11:51:09.654758 | controller | SELINUX_LEVEL_REQUESTED=
2025-12-16 11:51:09.654763 | controller | ZUUL_CHANGE=3397
2025-12-16 11:51:09.654769 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-12-16 11:51:09.654774 | controller | ZUUL_UUID=b9315f9ba18d4840b8f33ea60aa22d80
2025-12-16 11:51:09.654779 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-12-16 11:51:09.654785 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-12-16 11:51:09.654790 | controller | }
2025-12-16 11:51:09.982379 | controller | ok: Runtime: 0:00:00.005715
2025-12-16 11:51:09.988192 | 
2025-12-16 11:51:09.988263 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-12-16 11:51:10.004704 | controller | skipping: Conditional result was False
2025-12-16 11:51:10.012172 | 
2025-12-16 11:51:10.012253 | TASK [Symlink /home/zuul-worker/workspace]
2025-12-16 11:51:10.543122 | controller | skipping: Conditional result was False
2025-12-16 11:51:10.549720 | 
2025-12-16 11:51:10.549803 | TASK [Ensure legacy workspace directory]
2025-12-16 11:51:10.745013 | controller | changed
2025-12-16 11:51:10.764476 | 
2025-12-16 11:51:10.764573 | PLAY RECAP
2025-12-16 11:51:10.764639 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-16 11:51:10.764712 | 
2025-12-16 11:51:10.874702 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-16 11:51:10.875474 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-16 11:51:11.421833 | 
2025-12-16 11:51:11.422000 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-12-16 11:51:11.442881 | 
2025-12-16 11:51:11.442967 | TASK [Create zuul-output directory]
2025-12-16 11:51:11.779330 | controller | changed
2025-12-16 11:51:11.784669 | 
2025-12-16 11:51:11.784780 | TASK [Slurp Zuul inventory test]
2025-12-16 11:51:12.105623 | controller -> localhost | ok
2025-12-16 11:51:12.113924 | 
2025-12-16 11:51:12.114029 | TASK [Save zuul inventory]
2025-12-16 11:51:12.927898 | controller | changed
2025-12-16 11:51:12.933417 | 
2025-12-16 11:51:12.933521 | TASK [Save zuul vars without the change_message]
2025-12-16 11:51:13.579186 | controller | changed
2025-12-16 11:51:13.597646 | 
2025-12-16 11:51:13.597739 | PLAY RECAP
2025-12-16 11:51:13.597785 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-16 11:51:13.597807 | 
2025-12-16 11:51:13.667583 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-16 11:51:13.668341 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-16 11:51:14.272968 | 
2025-12-16 11:51:14.273154 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-12-16 11:51:14.297640 | 
2025-12-16 11:51:14.297807 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-12-16 11:51:14.317427 | controller | ok
2025-12-16 11:51:14.335490 | 
2025-12-16 11:51:14.335599 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-16 11:51:14.360346 | controller | skipping: Conditional result was False
2025-12-16 11:51:14.366769 | 
2025-12-16 11:51:14.366868 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-16 11:51:14.742497 | controller | ok
2025-12-16 11:51:14.749295 | 
2025-12-16 11:51:14.749430 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-16 11:51:15.442807 | controller | ok
2025-12-16 11:51:15.453586 | 
2025-12-16 11:51:15.453685 | TASK [Prepare workspace]
2025-12-16 11:51:15.475266 | controller | ok
2025-12-16 11:51:15.492695 | 
2025-12-16 11:51:15.492770 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-12-16 11:51:15.850409 | controller | ok
2025-12-16 11:51:15.858746 | 
2025-12-16 11:51:15.858873 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-12-16 11:51:18.833421 | controller | Output suppressed because no_log was given
2025-12-16 11:51:18.842357 | 
2025-12-16 11:51:18.842431 | LOOP [Create zuul-output directory]
2025-12-16 11:51:19.044704 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-12-16 11:51:19.205597 | controller | ok: "/home/zuul/zuul-output/logs"
2025-12-16 11:51:19.213098 | 
2025-12-16 11:51:19.213165 | TASK [Install required packages]
2025-12-16 11:52:06.198348 | controller | changed
2025-12-16 11:52:06.203310 | 
2025-12-16 11:52:06.203382 | TASK [Install venv]
2025-12-16 11:53:09.018507 | controller | changed
2025-12-16 11:53:09.042192 | 
2025-12-16 11:53:09.042259 | PLAY RECAP
2025-12-16 11:53:09.042308 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-16 11:53:09.042331 | 
2025-12-16 11:53:09.111973 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-16 11:53:09.112851 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-12-16 11:53:09.620077 | 
2025-12-16 11:53:09.620172 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-12-16 11:53:09.638642 | 
2025-12-16 11:53:09.638729 | TASK [Gather required facts]
2025-12-16 11:53:10.083056 | controller | ok
2025-12-16 11:53:10.088189 | 
2025-12-16 11:53:10.088259 | TASK [Load environment var if instructed to]
2025-12-16 11:53:10.111486 | controller | skipping: Conditional result was False
2025-12-16 11:53:10.116494 | 
2025-12-16 11:53:10.116551 | TASK [Ensure group_vars dir exists]
2025-12-16 11:53:10.408762 | controller | ok
2025-12-16 11:53:10.414331 | 
2025-12-16 11:53:10.414405 | TASK [Print related variables]
2025-12-16 11:53:10.442605 | controller | ok:
2025-12-16 11:53:10.442723 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2025-12-16 11:53:10.442752 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values
2025-12-16 11:53:10.447249 | 
2025-12-16 11:53:10.447306 | TASK [Run molecule]
2025-12-16 11:53:11.361740 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-12-16 11:53:11.431355 | controller | INFO     Performing prerun with role_name_check=0...
2025-12-16 11:53:27.846226 | 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-12-16 11:53:27.846686 | 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-12-16 11:53:27.847151 | 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-12-16 11:53:27.847586 | 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-12-16 11:53:27.848027 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+06f8586b was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0+06f8586b (/home/zuul/.ansible/collections/ansible_collections).
2025-12-16 11:53:27.848450 | 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-12-16 11:53:27.848842 | 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-12-16 11:53:27.849259 | 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-12-16 11:53:27.849669 | 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-12-16 11:53:27.850070 | 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-12-16 11:53:27.850479 | 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-12-16 11:53:27.850884 | 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-12-16 11:53:27.851314 | 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-12-16 11:53:27.851734 | 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-12-16 11:53:27.852188 | 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-12-16 11:53:27.861284 | controller | INFO     Running default > prepare
2025-12-16 11:53:28.548761 | controller |
2025-12-16 11:53:28.548807 | controller | PLAY [Prepare] *****************************************************************
2025-12-16 11:53:28.548956 | controller |
2025-12-16 11:53:28.549039 | controller | TASK [Gathering Facts] *********************************************************
2025-12-16 11:53:28.549134 | controller | Tuesday 16 December 2025  11:53:28 +0000 (0:00:00.018)       0:00:00.018 ******
2025-12-16 11:53:29.358422 | controller | ok: [instance]
2025-12-16 11:53:29.358474 | controller |
2025-12-16 11:53:29.358572 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2025-12-16 11:53:29.358669 | controller | Tuesday 16 December 2025  11:53:29 +0000 (0:00:00.810)       0:00:00.829 ******
2025-12-16 11:53:29.375272 | controller | skipping: [instance]
2025-12-16 11:53:29.375356 | controller |
2025-12-16 11:53:29.375475 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2025-12-16 11:53:29.375577 | controller | Tuesday 16 December 2025  11:53:29 +0000 (0:00:00.017)       0:00:00.846 ******
2025-12-16 11:53:29.405483 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2025-12-16 11:53:29.405566 | controller |
2025-12-16 11:53:29.405670 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2025-12-16 11:53:29.405771 | controller | Tuesday 16 December 2025  11:53:29 +0000 (0:00:00.030)       0:00:00.876 ******
2025-12-16 11:53:29.703317 | controller | ok: [instance]
2025-12-16 11:53:29.703400 | controller |
2025-12-16 11:53:29.703513 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2025-12-16 11:53:29.703618 | controller | Tuesday 16 December 2025  11:53:29 +0000 (0:00:00.297)       0:00:01.174 ******
2025-12-16 11:53:29.997186 | controller | ok: [instance]
2025-12-16 11:53:29.997267 | controller |
2025-12-16 11:53:29.997375 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2025-12-16 11:53:29.997485 | controller | Tuesday 16 December 2025  11:53:29 +0000 (0:00:00.293)       0:00:01.468 ******
2025-12-16 11:53:30.663353 | controller | ok: [instance] => (item=ubi-9-appstream)
2025-12-16 11:53:30.663456 | controller | ok: [instance] => (item=ubi-9-baseos)
2025-12-16 11:53:30.663565 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2025-12-16 11:53:30.663655 | controller |
2025-12-16 11:53:30.663756 | controller | TASK [Deploy repo-setup] *******************************************************
2025-12-16 11:53:30.663856 | controller | Tuesday 16 December 2025  11:53:30 +0000 (0:00:00.666)       0:00:02.134 ******
2025-12-16 11:53:30.722036 | controller |
2025-12-16 11:53:30.722174 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-12-16 11:53:30.722309 | controller | Tuesday 16 December 2025  11:53:30 +0000 (0:00:00.058)       0:00:02.193 ******
2025-12-16 11:53:31.247993 | controller | changed: [instance] => (item=tmp)
2025-12-16 11:53:31.248065 | controller | changed: [instance] => (item=artifacts/repositories)
2025-12-16 11:53:31.248171 | controller | changed: [instance] => (item=venv/repo_setup)
2025-12-16 11:53:31.248264 | controller |
2025-12-16 11:53:31.248364 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-12-16 11:53:31.248484 | controller | Tuesday 16 December 2025  11:53:31 +0000 (0:00:00.525)       0:00:02.718 ******
2025-12-16 11:53:32.040066 | controller | ok: [instance]
2025-12-16 11:53:32.040129 | controller |
2025-12-16 11:53:32.040241 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-12-16 11:53:32.040338 | controller | Tuesday 16 December 2025  11:53:32 +0000 (0:00:00.791)       0:00:03.510 ******
2025-12-16 11:53:33.155456 | controller | changed: [instance]
2025-12-16 11:53:33.155516 | controller |
2025-12-16 11:53:33.155756 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-12-16 11:53:40.958909 | controller | Tuesday 16 December 2025  11:53:33 +0000 (0:00:01.115)       0:00:04.626 ******
2025-12-16 11:53:40.958946 | controller | changed: [instance]
2025-12-16 11:53:41.653608 | controller |
2025-12-16 11:53:41.653642 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-12-16 11:53:41.653650 | controller | Tuesday 16 December 2025  11:53:40 +0000 (0:00:07.803)       0:00:12.429 ******
2025-12-16 11:53:41.653660 | controller | changed: [instance]
2025-12-16 11:53:41.674045 | controller |
2025-12-16 11:53:41.674080 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-12-16 11:53:41.674090 | controller | Tuesday 16 December 2025  11:53:41 +0000 (0:00:00.694)       0:00:13.124 ******
2025-12-16 11:53:41.674103 | controller | skipping: [instance]
2025-12-16 11:53:41.674129 | controller |
2025-12-16 11:53:41.674139 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-12-16 11:53:42.484726 | controller | Tuesday 16 December 2025  11:53:41 +0000 (0:00:00.020)       0:00:13.145 ******
2025-12-16 11:53:42.484759 | controller | changed: [instance]
2025-12-16 11:53:42.484792 | controller |
2025-12-16 11:53:42.485003 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-12-16 11:53:42.485038 | controller | Tuesday 16 December 2025  11:53:42 +0000 (0:00:00.810)       0:00:13.955 ******
2025-12-16 11:53:42.512505 | controller | skipping: [instance]
2025-12-16 11:53:42.538943 | controller |
2025-12-16 11:53:42.538964 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-12-16 11:53:42.538972 | controller | Tuesday 16 December 2025  11:53:42 +0000 (0:00:00.027)       0:00:13.983 ******
2025-12-16 11:53:42.538981 | controller | skipping: [instance]
2025-12-16 11:53:42.539042 | controller |
2025-12-16 11:53:42.539058 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-12-16 11:53:42.539068 | controller | Tuesday 16 December 2025  11:53:42 +0000 (0:00:00.026)       0:00:14.009 ******
2025-12-16 11:53:42.564545 | controller | skipping: [instance]
2025-12-16 11:53:43.088202 | controller |
2025-12-16 11:53:43.088232 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-12-16 11:53:43.088239 | controller | Tuesday 16 December 2025  11:53:42 +0000 (0:00:00.025)       0:00:14.035 ******
2025-12-16 11:53:43.088249 | controller | changed: [instance]
2025-12-16 11:53:43.496966 | controller |
2025-12-16 11:53:43.496994 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-12-16 11:53:43.497002 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.523)       0:00:14.558 ******
2025-12-16 11:53:43.497012 | controller | changed: [instance]
2025-12-16 11:53:43.497380 | controller |
2025-12-16 11:53:43.514557 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-12-16 11:53:43.514575 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.409)       0:00:14.967 ******
2025-12-16 11:53:43.514585 | controller | skipping: [instance]
2025-12-16 11:53:43.531608 | controller |
2025-12-16 11:53:43.531626 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-12-16 11:53:43.531633 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.017)       0:00:14.985 ******
2025-12-16 11:53:43.531645 | controller | skipping: [instance]
2025-12-16 11:53:43.547942 | controller |
2025-12-16 11:53:43.547959 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-12-16 11:53:43.547967 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.017)       0:00:15.002 ******
2025-12-16 11:53:43.547976 | controller | skipping: [instance]
2025-12-16 11:53:43.548331 | controller |
2025-12-16 11:53:43.574920 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-12-16 11:53:43.574942 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.016)       0:00:15.019 ******
2025-12-16 11:53:43.574953 | controller | ok: [instance]
2025-12-16 11:53:43.589730 | controller |
2025-12-16 11:53:43.589748 | controller | TASK [repo_setup : Create download directory] **********************************
2025-12-16 11:53:43.589755 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.026)       0:00:15.045 ******
2025-12-16 11:53:43.589764 | controller | skipping: [instance]
2025-12-16 11:53:43.604159 | controller |
2025-12-16 11:53:43.604178 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-12-16 11:53:43.604185 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.014)       0:00:15.060 ******
2025-12-16 11:53:43.604200 | controller | skipping: [instance]
2025-12-16 11:53:43.618284 | controller |
2025-12-16 11:53:43.618306 | controller | TASK [Download the RPM] ********************************************************
2025-12-16 11:53:43.618315 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.014)       0:00:15.074 ******
2025-12-16 11:53:43.618326 | controller | skipping: [instance]
2025-12-16 11:53:43.618542 | controller |
2025-12-16 11:53:43.618718 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-12-16 11:53:43.618888 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.014)       0:00:15.089 ******
2025-12-16 11:53:43.632954 | controller | skipping: [instance]
2025-12-16 11:53:43.633109 | controller |
2025-12-16 11:53:43.633258 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-12-16 11:53:43.633404 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.014)       0:00:15.104 ******
2025-12-16 11:53:43.647556 | controller | skipping: [instance]
2025-12-16 11:53:43.647751 | controller |
2025-12-16 11:53:43.647954 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-12-16 11:53:43.648130 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.014)       0:00:15.118 ******
2025-12-16 11:53:43.662838 | controller | skipping: [instance]
2025-12-16 11:53:43.663011 | controller |
2025-12-16 11:53:43.663167 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-12-16 11:53:43.663307 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.015)       0:00:15.134 ******
2025-12-16 11:53:43.678593 | controller | skipping: [instance]
2025-12-16 11:53:43.678772 | controller |
2025-12-16 11:53:43.678975 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-12-16 11:53:43.679163 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.015)       0:00:15.149 ******
2025-12-16 11:53:43.853220 | controller | ok: [instance]
2025-12-16 11:53:44.062000 | controller |
2025-12-16 11:53:44.062028 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-12-16 11:53:44.062036 | controller | Tuesday 16 December 2025  11:53:43 +0000 (0:00:00.173)       0:00:15.323 ******
2025-12-16 11:53:44.062046 | controller | changed: [instance]
2025-12-16 11:53:44.271969 | controller |
2025-12-16 11:53:44.272001 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-12-16 11:53:44.272009 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.208)       0:00:15.532 ******
2025-12-16 11:53:44.272020 | controller | changed: [instance]
2025-12-16 11:53:44.272044 | controller |
2025-12-16 11:53:44.272056 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-12-16 11:53:44.272175 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.209)       0:00:15.742 ******
2025-12-16 11:53:44.292681 | controller | skipping: [instance]
2025-12-16 11:53:44.313718 | controller |
2025-12-16 11:53:44.313739 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-12-16 11:53:44.313748 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.021)       0:00:15.763 ******
2025-12-16 11:53:44.313759 | controller | skipping: [instance]
2025-12-16 11:53:44.334830 | controller |
2025-12-16 11:53:44.334849 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-12-16 11:53:44.334858 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.021)       0:00:15.784 ******
2025-12-16 11:53:44.334868 | controller | skipping: [instance]
2025-12-16 11:53:44.355887 | controller |
2025-12-16 11:53:44.355927 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-12-16 11:53:44.355936 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.021)       0:00:15.805 ******
2025-12-16 11:53:44.355947 | controller | skipping: [instance]
2025-12-16 11:53:44.376866 | controller |
2025-12-16 11:53:44.376885 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-12-16 11:53:44.376920 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.021)       0:00:15.826 ******
2025-12-16 11:53:44.376935 | controller | skipping: [instance]
2025-12-16 11:53:44.377113 | controller |
2025-12-16 11:53:44.377305 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-12-16 11:53:44.377511 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.021)       0:00:15.848 ******
2025-12-16 11:53:44.398553 | controller | skipping: [instance]
2025-12-16 11:53:44.398726 | controller |
2025-12-16 11:53:44.398919 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-12-16 11:53:44.399106 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.021)       0:00:15.869 ******
2025-12-16 11:53:44.415005 | controller | skipping: [instance]
2025-12-16 11:53:44.415060 | controller |
2025-12-16 11:53:44.415072 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-12-16 11:53:44.415170 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.016)       0:00:15.886 ******
2025-12-16 11:53:44.433980 | controller | skipping: [instance]
2025-12-16 11:53:44.434314 | controller |
2025-12-16 11:53:44.450288 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-12-16 11:53:44.450309 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.019)       0:00:15.905 ******
2025-12-16 11:53:44.450322 | controller | skipping: [instance]
2025-12-16 11:53:44.469968 | controller |
2025-12-16 11:53:44.469990 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-12-16 11:53:44.469998 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.015)       0:00:15.921 ******
2025-12-16 11:53:44.470007 | controller | skipping: [instance]
2025-12-16 11:53:44.470103 | controller |
2025-12-16 11:53:44.470122 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2025-12-16 11:53:44.470134 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.019)       0:00:15.940 ******
2025-12-16 11:53:44.489572 | controller | skipping: [instance]
2025-12-16 11:53:44.508988 | controller |
2025-12-16 11:53:44.509011 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2025-12-16 11:53:44.509020 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.019)       0:00:15.960 ******
2025-12-16 11:53:44.509029 | controller | skipping: [instance]
2025-12-16 11:53:44.509054 | controller |
2025-12-16 11:53:44.509254 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2025-12-16 11:53:44.528877 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.019)       0:00:15.980 ******
2025-12-16 11:53:44.528925 | controller | skipping: [instance]
2025-12-16 11:53:44.548774 | controller |
2025-12-16 11:53:44.548793 | controller | TASK [test_deps : Install additional packages] *********************************
2025-12-16 11:53:44.548801 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.019)       0:00:15.999 ******
2025-12-16 11:53:44.548812 | controller | skipping: [instance]
2025-12-16 11:54:26.590778 | controller |
2025-12-16 11:54:26.590815 | controller | TASK [test_deps : Install selinux python libs] *********************************
2025-12-16 11:54:26.590823 | controller | Tuesday 16 December 2025  11:53:44 +0000 (0:00:00.019)       0:00:16.019 ******
2025-12-16 11:54:26.590833 | controller | ok: [instance]
2025-12-16 11:54:27.743837 | controller |
2025-12-16 11:54:27.743868 | controller | TASK [test_deps : Install python yaml libs] ************************************
2025-12-16 11:54:27.743875 | controller | Tuesday 16 December 2025  11:54:26 +0000 (0:00:42.041)       0:00:58.061 ******
2025-12-16 11:54:27.743885 | controller | ok: [instance]
2025-12-16 11:54:27.765949 | controller |
2025-12-16 11:54:27.765972 | controller | TASK [test_deps : Install extra packages] **************************************
2025-12-16 11:54:27.765980 | controller | Tuesday 16 December 2025  11:54:27 +0000 (0:00:01.153)       0:00:59.214 ******
2025-12-16 11:54:27.765990 | controller | skipping: [instance]
2025-12-16 11:54:27.766154 | controller |
2025-12-16 11:54:27.766165 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2025-12-16 11:54:27.766173 | controller | Tuesday 16 December 2025  11:54:27 +0000 (0:00:00.022)       0:00:59.236 ******
2025-12-16 11:54:27.797948 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2025-12-16 11:54:27.798191 | controller |
2025-12-16 11:54:27.798205 | controller | TASK [ci_setup : List packages to install] *************************************
2025-12-16 11:54:27.817944 | controller | Tuesday 16 December 2025  11:54:27 +0000 (0:00:00.032)       0:00:59.269 ******
2025-12-16 11:54:27.817971 | controller | ok: [instance] =>
2025-12-16 11:54:27.818579 | controller |   cifmw_ci_setup_packages:
2025-12-16 11:54:27.818608 | controller |   - bash-completion
2025-12-16 11:54:27.818616 | controller |   - ca-certificates
2025-12-16 11:54:27.818621 | controller |   - git-core
2025-12-16 11:54:27.818627 | controller |   - make
2025-12-16 11:54:27.818633 | controller |   - tar
2025-12-16 11:54:27.818638 | controller |   - tmux
2025-12-16 11:54:27.818648 | controller |   - python3-pip
2025-12-16 11:54:31.577669 | controller |
2025-12-16 11:54:31.577701 | controller | TASK [ci_setup : Install needed packages] **************************************
2025-12-16 11:54:31.577709 | controller | Tuesday 16 December 2025  11:54:27 +0000 (0:00:00.019)       0:00:59.288 ******
2025-12-16 11:54:31.577724 | controller | changed: [instance]
2025-12-16 11:54:31.755959 | controller |
2025-12-16 11:54:31.755986 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2025-12-16 11:54:31.755994 | controller | Tuesday 16 December 2025  11:54:31 +0000 (0:00:03.759)       0:01:03.048 ******
2025-12-16 11:54:31.756004 | controller | ok: [instance]
2025-12-16 11:54:31.756069 | controller |
2025-12-16 11:54:31.756077 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2025-12-16 11:54:31.756086 | controller | Tuesday 16 December 2025  11:54:31 +0000 (0:00:00.178)       0:01:03.226 ******
2025-12-16 11:54:31.937005 | controller | changed: [instance]
2025-12-16 11:54:37.894809 | controller |
2025-12-16 11:54:37.894841 | controller | TASK [ci_setup : Install openshift client] *************************************
2025-12-16 11:54:37.894849 | controller | Tuesday 16 December 2025  11:54:31 +0000 (0:00:00.180)       0:01:03.407 ******
2025-12-16 11:54:37.894859 | controller | changed: [instance]
2025-12-16 11:54:37.921030 | controller |
2025-12-16 11:54:37.921067 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2025-12-16 11:54:37.921077 | controller | Tuesday 16 December 2025  11:54:37 +0000 (0:00:05.957)       0:01:09.365 ******
2025-12-16 11:54:37.921089 | controller | ok: [instance]
2025-12-16 11:54:37.921117 | controller |
2025-12-16 11:54:37.921128 | controller | TASK [ci_setup : Create completion file] ***************************************
2025-12-16 11:54:37.921215 | controller | Tuesday 16 December 2025  11:54:37 +0000 (0:00:00.026)       0:01:09.392 ******
2025-12-16 11:54:38.176577 | controller | changed: [instance]
2025-12-16 11:54:38.453407 | controller |
2025-12-16 11:54:38.453438 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2025-12-16 11:54:38.453446 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.254)       0:01:09.647 ******
2025-12-16 11:54:38.453456 | controller | changed: [instance]
2025-12-16 11:54:38.469008 | controller |
2025-12-16 11:54:38.469048 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2025-12-16 11:54:38.469059 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.276)       0:01:09.924 ******
2025-12-16 11:54:38.469073 | controller | skipping: [instance]
2025-12-16 11:54:38.469104 | controller |
2025-12-16 11:54:38.469115 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2025-12-16 11:54:38.469268 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.015)       0:01:09.940 ******
2025-12-16 11:54:38.483953 | controller | skipping: [instance]
2025-12-16 11:54:38.484201 | controller |
2025-12-16 11:54:38.484218 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2025-12-16 11:54:38.499443 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.014)       0:01:09.954 ******
2025-12-16 11:54:38.499466 | controller | skipping: [instance]
2025-12-16 11:54:38.514367 | controller |
2025-12-16 11:54:38.514387 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2025-12-16 11:54:38.514395 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.015)       0:01:09.970 ******
2025-12-16 11:54:38.514406 | controller | skipping: [instance]
2025-12-16 11:54:38.529071 | controller |
2025-12-16 11:54:38.529090 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2025-12-16 11:54:38.529098 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.014)       0:01:09.985 ******
2025-12-16 11:54:38.529108 | controller | skipping: [instance]
2025-12-16 11:54:38.529286 | controller |
2025-12-16 11:54:38.529454 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2025-12-16 11:54:38.529630 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.015)       0:01:10.000 ******
2025-12-16 11:54:38.550725 | controller | skipping: [instance]
2025-12-16 11:54:38.550923 | controller |
2025-12-16 11:54:38.551113 | controller | TASK [ci_setup : Manage directories] *******************************************
2025-12-16 11:54:38.551302 | controller | Tuesday 16 December 2025  11:54:38 +0000 (0:00:00.021)       0:01:10.021 ******
2025-12-16 11:54:39.513058 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2025-12-16 11:54:39.706404 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2025-12-16 11:54:39.706433 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2025-12-16 11:54:39.706441 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2025-12-16 11:54:39.706447 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2025-12-16 11:54:39.706452 | controller |
2025-12-16 11:54:39.706458 | controller | TASK [Ensure directory exists] *************************************************
2025-12-16 11:54:39.706464 | controller | Tuesday 16 December 2025  11:54:39 +0000 (0:00:00.961)       0:01:10.983 ******
2025-12-16 11:54:39.706474 | controller | changed: [instance]
2025-12-16 11:54:40.093041 | controller |
2025-12-16 11:54:40.093078 | controller | TASK [Create nova migration keypair] *******************************************
2025-12-16 11:54:40.093089 | controller | Tuesday 16 December 2025  11:54:39 +0000 (0:00:00.193)       0:01:11.176 ******
2025-12-16 11:54:40.093108 | controller | changed: [instance]
2025-12-16 11:54:40.093141 | controller |
2025-12-16 11:54:40.093151 | controller | PLAY [Download tools] **********************************************************
2025-12-16 11:54:40.093159 | controller |
2025-12-16 11:54:40.093182 | controller | TASK [Gathering Facts] *********************************************************
2025-12-16 11:54:40.681931 | controller | Tuesday 16 December 2025  11:54:40 +0000 (0:00:00.386)       0:01:11.563 ******
2025-12-16 11:54:40.681967 | controller | ok: [localhost]
2025-12-16 11:54:51.952524 | controller |
2025-12-16 11:54:51.952554 | controller | TASK [download_tools : Install build dependencies] *****************************
2025-12-16 11:54:51.952562 | controller | Tuesday 16 December 2025  11:54:40 +0000 (0:00:00.588)       0:01:12.152 ******
2025-12-16 11:54:51.952572 | controller | changed: [localhost]
2025-12-16 11:54:51.974013 | controller |
2025-12-16 11:54:51.974059 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-12-16 11:54:51.974068 | controller | Tuesday 16 December 2025  11:54:51 +0000 (0:00:11.270)       0:01:23.423 ******
2025-12-16 11:54:51.974080 | controller | skipping: [localhost]
2025-12-16 11:54:51.974105 | controller |
2025-12-16 11:54:51.974113 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-12-16 11:54:51.974241 | controller | Tuesday 16 December 2025  11:54:51 +0000 (0:00:00.021)       0:01:23.445 ******
2025-12-16 11:54:51.998448 | controller | ok: [localhost]
2025-12-16 11:54:52.178053 | controller |
2025-12-16 11:54:52.178085 | controller | TASK [download_tools : Create $HOME/bin dir] ***********************************
2025-12-16 11:54:52.178093 | controller | Tuesday 16 December 2025  11:54:51 +0000 (0:00:00.024)       0:01:23.469 ******
2025-12-16 11:54:52.178104 | controller | ok: [localhost]
2025-12-16 11:54:53.443931 | controller |
2025-12-16 11:54:53.443963 | controller | TASK [download_tools : Download opm] *******************************************
2025-12-16 11:54:53.443971 | controller | Tuesday 16 December 2025  11:54:52 +0000 (0:00:00.177)       0:01:23.647 ******
2025-12-16 11:54:53.443981 | controller | changed: [localhost]
2025-12-16 11:54:53.464692 | controller |
2025-12-16 11:54:53.464724 | controller | TASK [download_tools : Get version from sdk_version] ***************************
2025-12-16 11:54:53.464736 | controller | Tuesday 16 December 2025  11:54:53 +0000 (0:00:01.267)       0:01:24.914 ******
2025-12-16 11:54:53.464750 | controller | ok: [localhost]
2025-12-16 11:54:53.484016 | controller |
2025-12-16 11:54:53.484035 | controller | TASK [download_tools : Set operator-sdk file for version < 1.3.0] **************
2025-12-16 11:54:53.484042 | controller | Tuesday 16 December 2025  11:54:53 +0000 (0:00:00.020)       0:01:24.935 ******
2025-12-16 11:54:53.484051 | controller | skipping: [localhost]
2025-12-16 11:54:53.505983 | controller |
2025-12-16 11:54:53.506032 | controller | TASK [download_tools : Set operator-sdk file for version >= 1.3.0] *************
2025-12-16 11:54:53.506041 | controller | Tuesday 16 December 2025  11:54:53 +0000 (0:00:00.019)       0:01:24.954 ******
2025-12-16 11:54:53.506051 | controller | ok: [localhost]
2025-12-16 11:54:53.506075 | controller |
2025-12-16 11:54:53.506082 | controller | TASK [download_tools : Download operator-sdk] **********************************
2025-12-16 11:54:53.506089 | controller | Tuesday 16 December 2025  11:54:53 +0000 (0:00:00.021)       0:01:24.976 ******
2025-12-16 11:54:55.335123 | controller | changed: [localhost]
2025-12-16 11:54:55.335179 | controller |
2025-12-16 11:54:55.335434 | controller | TASK [download_tools : Download and extract kustomize] *************************
2025-12-16 11:54:56.371447 | controller | Tuesday 16 December 2025  11:54:55 +0000 (0:00:01.829)       0:01:26.806 ******
2025-12-16 11:54:56.371482 | controller | changed: [localhost]
2025-12-16 11:54:56.721659 | controller |
2025-12-16 11:54:56.721687 | controller | TASK [download_tools : Download kubectl] ***************************************
2025-12-16 11:54:56.721695 | controller | Tuesday 16 December 2025  11:54:56 +0000 (0:00:01.035)       0:01:27.842 ******
2025-12-16 11:54:56.721705 | controller | ok: [localhost]
2025-12-16 11:54:57.647957 | controller |
2025-12-16 11:54:57.647982 | controller | TASK [download_tools : Download kuttl] *****************************************
2025-12-16 11:54:57.647990 | controller | Tuesday 16 December 2025  11:54:56 +0000 (0:00:00.349)       0:01:28.191 ******
2025-12-16 11:54:57.648000 | controller | changed: [localhost]
2025-12-16 11:54:57.648019 | controller |
2025-12-16 11:54:57.648182 | controller | TASK [download_tools : Download chainsaw] **************************************
2025-12-16 11:55:00.616959 | controller | Tuesday 16 December 2025  11:54:57 +0000 (0:00:00.926)       0:01:29.118 ******
2025-12-16 11:55:00.616996 | controller | changed: [localhost]
2025-12-16 11:55:00.617023 | controller |
2025-12-16 11:55:00.617288 | controller | TASK [download_tools : Download and extract yq] ********************************
2025-12-16 11:55:01.769813 | controller | Tuesday 16 December 2025  11:55:00 +0000 (0:00:02.968)       0:01:32.087 ******
2025-12-16 11:55:01.769854 | controller | changed: [localhost]
2025-12-16 11:55:01.946426 | controller |
2025-12-16 11:55:01.946455 | controller | TASK [download_tools : Link yq_linux_amd64 as yq] ******************************
2025-12-16 11:55:01.946463 | controller | Tuesday 16 December 2025  11:55:01 +0000 (0:00:01.152)       0:01:33.240 ******
2025-12-16 11:55:01.946473 | controller | changed: [localhost]
2025-12-16 11:55:03.416996 | controller |
2025-12-16 11:55:03.417028 | controller | TASK [download_tools : Deinstall golang] ***************************************
2025-12-16 11:55:03.417037 | controller | Tuesday 16 December 2025  11:55:01 +0000 (0:00:00.176)       0:01:33.417 ******
2025-12-16 11:55:03.417047 | controller | ok: [localhost]
2025-12-16 11:55:03.417072 | controller |
2025-12-16 11:55:03.417262 | controller | TASK [download_tools : Delete old go version installed from upstream] **********
2025-12-16 11:55:04.306674 | controller | Tuesday 16 December 2025  11:55:03 +0000 (0:00:01.470)       0:01:34.887 ******
2025-12-16 11:55:04.306707 | controller | ok: [localhost] => (item=/usr/local/go)
2025-12-16 11:55:16.068142 | controller | ok: [localhost] => (item=/home/zuul/bin/go)
2025-12-16 11:55:16.068170 | controller | ok: [localhost] => (item=/home/zuul/bin/gofmt)
2025-12-16 11:55:16.068178 | controller | ok: [localhost] => (item=/usr/local/bin/go)
2025-12-16 11:55:16.068183 | controller | ok: [localhost] => (item=/usr/local/bin/gofmt)
2025-12-16 11:55:16.068189 | controller |
2025-12-16 11:55:16.068195 | controller | TASK [download_tools : Download and extract golang] ****************************
2025-12-16 11:55:16.068201 | controller | Tuesday 16 December 2025  11:55:04 +0000 (0:00:00.889)       0:01:35.776 ******
2025-12-16 11:55:16.068211 | controller | changed: [localhost]
2025-12-16 11:55:16.431731 | controller |
2025-12-16 11:55:16.431759 | controller | TASK [download_tools : Set alternatives link to installed go version] **********
2025-12-16 11:55:16.431766 | controller | Tuesday 16 December 2025  11:55:16 +0000 (0:00:11.761)       0:01:47.538 ******
2025-12-16 11:55:16.431775 | controller | changed: [localhost] => (item=go)
2025-12-16 11:55:16.465640 | controller | changed: [localhost] => (item=gofmt)
2025-12-16 11:55:16.465674 | controller |
2025-12-16 11:55:16.465682 | controller | TASK [download_tools : Clean bash cache] ***************************************
2025-12-16 11:55:16.465696 | controller | Tuesday 16 December 2025  11:55:16 +0000 (0:00:00.363)       0:01:47.902 ******
2025-12-16 11:55:16.465706 | controller | ok: [localhost] =>
2025-12-16 11:55:16.465732 | controller |   msg: When move from rpm to upstream version, make sure to clean bash cache using `hash -d go`
2025-12-16 11:55:16.465937 | controller |
2025-12-16 11:55:16.468258 | controller | PLAY RECAP *********************************************************************
2025-12-16 11:55:16.468290 | controller | instance                   : ok=31   changed=17   unreachable=0    failed=0    skipped=36   rescued=0    ignored=0
2025-12-16 11:55:16.522628 | controller | localhost                  : ok=19   changed=10   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-12-16 11:55:16.522651 | controller |
2025-12-16 11:55:16.522659 | controller | Tuesday 16 December 2025  11:55:16 +0000 (0:00:00.034)       0:01:47.936 ******
2025-12-16 11:55:16.522665 | controller | ===============================================================================
2025-12-16 11:55:16.522671 | controller | test_deps : Install selinux python libs -------------------------------- 42.04s
2025-12-16 11:55:16.522676 | controller | download_tools : Download and extract golang --------------------------- 11.76s
2025-12-16 11:55:16.522682 | controller | download_tools : Install build dependencies ---------------------------- 11.27s
2025-12-16 11:55:16.522687 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.80s
2025-12-16 11:55:16.522692 | controller | ci_setup : Install openshift client ------------------------------------- 5.96s
2025-12-16 11:55:16.522698 | controller | ci_setup : Install needed packages -------------------------------------- 3.76s
2025-12-16 11:55:16.522703 | controller | download_tools : Download chainsaw -------------------------------------- 2.97s
2025-12-16 11:55:16.522708 | controller | download_tools : Download operator-sdk ---------------------------------- 1.83s
2025-12-16 11:55:16.522713 | controller | download_tools : Deinstall golang --------------------------------------- 1.47s
2025-12-16 11:55:16.522719 | controller | download_tools : Download opm ------------------------------------------- 1.27s
2025-12-16 11:55:16.522724 | controller | test_deps : Install python yaml libs ------------------------------------ 1.15s
2025-12-16 11:55:16.522729 | controller | download_tools : Download and extract yq -------------------------------- 1.15s
2025-12-16 11:55:16.522734 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.12s
2025-12-16 11:55:16.522740 | controller | download_tools : Download and extract kustomize ------------------------- 1.04s
2025-12-16 11:55:16.522745 | controller | ci_setup : Manage directories ------------------------------------------- 0.96s
2025-12-16 11:55:16.522750 | controller | download_tools : Download kuttl ----------------------------------------- 0.93s
2025-12-16 11:55:16.522755 | controller | download_tools : Delete old go version installed from upstream ---------- 0.89s
2025-12-16 11:55:16.522761 | controller | Gathering Facts --------------------------------------------------------- 0.81s
2025-12-16 11:55:16.522766 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.81s
2025-12-16 11:55:16.522771 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.79s
2025-12-16 11:55:16.522780 | controller | INFO     Running default > converge
2025-12-16 11:55:16.911659 | controller |
2025-12-16 11:55:17.689734 | controller | PLAY [Converge] ****************************************************************
2025-12-16 11:55:17.689768 | controller |
2025-12-16 11:55:17.689778 | controller | TASK [Gathering Facts] *********************************************************
2025-12-16 11:55:17.689786 | controller | Tuesday 16 December 2025  11:55:16 +0000 (0:00:00.012)       0:00:00.012 ******
2025-12-16 11:55:17.689797 | controller | ok: [instance]
2025-12-16 11:55:18.305608 | controller |
2025-12-16 11:55:18.305640 | controller | TASK [Ensure architecture repository is building] ******************************
2025-12-16 11:55:18.305648 | controller | Tuesday 16 December 2025  11:55:17 +0000 (0:00:00.778)       0:00:00.790 ******
2025-12-16 11:55:18.305658 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-12-16 11:55:18.655809 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-12-16 11:55:18.655843 | controller |
2025-12-16 11:55:18.655851 | controller | TASK [Create nova migration keypair] *******************************************
2025-12-16 11:55:18.655858 | controller | Tuesday 16 December 2025  11:55:18 +0000 (0:00:00.615)       0:00:01.406 ******
2025-12-16 11:55:18.655867 | controller | changed: [instance]
2025-12-16 11:55:18.710985 | controller |
2025-12-16 11:55:18.711016 | controller | TASK [Generate needed facts out of local files] ********************************
2025-12-16 11:55:18.711024 | controller | Tuesday 16 December 2025  11:55:18 +0000 (0:00:00.350)       0:00:01.756 ******
2025-12-16 11:55:18.711035 | controller | ok: [instance]
2025-12-16 11:55:18.733771 | controller |
2025-12-16 11:55:18.733799 | controller | TASK [Generate network-values] *************************************************
2025-12-16 11:55:18.733810 | controller | Tuesday 16 December 2025  11:55:18 +0000 (0:00:00.055)       0:00:01.811 ******
2025-12-16 11:55:18.733822 | controller |
2025-12-16 11:55:18.758485 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-16 11:55:18.758508 | controller | Tuesday 16 December 2025  11:55:18 +0000 (0:00:00.022)       0:00:01.834 ******
2025-12-16 11:55:18.758522 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-16 11:55:18.784520 | controller |
2025-12-16 11:55:18.784537 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-16 11:55:18.784545 | controller | Tuesday 16 December 2025  11:55:18 +0000 (0:00:00.024)       0:00:01.859 ******
2025-12-16 11:55:18.784554 | controller | ok: [instance] => changed=false
2025-12-16 11:55:19.062384 | controller |   msg: All assertions passed
2025-12-16 11:55:19.062413 | controller |
2025-12-16 11:55:19.062421 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-16 11:55:19.062427 | controller | Tuesday 16 December 2025  11:55:18 +0000 (0:00:00.025)       0:00:01.885 ******
2025-12-16 11:55:19.062436 | controller | ok: [instance]
2025-12-16 11:55:19.095762 | controller |
2025-12-16 11:55:19.095781 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-16 11:55:19.095789 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.277)       0:00:02.163 ******
2025-12-16 11:55:19.095798 | controller | ok: [instance] => changed=false
2025-12-16 11:55:19.371553 | controller |   msg: All assertions passed
2025-12-16 11:55:19.371584 | controller |
2025-12-16 11:55:19.371593 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-16 11:55:19.371599 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.033)       0:00:02.196 ******
2025-12-16 11:55:19.371608 | controller | ok: [instance]
2025-12-16 11:55:19.628981 | controller |
2025-12-16 11:55:19.629005 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-16 11:55:19.629019 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.275)       0:00:02.472 ******
2025-12-16 11:55:19.629028 | controller | ok: [instance]
2025-12-16 11:55:19.670447 | controller |
2025-12-16 11:55:19.670477 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-16 11:55:19.670489 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.257)       0:00:02.729 ******
2025-12-16 11:55:19.670504 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-12-16 11:55:19.693521 | controller |
2025-12-16 11:55:19.693543 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-12-16 11:55:19.693552 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.041)       0:00:02.771 ******
2025-12-16 11:55:19.693560 | controller | ok: [instance] => changed=false
2025-12-16 11:55:19.965958 | controller |   msg: All assertions passed
2025-12-16 11:55:19.965987 | controller |
2025-12-16 11:55:19.965995 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-16 11:55:19.966007 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.023)       0:00:02.794 ******
2025-12-16 11:55:19.966017 | controller | changed: [instance]
2025-12-16 11:55:19.966040 | controller |
2025-12-16 11:55:19.966191 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-16 11:55:20.482179 | controller | Tuesday 16 December 2025  11:55:19 +0000 (0:00:00.272)       0:00:03.066 ******
2025-12-16 11:55:20.482213 | controller | changed: [instance]
2025-12-16 11:55:20.513778 | controller |
2025-12-16 11:55:20.513801 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-16 11:55:20.513810 | controller | Tuesday 16 December 2025  11:55:20 +0000 (0:00:00.516)       0:00:03.582 ******
2025-12-16 11:55:20.513821 | controller | ok: [instance]
2025-12-16 11:55:20.840565 | controller |
2025-12-16 11:55:20.840594 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-16 11:55:20.840602 | controller | Tuesday 16 December 2025  11:55:20 +0000 (0:00:00.031)       0:00:03.614 ******
2025-12-16 11:55:20.840611 | controller | changed: [instance]
2025-12-16 11:55:21.164100 | controller |
2025-12-16 11:55:21.164130 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-16 11:55:21.164138 | controller | Tuesday 16 December 2025  11:55:20 +0000 (0:00:00.326)       0:00:03.941 ******
2025-12-16 11:55:21.164148 | controller | changed: [instance]
2025-12-16 11:55:21.493425 | controller |
2025-12-16 11:55:21.493455 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-16 11:55:21.493463 | controller | Tuesday 16 December 2025  11:55:21 +0000 (0:00:00.323)       0:00:04.264 ******
2025-12-16 11:55:21.493473 | controller | changed: [instance]
2025-12-16 11:55:21.519751 | controller |
2025-12-16 11:55:21.519772 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-16 11:55:21.519781 | controller | Tuesday 16 December 2025  11:55:21 +0000 (0:00:00.329)       0:00:04.594 ******
2025-12-16 11:55:21.519791 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-16 11:55:21.542793 | controller |
2025-12-16 11:55:21.542814 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-16 11:55:21.542823 | controller | Tuesday 16 December 2025  11:55:21 +0000 (0:00:00.026)       0:00:04.620 ******
2025-12-16 11:55:21.542833 | controller | ok: [instance] => changed=false
2025-12-16 11:55:21.805125 | controller |   msg: All assertions passed
2025-12-16 11:55:21.805154 | controller |
2025-12-16 11:55:21.805162 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-16 11:55:21.805169 | controller | Tuesday 16 December 2025  11:55:21 +0000 (0:00:00.022)       0:00:04.643 ******
2025-12-16 11:55:21.805183 | controller | ok: [instance]
2025-12-16 11:55:21.820881 | controller |
2025-12-16 11:55:21.820922 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-16 11:55:21.820934 | controller | Tuesday 16 December 2025  11:55:21 +0000 (0:00:00.262)       0:00:04.905 ******
2025-12-16 11:55:21.820945 | controller | ok: [instance]
2025-12-16 11:55:22.285961 | controller |
2025-12-16 11:55:22.285991 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-16 11:55:22.285999 | controller | Tuesday 16 December 2025  11:55:21 +0000 (0:00:00.015)       0:00:04.921 ******
2025-12-16 11:55:22.286009 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-12-16 11:55:22.286526 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-12-16 11:55:22.345756 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-12-16 11:55:22.345772 | controller |
2025-12-16 11:55:22.345779 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-16 11:55:22.345785 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.465)       0:00:05.387 ******
2025-12-16 11:55:22.345793 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-16 11:55:22.537544 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-16 11:55:22.537572 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-16 11:55:22.537579 | controller |
2025-12-16 11:55:22.537585 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-16 11:55:22.537591 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.059)       0:00:05.446 ******
2025-12-16 11:55:22.537607 | controller | changed: [instance]
2025-12-16 11:55:22.876635 | controller |
2025-12-16 11:55:22.876665 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-16 11:55:22.876673 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.191)       0:00:05.638 ******
2025-12-16 11:55:22.876683 | controller | changed: [instance]
2025-12-16 11:55:22.900420 | controller |
2025-12-16 11:55:22.900439 | controller | TASK [Generate edpm-nodeset-values] ********************************************
2025-12-16 11:55:22.900448 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.338)       0:00:05.977 ******
2025-12-16 11:55:22.900458 | controller |
2025-12-16 11:55:22.923980 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-16 11:55:22.924002 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.024)       0:00:06.001 ******
2025-12-16 11:55:22.924022 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-16 11:55:22.947992 | controller |
2025-12-16 11:55:22.948023 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-16 11:55:22.948031 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.023)       0:00:06.024 ******
2025-12-16 11:55:22.948041 | controller | ok: [instance] => changed=false
2025-12-16 11:55:22.948066 | controller |   msg: All assertions passed
2025-12-16 11:55:22.948074 | controller |
2025-12-16 11:55:22.948253 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-16 11:55:23.128477 | controller | Tuesday 16 December 2025  11:55:22 +0000 (0:00:00.024)       0:00:06.049 ******
2025-12-16 11:55:23.128510 | controller | ok: [instance]
2025-12-16 11:55:23.159840 | controller |
2025-12-16 11:55:23.159864 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-16 11:55:23.159873 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.180)       0:00:06.229 ******
2025-12-16 11:55:23.159883 | controller | ok: [instance] => changed=false
2025-12-16 11:55:23.346806 | controller |   msg: All assertions passed
2025-12-16 11:55:23.346838 | controller |
2025-12-16 11:55:23.346847 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-16 11:55:23.346853 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.031)       0:00:06.260 ******
2025-12-16 11:55:23.346863 | controller | ok: [instance]
2025-12-16 11:55:23.569753 | controller |
2025-12-16 11:55:23.569775 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-16 11:55:23.569783 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.186)       0:00:06.447 ******
2025-12-16 11:55:23.569792 | controller | ok: [instance]
2025-12-16 11:55:23.610952 | controller |
2025-12-16 11:55:23.610970 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-16 11:55:23.610978 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.223)       0:00:06.670 ******
2025-12-16 11:55:23.610987 | 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-12-16 11:55:23.611037 | controller |
2025-12-16 11:55:23.611053 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-12-16 11:55:23.611063 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.041)       0:00:06.711 ******
2025-12-16 11:55:23.643379 | 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-12-16 11:55:23.670987 | controller |
2025-12-16 11:55:23.671010 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-12-16 11:55:23.671019 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.032)       0:00:06.744 ******
2025-12-16 11:55:23.671030 | controller | ok: [instance] => changed=false
2025-12-16 11:55:23.671057 | controller |   msg: All assertions passed
2025-12-16 11:55:23.671067 | controller |
2025-12-16 11:55:23.671285 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-12-16 11:55:23.695540 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.027)       0:00:06.772 ******
2025-12-16 11:55:23.695565 | 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-12-16 11:55:23.710411 | controller |
2025-12-16 11:55:23.710432 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-12-16 11:55:23.710441 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.024)       0:00:06.796 ******
2025-12-16 11:55:23.710451 | controller | skipping: [instance]
2025-12-16 11:55:23.728963 | controller |
2025-12-16 11:55:23.728989 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-12-16 11:55:23.728999 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.015)       0:00:06.811 ******
2025-12-16 11:55:23.729012 | controller | ok: [instance]
2025-12-16 11:55:23.729043 | controller |
2025-12-16 11:55:23.729053 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-12-16 11:55:23.729130 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.018)       0:00:06.830 ******
2025-12-16 11:55:23.753481 | controller | ok: [instance] => changed=false
2025-12-16 11:55:23.930374 | controller |   msg: All assertions passed
2025-12-16 11:55:23.930404 | controller |
2025-12-16 11:55:23.930412 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-16 11:55:23.930419 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.024)       0:00:06.854 ******
2025-12-16 11:55:23.930429 | controller | changed: [instance]
2025-12-16 11:55:24.308168 | controller |
2025-12-16 11:55:24.308208 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-16 11:55:24.308216 | controller | Tuesday 16 December 2025  11:55:23 +0000 (0:00:00.176)       0:00:07.031 ******
2025-12-16 11:55:24.308226 | controller | changed: [instance]
2025-12-16 11:55:24.330451 | controller |
2025-12-16 11:55:24.330473 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-16 11:55:24.330482 | controller | Tuesday 16 December 2025  11:55:24 +0000 (0:00:00.377)       0:00:07.408 ******
2025-12-16 11:55:24.330491 | controller | ok: [instance]
2025-12-16 11:55:24.646293 | controller |
2025-12-16 11:55:24.646322 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-16 11:55:24.646330 | controller | Tuesday 16 December 2025  11:55:24 +0000 (0:00:00.022)       0:00:07.431 ******
2025-12-16 11:55:24.646340 | controller | changed: [instance]
2025-12-16 11:55:24.961862 | controller |
2025-12-16 11:55:24.961886 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-16 11:55:24.961919 | controller | Tuesday 16 December 2025  11:55:24 +0000 (0:00:00.315)       0:00:07.747 ******
2025-12-16 11:55:24.961932 | controller | changed: [instance]
2025-12-16 11:55:25.269357 | controller |
2025-12-16 11:55:25.269384 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-16 11:55:25.269397 | controller | Tuesday 16 December 2025  11:55:24 +0000 (0:00:00.315)       0:00:08.062 ******
2025-12-16 11:55:25.269407 | controller | changed: [instance]
2025-12-16 11:55:25.294419 | controller |
2025-12-16 11:55:25.294440 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-16 11:55:25.294450 | controller | Tuesday 16 December 2025  11:55:25 +0000 (0:00:00.307)       0:00:08.370 ******
2025-12-16 11:55:25.294461 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-16 11:55:25.317606 | controller |
2025-12-16 11:55:25.317625 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-16 11:55:25.317633 | controller | Tuesday 16 December 2025  11:55:25 +0000 (0:00:00.025)       0:00:08.395 ******
2025-12-16 11:55:25.317644 | controller | ok: [instance] => changed=false
2025-12-16 11:55:25.484001 | controller |   msg: All assertions passed
2025-12-16 11:55:25.484033 | controller |
2025-12-16 11:55:25.484042 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-16 11:55:25.484049 | controller | Tuesday 16 December 2025  11:55:25 +0000 (0:00:00.023)       0:00:08.418 ******
2025-12-16 11:55:25.484064 | controller | ok: [instance]
2025-12-16 11:55:25.484635 | controller |
2025-12-16 11:55:25.484661 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-16 11:55:25.500477 | controller | Tuesday 16 December 2025  11:55:25 +0000 (0:00:00.166)       0:00:08.585 ******
2025-12-16 11:55:25.500494 | controller | ok: [instance]
2025-12-16 11:55:25.974724 | controller |
2025-12-16 11:55:25.974753 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-16 11:55:25.974761 | controller | Tuesday 16 December 2025  11:55:25 +0000 (0:00:00.016)       0:00:08.601 ******
2025-12-16 11:55:25.974771 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-12-16 11:55:26.022612 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-12-16 11:55:26.022634 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-12-16 11:55:26.022641 | controller |
2025-12-16 11:55:26.022647 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-16 11:55:26.022653 | controller | Tuesday 16 December 2025  11:55:25 +0000 (0:00:00.473)       0:00:09.075 ******
2025-12-16 11:55:26.022662 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-16 11:55:26.207031 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-16 11:55:26.207060 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-16 11:55:26.207067 | controller |
2025-12-16 11:55:26.207072 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-16 11:55:26.207078 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.047)       0:00:09.123 ******
2025-12-16 11:55:26.207087 | controller | changed: [instance]
2025-12-16 11:55:26.531775 | controller |
2025-12-16 11:55:26.531805 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-16 11:55:26.531812 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.184)       0:00:09.307 ******
2025-12-16 11:55:26.531821 | controller | changed: [instance]
2025-12-16 11:55:26.859964 | controller |
2025-12-16 11:55:26.859992 | controller | TASK [Get generated files status] **********************************************
2025-12-16 11:55:26.860000 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.324)       0:00:09.632 ******
2025-12-16 11:55:26.860010 | controller | ok: [instance] => (item=network-values)
2025-12-16 11:55:26.860102 | controller | ok: [instance] => (item=edpm-nodeset-values)
2025-12-16 11:55:26.860141 | controller |
2025-12-16 11:55:26.860149 | controller | TASK [Assert generated values.yaml exists] *************************************
2025-12-16 11:55:26.860160 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.328)       0:00:09.960 ******
2025-12-16 11:55:26.885958 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml) => changed=false
2025-12-16 11:55:26.886634 | controller |   ansible_loop_var: item
2025-12-16 11:55:26.886659 | controller |   item:
2025-12-16 11:55:26.886666 | controller |     ansible_loop_var: item
2025-12-16 11:55:26.886672 | controller |     changed: false
2025-12-16 11:55:26.886678 | controller |     failed: false
2025-12-16 11:55:26.886683 | controller |     invocation:
2025-12-16 11:55:26.886689 | controller |       module_args:
2025-12-16 11:55:26.886694 | controller |         checksum_algorithm: sha1
2025-12-16 11:55:26.886700 | controller |         follow: false
2025-12-16 11:55:26.886705 | controller |         get_attributes: false
2025-12-16 11:55:26.886715 | controller |         get_checksum: false
2025-12-16 11:55:26.886746 | controller |         get_md5: false
2025-12-16 11:55:26.886752 | controller |         get_mime: false
2025-12-16 11:55:26.886758 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-12-16 11:55:26.886764 | controller |     item: network-values
2025-12-16 11:55:26.886769 | controller |     stat:
2025-12-16 11:55:26.886776 | controller |       atime: 1765886122.8409216
2025-12-16 11:55:26.886944 | controller |       block_size: 4096
2025-12-16 11:55:26.887733 | controller |       blocks: 16
2025-12-16 11:55:26.887747 | controller |       ctime: 1765886122.8439217
2025-12-16 11:55:26.887831 | controller |       dev: 64513
2025-12-16 11:55:26.887839 | controller |       device_type: 0
2025-12-16 11:55:26.887851 | controller |       executable: false
2025-12-16 11:55:26.887856 | controller |       exists: true
2025-12-16 11:55:26.887862 | controller |       gid: 1000
2025-12-16 11:55:26.887867 | controller |       gr_name: zuul
2025-12-16 11:55:26.887873 | controller |       inode: 138431342
2025-12-16 11:55:26.887878 | controller |       isblk: false
2025-12-16 11:55:26.887885 | controller |       ischr: false
2025-12-16 11:55:26.887969 | controller |       isdir: false
2025-12-16 11:55:26.888102 | controller |       isfifo: false
2025-12-16 11:55:26.888229 | controller |       isgid: false
2025-12-16 11:55:26.888337 | controller |       islnk: false
2025-12-16 11:55:26.888440 | controller |       isreg: true
2025-12-16 11:55:26.888549 | controller |       issock: false
2025-12-16 11:55:26.888657 | controller |       isuid: false
2025-12-16 11:55:26.888772 | controller |       mode: '0644'
2025-12-16 11:55:26.888887 | controller |       mtime: 1765886122.7079246
2025-12-16 11:55:26.889061 | controller |       nlink: 1
2025-12-16 11:55:26.889221 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-12-16 11:55:26.889353 | controller |       pw_name: zuul
2025-12-16 11:55:26.889482 | controller |       readable: true
2025-12-16 11:55:26.889610 | controller |       rgrp: true
2025-12-16 11:55:26.889747 | controller |       roth: true
2025-12-16 11:55:26.889876 | controller |       rusr: true
2025-12-16 11:55:26.890029 | controller |       size: 5726
2025-12-16 11:55:26.890185 | controller |       uid: 1000
2025-12-16 11:55:26.890326 | controller |       wgrp: false
2025-12-16 11:55:26.890462 | controller |       woth: false
2025-12-16 11:55:26.890589 | controller |       writeable: true
2025-12-16 11:55:26.890714 | controller |       wusr: true
2025-12-16 11:55:26.890847 | controller |       xgrp: false
2025-12-16 11:55:26.891007 | controller |       xoth: false
2025-12-16 11:55:26.891154 | controller |       xusr: false
2025-12-16 11:55:26.891288 | controller |   msg: All assertions passed
2025-12-16 11:55:26.891426 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml) => changed=false
2025-12-16 11:55:26.891555 | controller |   ansible_loop_var: item
2025-12-16 11:55:26.891681 | controller |   item:
2025-12-16 11:55:26.891816 | controller |     ansible_loop_var: item
2025-12-16 11:55:26.891965 | controller |     changed: false
2025-12-16 11:55:26.892098 | controller |     failed: false
2025-12-16 11:55:26.892240 | controller |     invocation:
2025-12-16 11:55:26.892370 | controller |       module_args:
2025-12-16 11:55:26.892498 | controller |         checksum_algorithm: sha1
2025-12-16 11:55:26.892624 | controller |         follow: false
2025-12-16 11:55:26.892749 | controller |         get_attributes: false
2025-12-16 11:55:26.892875 | controller |         get_checksum: false
2025-12-16 11:55:26.893035 | controller |         get_md5: false
2025-12-16 11:55:26.893183 | controller |         get_mime: false
2025-12-16 11:55:26.893318 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-12-16 11:55:26.893445 | controller |     item: edpm-nodeset-values
2025-12-16 11:55:26.893570 | controller |     stat:
2025-12-16 11:55:26.893703 | controller |       atime: 1765886126.4968436
2025-12-16 11:55:26.893832 | controller |       block_size: 4096
2025-12-16 11:55:26.893984 | controller |       blocks: 40
2025-12-16 11:55:26.894118 | controller |       ctime: 1765886126.4998436
2025-12-16 11:55:26.894263 | controller |       dev: 64513
2025-12-16 11:55:26.894390 | controller |       device_type: 0
2025-12-16 11:55:26.894515 | controller |       executable: false
2025-12-16 11:55:26.894641 | controller |       exists: true
2025-12-16 11:55:26.894766 | controller |       gid: 1000
2025-12-16 11:55:26.894910 | controller |       gr_name: zuul
2025-12-16 11:55:26.895054 | controller |       inode: 109062001
2025-12-16 11:55:26.895197 | controller |       isblk: false
2025-12-16 11:55:26.895325 | controller |       ischr: false
2025-12-16 11:55:26.895461 | controller |       isdir: false
2025-12-16 11:55:26.895591 | controller |       isfifo: false
2025-12-16 11:55:26.895718 | controller |       isgid: false
2025-12-16 11:55:26.895844 | controller |       islnk: false
2025-12-16 11:55:26.895991 | controller |       isreg: true
2025-12-16 11:55:26.896124 | controller |       issock: false
2025-12-16 11:55:26.896267 | controller |       isuid: false
2025-12-16 11:55:26.896392 | controller |       mode: '0644'
2025-12-16 11:55:26.896519 | controller |       mtime: 1765886126.3648465
2025-12-16 11:55:26.896646 | controller |       nlink: 1
2025-12-16 11:55:26.896779 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-12-16 11:55:26.896932 | controller |       pw_name: zuul
2025-12-16 11:55:26.897081 | controller |       readable: true
2025-12-16 11:55:26.897228 | controller |       rgrp: true
2025-12-16 11:55:26.897358 | controller |       roth: true
2025-12-16 11:55:26.897490 | controller |       rusr: true
2025-12-16 11:55:26.897617 | controller |       size: 16482
2025-12-16 11:55:26.897741 | controller |       uid: 1000
2025-12-16 11:55:26.897870 | controller |       wgrp: false
2025-12-16 11:55:26.898021 | controller |       woth: false
2025-12-16 11:55:26.898167 | controller |       writeable: true
2025-12-16 11:55:26.898295 | controller |       wusr: true
2025-12-16 11:55:26.898423 | controller |       xgrp: false
2025-12-16 11:55:26.898548 | controller |       xoth: false
2025-12-16 11:55:26.898671 | controller |       xusr: false
2025-12-16 11:55:26.898796 | controller |   msg: All assertions passed
2025-12-16 11:55:26.898937 | controller |
2025-12-16 11:55:26.899076 | controller | TASK [Ensure we have correct MAC] **********************************************
2025-12-16 11:55:26.899217 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.025)       0:00:09.986 ******
2025-12-16 11:55:26.915449 | controller | ok: [instance] => changed=false
2025-12-16 11:55:26.915600 | controller |   msg: All assertions passed
2025-12-16 11:55:26.915730 | controller |
2025-12-16 11:55:26.915867 | controller | TASK [Ensure we don't have node_1 nor node_2] **********************************
2025-12-16 11:55:26.916030 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.030)       0:00:10.016 ******
2025-12-16 11:55:26.946052 | controller | ok: [instance] => changed=false
2025-12-16 11:55:26.946237 | controller |   msg: All assertions passed
2025-12-16 11:55:26.946369 | controller |
2025-12-16 11:55:26.946505 | controller | TASK [Update cifmw_networking_env_definition] **********************************
2025-12-16 11:55:26.946640 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.030)       0:00:10.047 ******
2025-12-16 11:55:26.969464 | controller | ok: [instance]
2025-12-16 11:55:26.969608 | controller |
2025-12-16 11:55:26.969747 | controller | TASK [Regenerate network-values] ***********************************************
2025-12-16 11:55:26.969884 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.023)       0:00:10.070 ******
2025-12-16 11:55:26.990310 | controller |
2025-12-16 11:55:26.990494 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-16 11:55:26.990665 | controller | Tuesday 16 December 2025  11:55:26 +0000 (0:00:00.020)       0:00:10.091 ******
2025-12-16 11:55:27.013441 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-16 11:55:27.013586 | controller |
2025-12-16 11:55:27.013739 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-16 11:55:27.013881 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.023)       0:00:10.114 ******
2025-12-16 11:55:27.038723 | controller | ok: [instance] => changed=false
2025-12-16 11:55:27.038958 | controller |   msg: All assertions passed
2025-12-16 11:55:27.039159 | controller |
2025-12-16 11:55:27.039346 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-16 11:55:27.039485 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.025)       0:00:10.140 ******
2025-12-16 11:55:27.214758 | controller | ok: [instance]
2025-12-16 11:55:27.236681 | controller |
2025-12-16 11:55:27.236698 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-16 11:55:27.236706 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.175)       0:00:10.315 ******
2025-12-16 11:55:27.236714 | controller | ok: [instance] => changed=false
2025-12-16 11:55:27.407785 | controller |   msg: All assertions passed
2025-12-16 11:55:27.407809 | controller |
2025-12-16 11:55:27.407817 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-16 11:55:27.407823 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.021)       0:00:10.337 ******
2025-12-16 11:55:27.407832 | controller | ok: [instance]
2025-12-16 11:55:27.636770 | controller |
2025-12-16 11:55:27.636797 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-16 11:55:27.636805 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.171)       0:00:10.508 ******
2025-12-16 11:55:27.636814 | controller | ok: [instance]
2025-12-16 11:55:27.669021 | controller |
2025-12-16 11:55:27.669055 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-16 11:55:27.669075 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.229)       0:00:10.737 ******
2025-12-16 11:55:27.669088 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-12-16 11:55:27.669133 | controller |
2025-12-16 11:55:27.669142 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-12-16 11:55:27.669152 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.032)       0:00:10.769 ******
2025-12-16 11:55:27.691954 | controller | ok: [instance] => changed=false
2025-12-16 11:55:27.692543 | controller |   msg: All assertions passed
2025-12-16 11:55:27.870633 | controller |
2025-12-16 11:55:27.870653 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-16 11:55:27.870660 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.023)       0:00:10.793 ******
2025-12-16 11:55:27.870669 | controller | ok: [instance]
2025-12-16 11:55:28.323417 | controller |
2025-12-16 11:55:28.323446 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-16 11:55:28.323454 | controller | Tuesday 16 December 2025  11:55:27 +0000 (0:00:00.178)       0:00:10.971 ******
2025-12-16 11:55:28.323463 | controller | changed: [instance]
2025-12-16 11:55:28.345779 | controller |
2025-12-16 11:55:28.345797 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-16 11:55:28.345804 | controller | Tuesday 16 December 2025  11:55:28 +0000 (0:00:00.452)       0:00:11.424 ******
2025-12-16 11:55:28.345812 | controller | ok: [instance]
2025-12-16 11:55:28.663380 | controller |
2025-12-16 11:55:28.663405 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-16 11:55:28.663412 | controller | Tuesday 16 December 2025  11:55:28 +0000 (0:00:00.022)       0:00:11.446 ******
2025-12-16 11:55:28.663422 | controller | ok: [instance]
2025-12-16 11:55:28.979347 | controller |
2025-12-16 11:55:28.979369 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-16 11:55:28.979376 | controller | Tuesday 16 December 2025  11:55:28 +0000 (0:00:00.317)       0:00:11.764 ******
2025-12-16 11:55:28.979385 | controller | ok: [instance]
2025-12-16 11:55:29.310023 | controller |
2025-12-16 11:55:29.310046 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-16 11:55:29.310054 | controller | Tuesday 16 December 2025  11:55:28 +0000 (0:00:00.316)       0:00:12.080 ******
2025-12-16 11:55:29.310076 | controller | ok: [instance]
2025-12-16 11:55:29.353014 | controller |
2025-12-16 11:55:29.353052 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-16 11:55:29.353071 | controller | Tuesday 16 December 2025  11:55:29 +0000 (0:00:00.330)       0:00:12.410 ******
2025-12-16 11:55:29.353085 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-16 11:55:29.353117 | controller |
2025-12-16 11:55:29.353127 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-16 11:55:29.353268 | controller | Tuesday 16 December 2025  11:55:29 +0000 (0:00:00.043)       0:00:12.454 ******
2025-12-16 11:55:29.378881 | controller | ok: [instance] => changed=false
2025-12-16 11:55:29.559932 | controller |   msg: All assertions passed
2025-12-16 11:55:29.559956 | controller |
2025-12-16 11:55:29.559965 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-16 11:55:29.559973 | controller | Tuesday 16 December 2025  11:55:29 +0000 (0:00:00.025)       0:00:12.479 ******
2025-12-16 11:55:29.559991 | controller | ok: [instance]
2025-12-16 11:55:29.576587 | controller |
2025-12-16 11:55:29.576608 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-16 11:55:29.576616 | controller | Tuesday 16 December 2025  11:55:29 +0000 (0:00:00.181)       0:00:12.660 ******
2025-12-16 11:55:29.576626 | controller | ok: [instance]
2025-12-16 11:55:30.059248 | controller |
2025-12-16 11:55:30.059275 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-16 11:55:30.059283 | controller | Tuesday 16 December 2025  11:55:29 +0000 (0:00:00.016)       0:00:12.677 ******
2025-12-16 11:55:30.059298 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-12-16 11:55:30.111318 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-12-16 11:55:30.111336 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-12-16 11:55:30.111343 | controller |
2025-12-16 11:55:30.111349 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-16 11:55:30.111354 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.482)       0:00:13.159 ******
2025-12-16 11:55:30.111363 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-16 11:55:30.288361 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-16 11:55:30.288387 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-16 11:55:30.288395 | controller |
2025-12-16 11:55:30.288402 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-16 11:55:30.288407 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.052)       0:00:13.211 ******
2025-12-16 11:55:30.288416 | controller | ok: [instance]
2025-12-16 11:55:30.646972 | controller |
2025-12-16 11:55:30.647002 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-16 11:55:30.647010 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.177)       0:00:13.389 ******
2025-12-16 11:55:30.647020 | controller | changed: [instance]
2025-12-16 11:55:30.647055 | controller |
2025-12-16 11:55:30.647248 | controller | TASK [Regenerate edpm-nodeset-values] ******************************************
2025-12-16 11:55:30.669970 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.358)       0:00:13.748 ******
2025-12-16 11:55:30.669995 | controller |
2025-12-16 11:55:30.670126 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-16 11:55:30.670137 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.023)       0:00:13.771 ******
2025-12-16 11:55:30.693669 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-16 11:55:30.716909 | controller |
2025-12-16 11:55:30.716933 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-16 11:55:30.716941 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.023)       0:00:13.794 ******
2025-12-16 11:55:30.716951 | controller | ok: [instance] => changed=false
2025-12-16 11:55:30.887965 | controller |   msg: All assertions passed
2025-12-16 11:55:30.887992 | controller |
2025-12-16 11:55:30.888004 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-16 11:55:30.888011 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.023)       0:00:13.817 ******
2025-12-16 11:55:30.888021 | controller | ok: [instance]
2025-12-16 11:55:30.888324 | controller |
2025-12-16 11:55:30.908383 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-16 11:55:30.908408 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.171)       0:00:13.989 ******
2025-12-16 11:55:30.908421 | controller | ok: [instance] => changed=false
2025-12-16 11:55:31.067960 | controller |   msg: All assertions passed
2025-12-16 11:55:31.067986 | controller |
2025-12-16 11:55:31.067994 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-16 11:55:31.068000 | controller | Tuesday 16 December 2025  11:55:30 +0000 (0:00:00.020)       0:00:14.009 ******
2025-12-16 11:55:31.068009 | controller | ok: [instance]
2025-12-16 11:55:31.068041 | controller |
2025-12-16 11:55:31.068050 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-16 11:55:31.068170 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.159)       0:00:14.169 ******
2025-12-16 11:55:31.273884 | controller | ok: [instance]
2025-12-16 11:55:31.304356 | controller |
2025-12-16 11:55:31.304390 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-16 11:55:31.304401 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.205)       0:00:14.374 ******
2025-12-16 11:55:31.304413 | 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-12-16 11:55:31.326964 | controller |
2025-12-16 11:55:31.326987 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-12-16 11:55:31.326997 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.030)       0:00:14.405 ******
2025-12-16 11:55:31.327008 | 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-12-16 11:55:31.327052 | controller |
2025-12-16 11:55:31.327063 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-12-16 11:55:31.327176 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.022)       0:00:14.428 ******
2025-12-16 11:55:31.355577 | controller | ok: [instance] => changed=false
2025-12-16 11:55:31.378497 | controller |   msg: All assertions passed
2025-12-16 11:55:31.378524 | controller |
2025-12-16 11:55:31.378534 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-12-16 11:55:31.378541 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.028)       0:00:14.456 ******
2025-12-16 11:55:31.378553 | 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-12-16 11:55:31.378651 | controller |
2025-12-16 11:55:31.378802 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-12-16 11:55:31.378959 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.023)       0:00:14.479 ******
2025-12-16 11:55:31.392971 | controller | skipping: [instance]
2025-12-16 11:55:31.393135 | controller |
2025-12-16 11:55:31.393283 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-12-16 11:55:31.393424 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.014)       0:00:14.494 ******
2025-12-16 11:55:31.411268 | controller | ok: [instance]
2025-12-16 11:55:31.411418 | controller |
2025-12-16 11:55:31.411566 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-12-16 11:55:31.411687 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.018)       0:00:14.512 ******
2025-12-16 11:55:31.434853 | controller | ok: [instance] => changed=false
2025-12-16 11:55:31.435005 | controller |   msg: All assertions passed
2025-12-16 11:55:31.435137 | controller |
2025-12-16 11:55:31.435252 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-16 11:55:31.435365 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.023)       0:00:14.536 ******
2025-12-16 11:55:31.605656 | controller | ok: [instance]
2025-12-16 11:55:31.980757 | controller |
2025-12-16 11:55:31.980810 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-16 11:55:31.980819 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.170)       0:00:14.706 ******
2025-12-16 11:55:31.980829 | controller | ok: [instance]
2025-12-16 11:55:32.002941 | controller |
2025-12-16 11:55:32.002963 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-16 11:55:32.002971 | controller | Tuesday 16 December 2025  11:55:31 +0000 (0:00:00.375)       0:00:15.081 ******
2025-12-16 11:55:32.002981 | controller | ok: [instance]
2025-12-16 11:55:32.003012 | controller |
2025-12-16 11:55:32.003021 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-16 11:55:32.003095 | controller | Tuesday 16 December 2025  11:55:32 +0000 (0:00:00.022)       0:00:15.104 ******
2025-12-16 11:55:32.329972 | controller | ok: [instance]
2025-12-16 11:55:32.644967 | controller |
2025-12-16 11:55:32.645009 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-16 11:55:32.645017 | controller | Tuesday 16 December 2025  11:55:32 +0000 (0:00:00.326)       0:00:15.430 ******
2025-12-16 11:55:32.645028 | controller | ok: [instance]
2025-12-16 11:55:32.645036 | controller |
2025-12-16 11:55:32.645155 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-16 11:55:32.645258 | controller | Tuesday 16 December 2025  11:55:32 +0000 (0:00:00.315)       0:00:15.746 ******
2025-12-16 11:55:32.960230 | controller | ok: [instance]
2025-12-16 11:55:32.960290 | controller |
2025-12-16 11:55:32.960384 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-16 11:55:32.960475 | controller | Tuesday 16 December 2025  11:55:32 +0000 (0:00:00.315)       0:00:16.061 ******
2025-12-16 11:55:32.985850 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-16 11:55:32.986275 | controller |
2025-12-16 11:55:33.009849 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-16 11:55:33.009865 | controller | Tuesday 16 December 2025  11:55:32 +0000 (0:00:00.025)       0:00:16.087 ******
2025-12-16 11:55:33.009874 | controller | ok: [instance] => changed=false
2025-12-16 11:55:33.179533 | controller |   msg: All assertions passed
2025-12-16 11:55:33.179561 | controller |
2025-12-16 11:55:33.179568 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-16 11:55:33.179575 | controller | Tuesday 16 December 2025  11:55:33 +0000 (0:00:00.023)       0:00:16.110 ******
2025-12-16 11:55:33.179584 | controller | ok: [instance]
2025-12-16 11:55:33.196143 | controller |
2025-12-16 11:55:33.196165 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-16 11:55:33.196174 | controller | Tuesday 16 December 2025  11:55:33 +0000 (0:00:00.169)       0:00:16.280 ******
2025-12-16 11:55:33.196184 | controller | ok: [instance]
2025-12-16 11:55:33.653984 | controller |
2025-12-16 11:55:33.654013 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-16 11:55:33.654021 | controller | Tuesday 16 December 2025  11:55:33 +0000 (0:00:00.016)       0:00:16.297 ******
2025-12-16 11:55:33.654031 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-12-16 11:55:33.699975 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-12-16 11:55:33.700001 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-12-16 11:55:33.700009 | controller |
2025-12-16 11:55:33.700016 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-16 11:55:33.700023 | controller | Tuesday 16 December 2025  11:55:33 +0000 (0:00:00.457)       0:00:16.754 ******
2025-12-16 11:55:33.700034 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-16 11:55:33.700059 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-16 11:55:33.700068 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-16 11:55:33.700324 | controller |
2025-12-16 11:55:33.876333 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-16 11:55:33.876360 | controller | Tuesday 16 December 2025  11:55:33 +0000 (0:00:00.046)       0:00:16.801 ******
2025-12-16 11:55:33.876371 | controller | ok: [instance]
2025-12-16 11:55:34.212973 | controller |
2025-12-16 11:55:34.213004 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-16 11:55:34.213013 | controller | Tuesday 16 December 2025  11:55:33 +0000 (0:00:00.176)       0:00:16.977 ******
2025-12-16 11:55:34.213028 | controller | ok: [instance]
2025-12-16 11:55:34.558981 | controller |
2025-12-16 11:55:34.559009 | controller | TASK [Copy generated values to correct location] *******************************
2025-12-16 11:55:34.559017 | controller | Tuesday 16 December 2025  11:55:34 +0000 (0:00:00.336)       0:00:17.313 ******
2025-12-16 11:55:34.559027 | controller | changed: [instance] => (item={'key': 'network-values', 'value': 'examples/va/hci/control-plane/networking/nncp/values.yaml'})
2025-12-16 11:55:34.559049 | controller | changed: [instance] => (item={'key': 'edpm-nodeset-values', 'value': 'examples/va/hci/edpm-pre-ceph/nodeset/values.yaml'})
2025-12-16 11:55:34.559058 | controller |
2025-12-16 11:55:34.559276 | controller | TASK [Ensure kustomize is able to build] ***************************************
2025-12-16 11:55:35.094206 | controller | Tuesday 16 December 2025  11:55:34 +0000 (0:00:00.346)       0:00:17.659 ******
2025-12-16 11:55:35.094247 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-12-16 11:55:35.094269 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-12-16 11:55:35.096008 | controller |
2025-12-16 11:55:35.096050 | controller | PLAY RECAP *********************************************************************
2025-12-16 11:55:35.096058 | controller | instance                   : ok=107  changed=20   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-12-16 11:55:35.096064 | controller |
2025-12-16 11:55:35.096070 | controller | Tuesday 16 December 2025  11:55:35 +0000 (0:00:00.535)       0:00:18.195 ******
2025-12-16 11:55:35.096075 | controller | ===============================================================================
2025-12-16 11:55:35.096080 | controller | Gathering Facts --------------------------------------------------------- 0.78s
2025-12-16 11:55:35.096085 | controller | Ensure architecture repository is building ------------------------------ 0.62s
2025-12-16 11:55:35.096090 | controller | Ensure kustomize is able to build --------------------------------------- 0.54s
2025-12-16 11:55:35.096095 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.52s
2025-12-16 11:55:35.096100 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.48s
2025-12-16 11:55:35.096105 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.47s
2025-12-16 11:55:35.096110 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.47s
2025-12-16 11:55:35.096115 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.46s
2025-12-16 11:55:35.096119 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.45s
2025-12-16 11:55:35.096124 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.38s
2025-12-16 11:55:35.096129 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.38s
2025-12-16 11:55:35.096134 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.36s
2025-12-16 11:55:35.096139 | controller | Create nova migration keypair ------------------------------------------- 0.35s
2025-12-16 11:55:35.096146 | controller | Copy generated values to correct location ------------------------------- 0.35s
2025-12-16 11:55:35.096164 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.34s
2025-12-16 11:55:35.096540 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.34s
2025-12-16 11:55:35.153439 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.33s
2025-12-16 11:55:35.153461 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.33s
2025-12-16 11:55:35.153468 | controller | Get generated files status ---------------------------------------------- 0.33s
2025-12-16 11:55:35.153474 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.33s
2025-12-16 11:55:35.153482 | controller | INFO     Running default > cleanup
2025-12-16 11:55:35.153955 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-12-16 11:55:35.154523 | controller | INFO     Writing /tmp/report.html report.
2025-12-16 11:55:35.635277 | controller | changed
2025-12-16 11:55:35.658909 | 
2025-12-16 11:55:35.658978 | PLAY RECAP
2025-12-16 11:55:35.659026 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-16 11:55:35.659058 | 
2025-12-16 11:55:35.722630 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-12-16 11:55:35.723429 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-16 11:55:36.239624 | 
2025-12-16 11:55:36.239745 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-12-16 11:55:36.258535 | 
2025-12-16 11:55:36.258603 | TASK [Filter out host if needed]
2025-12-16 11:55:36.266677 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-12-16 11:55:36.270843 | 
2025-12-16 11:55:36.270904 | TASK [Ensure file is present]
2025-12-16 11:55:36.576773 | controller | ok
2025-12-16 11:55:36.584066 | 
2025-12-16 11:55:36.584155 | TASK [Manage molecule report file]
2025-12-16 11:55:37.110091 | controller | changed
2025-12-16 11:55:37.115094 | 
2025-12-16 11:55:37.115155 | TASK [Check if we get ci-framework-data basedir]
2025-12-16 11:55:37.296315 | controller | ok
2025-12-16 11:55:37.301235 | 
2025-12-16 11:55:37.301297 | TASK [Create ci-framework-data log directory for zuul]
2025-12-16 11:55:37.604805 | controller | changed
2025-12-16 11:55:37.610078 | 
2025-12-16 11:55:37.610141 | TASK [Copy ci-framework interesting files]
2025-12-16 11:55:37.805567 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-12-16 11:55:38.136602 | controller | changed
2025-12-16 11:55:38.141474 | 
2025-12-16 11:55:38.141538 | TASK [Get SELinux listing]
2025-12-16 11:55:38.667254 | controller | changed
2025-12-16 11:55:38.673555 | 
2025-12-16 11:55:38.673625 | TASK [Generate log index]
2025-12-16 11:55:39.315483 | controller | changed
2025-12-16 11:55:39.320529 | 
2025-12-16 11:55:39.320596 | TASK [Get some env related data]
2025-12-16 11:55:39.859319 | controller | /home/zuul/.local/bin/ansible
2025-12-16 11:55:40.848977 | controller | changed
2025-12-16 11:55:40.854160 | 
2025-12-16 11:55:40.854228 | TASK [Generate list of logs to collect in home directory]
2025-12-16 11:55:41.146727 | controller | ok: All paths examined
2025-12-16 11:55:41.151735 | 
2025-12-16 11:55:41.151795 | LOOP [Copy logs from home directory]
2025-12-16 11:55:41.471583 | controller | changed:
2025-12-16 11:55:41.471732 | controller | {
2025-12-16 11:55:41.471762 | controller |   "atime": 1765885972.8413606,
2025-12-16 11:55:41.471784 | controller |   "ctime": 1765885988.5964446,
2025-12-16 11:55:41.471803 | controller |   "dev": 64513,
2025-12-16 11:55:41.471821 | controller |   "gid": 1000,
2025-12-16 11:55:41.471837 | controller |   "gr_name": "zuul",
2025-12-16 11:55:41.471854 | controller |   "inode": 4448969,
2025-12-16 11:55:41.471871 | controller |   "isblk": false,
2025-12-16 11:55:41.471886 | controller |   "ischr": false,
2025-12-16 11:55:41.471900 | controller |   "isdir": false,
2025-12-16 11:55:41.471914 | controller |   "isfifo": false,
2025-12-16 11:55:41.471929 | controller |   "isgid": false,
2025-12-16 11:55:41.471943 | controller |   "islnk": false,
2025-12-16 11:55:41.471957 | controller |   "isreg": true,
2025-12-16 11:55:41.471970 | controller |   "issock": false,
2025-12-16 11:55:41.471984 | controller |   "isuid": false,
2025-12-16 11:55:41.471998 | controller |   "mode": "0644",
2025-12-16 11:55:41.472013 | controller |   "mtime": 1765885988.5964446,
2025-12-16 11:55:41.472027 | controller |   "nlink": 1,
2025-12-16 11:55:41.472041 | controller |   "path": "/home/zuul/ansible.log",
2025-12-16 11:55:41.472057 | controller |   "pw_name": "zuul",
2025-12-16 11:55:41.472072 | controller |   "rgrp": true,
2025-12-16 11:55:41.472086 | controller |   "roth": true,
2025-12-16 11:55:41.472100 | controller |   "rusr": true,
2025-12-16 11:55:41.472114 | controller |   "size": 6749,
2025-12-16 11:55:41.472128 | controller |   "uid": 1000,
2025-12-16 11:55:41.472141 | controller |   "wgrp": false,
2025-12-16 11:55:41.472155 | controller |   "woth": false,
2025-12-16 11:55:41.472171 | controller |   "wusr": true,
2025-12-16 11:55:41.472185 | controller |   "xgrp": false,
2025-12-16 11:55:41.472198 | controller |   "xoth": false,
2025-12-16 11:55:41.472212 | controller |   "xusr": false
2025-12-16 11:55:41.472225 | controller | }
2025-12-16 11:55:41.485923 | 
2025-12-16 11:55:41.486038 | TASK [Copy crio stats log file]
2025-12-16 11:55:41.500830 | controller | skipping: Conditional result was False
2025-12-16 11:55:41.506810 | 
2025-12-16 11:55:41.506881 | TASK [Get SELinux related data]
2025-12-16 11:55:41.708149 | controller | <no matches>
2025-12-16 11:55:42.034178 | controller | ERROR
2025-12-16 11:55:42.034364 | controller | {
2025-12-16 11:55:42.034409 | controller |   "delta": "0:00:00.008728",
2025-12-16 11:55:42.034432 | controller |   "end": "2025-12-16 11:55:41.709000",
2025-12-16 11:55:42.034450 | controller |   "msg": "non-zero return code",
2025-12-16 11:55:42.034465 | controller |   "rc": 1,
2025-12-16 11:55:42.034481 | controller |   "start": "2025-12-16 11:55:41.700272"
2025-12-16 11:55:42.034495 | controller | }
2025-12-16 11:55:42.034516 | controller | ERROR: Ignoring Errors
2025-12-16 11:55:42.039638 | 
2025-12-16 11:55:42.039719 | TASK [Create system configuration directory]
2025-12-16 11:55:42.231519 | controller | changed
2025-12-16 11:55:42.239895 | 
2025-12-16 11:55:42.239969 | TASK [Get some of the system configurations]
2025-12-16 11:55:42.767264 | controller | changed
2025-12-16 11:55:42.772158 | 
2025-12-16 11:55:42.772221 | TASK [Copy generated documentation if available]
2025-12-16 11:55:42.796263 | controller | skipping: Conditional result was False
2025-12-16 11:55:42.801779 | 
2025-12-16 11:55:42.801841 | TASK [Copy generated AsciiDoc documentation if available]
2025-12-16 11:55:42.825452 | controller | skipping: Conditional result was False
2025-12-16 11:55:42.831530 | 
2025-12-16 11:55:42.831590 | TASK [Compress logs bigger than 2MB]
2025-12-16 11:55:43.357938 | controller | changed
2025-12-16 11:55:43.363226 | 
2025-12-16 11:55:43.363287 | TASK [Copy files from workspace on node]
2025-12-16 11:55:43.384232 | controller | ok
2025-12-16 11:55:43.407553 | 
2025-12-16 11:55:43.407629 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-16 11:55:43.432682 | controller | skipping: Conditional result was False
2025-12-16 11:55:43.438251 | 
2025-12-16 11:55:43.438323 | TASK [fetch-output : Set log path for single node]
2025-12-16 11:55:43.468181 | controller | ok
2025-12-16 11:55:43.473028 | 
2025-12-16 11:55:43.473094 | LOOP [fetch-output : Ensure local output dirs]
2025-12-16 11:55:43.699201 | controller -> localhost | ok: "/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/logs"
2025-12-16 11:55:43.699785 | controller -> localhost | changed: All items complete
2025-12-16 11:55:43.699840 | 
2025-12-16 11:55:43.890916 | controller -> localhost | changed: "/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/artifacts"
2025-12-16 11:55:44.082161 | controller -> localhost | changed: "/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/docs"
2025-12-16 11:55:44.093871 | 
2025-12-16 11:55:44.094020 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-16 11:55:44.665535 | controller | changed:
2025-12-16 11:55:44.666002 | controller | .d..t...... ./
2025-12-16 11:55:44.666056 | controller | >f+++++++++ README.html
2025-12-16 11:55:44.666080 | controller | >f+++++++++ ansible-execution.log
2025-12-16 11:55:44.666100 | controller | >f+++++++++ ansible.log
2025-12-16 11:55:44.666117 | controller | >f+++++++++ dmesg.log
2025-12-16 11:55:44.666132 | controller | >f+++++++++ installed-pkgs.log
2025-12-16 11:55:44.666151 | controller | >f+++++++++ python.log
2025-12-16 11:55:44.666172 | controller | >f+++++++++ registries.conf
2025-12-16 11:55:44.666187 | controller | >f+++++++++ report.html
2025-12-16 11:55:44.666204 | controller | >f+++++++++ selinux-denials.log
2025-12-16 11:55:44.666219 | controller | >f+++++++++ selinux-listing.log
2025-12-16 11:55:44.666234 | controller | cd+++++++++ ci-framework-data/
2025-12-16 11:55:44.666248 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-12-16 11:55:44.666263 | controller | >f+++++++++ ci-framework-data/artifacts/ctlplane.yaml
2025-12-16 11:55:44.666279 | controller | >f+++++++++ ci-framework-data/artifacts/dataplane.yaml
2025-12-16 11:55:44.666293 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key
2025-12-16 11:55:44.666307 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub
2025-12-16 11:55:44.666320 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-ctlplane.yaml
2025-12-16 11:55:44.666334 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-dataplane.yaml
2025-12-16 11:55:44.666348 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-12-16 11:55:44.666362 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/
2025-12-16 11:55:44.666375 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/
2025-12-16 11:55:44.666404 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-12-16 11:55:44.666423 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/
2025-12-16 11:55:44.666438 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-12-16 11:55:44.666453 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml.32317.2025-12-16@11:55:30~
2025-12-16 11:55:44.666468 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/
2025-12-16 11:55:44.666482 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/
2025-12-16 11:55:44.666495 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml
2025-12-16 11:55:44.666519 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml
2025-12-16 11:55:44.666534 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml
2025-12-16 11:55:44.666547 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml
2025-12-16 11:55:44.666560 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/
2025-12-16 11:55:44.666573 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml
2025-12-16 11:55:44.666586 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml
2025-12-16 11:55:44.666598 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml.32148.2025-12-16@11:55:28~
2025-12-16 11:55:44.666612 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml
2025-12-16 11:55:44.666626 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml
2025-12-16 11:55:44.666641 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2025-12-16 11:55:44.666686 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2025-12-16 11:55:44.666705 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2025-12-16 11:55:44.666720 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-12-16 11:55:44.666733 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-12-16 11:55:44.666747 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2025-12-16 11:55:44.666760 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2025-12-16 11:55:44.666773 | controller | cd+++++++++ ci-framework-data/logs/
2025-12-16 11:55:44.666786 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-12-16 11:55:44.666799 | controller | cd+++++++++ registries.conf.d/
2025-12-16 11:55:44.666812 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-12-16 11:55:44.666825 | controller | cd+++++++++ system-config/
2025-12-16 11:55:44.666837 | controller | cd+++++++++ system-config/libvirt/
2025-12-16 11:55:44.666850 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-12-16 11:55:44.666862 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-12-16 11:55:45.069485 | controller | changed: .d..t...... ./
2025-12-16 11:55:45.441579 | controller | changed: .d..t...... ./
2025-12-16 11:55:45.459153 | 
2025-12-16 11:55:45.459315 | TASK [Return artifact to Zuul]
2025-12-16 11:55:45.489336 | controller | ok
2025-12-16 11:55:45.509208 | 
2025-12-16 11:55:45.509279 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-12-16 11:55:45.509411 | 
2025-12-16 11:55:45.509441 | PLAY RECAP
2025-12-16 11:55:45.509486 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-12-16 11:55:45.509508 | 
2025-12-16 11:55:45.600320 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-16 11:55:45.601106 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-16 11:55:46.139970 | 
2025-12-16 11:55:46.140087 | PLAY [all]
2025-12-16 11:55:46.158735 | 
2025-12-16 11:55:46.158814 | TASK [include_role : fetch-output]
2025-12-16 11:55:46.188771 | controller | ok
2025-12-16 11:55:46.206375 | 
2025-12-16 11:55:46.206516 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-16 11:55:46.252296 | controller | skipping: Conditional result was False
2025-12-16 11:55:46.259456 | 
2025-12-16 11:55:46.259574 | TASK [fetch-output : Set log path for single node]
2025-12-16 11:55:46.301561 | controller | ok
2025-12-16 11:55:46.306692 | 
2025-12-16 11:55:46.306765 | LOOP [fetch-output : Ensure local output dirs]
2025-12-16 11:55:46.635468 | controller -> localhost | ok: "/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/logs"
2025-12-16 11:55:46.839843 | controller -> localhost | ok: "/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/artifacts"
2025-12-16 11:55:47.031094 | controller -> localhost | ok: "/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/docs"
2025-12-16 11:55:47.048601 | 
2025-12-16 11:55:47.048714 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-16 11:55:47.587606 | controller | ok
2025-12-16 11:55:47.587849 | controller | ok: All items complete
2025-12-16 11:55:47.587882 | 
2025-12-16 11:55:47.969140 | controller | ok
2025-12-16 11:55:48.344538 | controller | ok
2025-12-16 11:55:48.364946 | 
2025-12-16 11:55:48.365020 | TASK [include_role : fetch-output-openshift]
2025-12-16 11:55:48.382288 | controller | skipping: Conditional result was False
2025-12-16 11:55:48.388920 | 
2025-12-16 11:55:48.389022 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-12-16 11:55:48.768218 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008203
2025-12-16 11:55:48.963225 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009300
2025-12-16 11:55:48.996667 | 
2025-12-16 11:55:48.996786 | PLAY [all]
2025-12-16 11:55:49.009969 | 
2025-12-16 11:55:49.010043 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-12-16 11:55:49.416975 | controller | changed
2025-12-16 11:55:49.438767 | 
2025-12-16 11:55:49.438843 | PLAY RECAP
2025-12-16 11:55:49.438893 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-12-16 11:55:49.438917 | 
2025-12-16 11:55:49.511926 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-16 11:55:49.512762 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-12-16 11:55:50.047424 | 
2025-12-16 11:55:50.047545 | PLAY [localhost]
2025-12-16 11:55:50.064243 | 
2025-12-16 11:55:50.064321 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-12-16 11:55:50.366772 | localhost | changed
2025-12-16 11:55:50.371333 | 
2025-12-16 11:55:50.371436 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-12-16 11:55:50.399777 | localhost | ok
2025-12-16 11:55:50.407603 | 
2025-12-16 11:55:50.407714 | TASK [add-fileserver : Create SSH private key tempfile]
2025-12-16 11:55:50.709119 | localhost | changed
2025-12-16 11:55:50.714622 | 
2025-12-16 11:55:50.714717 | TASK [add-fileserver : Create SSH private key from secret]
2025-12-16 11:55:51.259673 | localhost | changed
2025-12-16 11:55:51.264538 | 
2025-12-16 11:55:51.264609 | TASK [add-fileserver : Add fileserver ssh key]
2025-12-16 11:55:51.620364 | localhost | Identity added: /var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/tmp/ansible.ydwpdz6r (/var/lib/zuul/builds/b9315f9ba18d4840b8f33ea60aa22d80/work/tmp/ansible.ydwpdz6r)
2025-12-16 11:55:51.620742 | localhost | ok: Runtime: 0:00:00.006768
2025-12-16 11:55:51.625915 | 
2025-12-16 11:55:51.625993 | TASK [add-fileserver : Remove SSH private key from disk]
2025-12-16 11:55:51.859780 | localhost | ok: Runtime: 0:00:00.004785
2025-12-16 11:55:51.865878 | 
2025-12-16 11:55:51.865997 | TASK [add-fileserver : Add fileserver to inventory]
2025-12-16 11:55:51.926262 | localhost | changed
2025-12-16 11:55:51.931560 | 
2025-12-16 11:55:51.931640 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-12-16 11:55:52.275672 | localhost | changed
2025-12-16 11:55:52.296550 | 
2025-12-16 11:55:52.296644 | PLAY [localhost]
2025-12-16 11:55:52.308713 | 
2025-12-16 11:55:52.308780 | TASK [Generate bulk log download script]
2025-12-16 11:55:52.328638 | localhost | ok
2025-12-16 11:55:52.340920 | 
2025-12-16 11:55:52.340995 | TASK [local-log-download : Check API endpoint is defined]
2025-12-16 11:55:52.368815 | localhost | ok: All assertions passed
2025-12-16 11:55:52.373201 | 
2025-12-16 11:55:52.373267 | TASK [local-log-download : Create download script]
2025-12-16 11:55:52.720832 | localhost -> localhost | changed
2025-12-16 11:55:52.730507 | 
2025-12-16 11:55:52.730626 | TASK [Register quick-download link]
2025-12-16 11:55:52.747714 | localhost | ok
2025-12-16 11:55:52.783682 | 
2025-12-16 11:55:52.783764 | PLAY [logserver.rdoproject.org]
2025-12-16 11:55:52.792912 | 
2025-12-16 11:55:52.792971 | TASK [Set zuul-log-path fact]
2025-12-16 11:55:52.808666 | logserver.rdoproject.org | ok
2025-12-16 11:55:52.817756 | 
2025-12-16 11:55:52.817825 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-16 11:55:52.844029 | logserver.rdoproject.org | ok
2025-12-16 11:55:52.849298 | 
2025-12-16 11:55:52.849361 | TASK [upload-logs : Create log directories]
2025-12-16 11:55:54.607087 | logserver.rdoproject.org | changed
2025-12-16 11:55:54.610524 | 
2025-12-16 11:55:54.610613 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-12-16 11:55:54.836857 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004562
2025-12-16 11:55:54.843158 | 
2025-12-16 11:55:54.843229 | TASK [upload-logs : Upload logs to log server]
2025-12-16 11:55:56.289047 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-12-16 11:55:56.291765 | 
2025-12-16 11:55:56.291838 | LOOP [upload-logs : Compress console log and json output]
2025-12-16 11:55:56.327977 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-16 11:55:56.335836 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-16 11:55:56.348949 | 
2025-12-16 11:55:56.349035 | LOOP [upload-logs : Upload compressed console log and json output]
2025-12-16 11:55:56.381754 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-16 11:55:56.381961 | 
2025-12-16 11:55:56.384959 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-16 11:55:56.395990 | 
2025-12-16 11:55:56.396082 | LOOP [upload-logs : Upload console log and json output]