2025-10-08 17:30:50.556820 | Job console starting...
2025-10-08 17:30:50.794899 | Updating repositories
2025-10-08 17:30:51.502969 | Preparing job workspace
2025-10-08 17:30:58.511252 | Running Ansible setup...
2025-10-08 17:31:01.287141 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-08 17:31:01.763133 | 
2025-10-08 17:31:01.763223 | PLAY [localhost]
2025-10-08 17:31:01.771142 | 
2025-10-08 17:31:01.771208 | TASK [Gathering Facts]
2025-10-08 17:31:02.526813 | localhost | ok
2025-10-08 17:31:02.539000 | 
2025-10-08 17:31:02.539080 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-08 17:31:02.836295 | localhost -> localhost | changed
2025-10-08 17:31:02.840960 | 
2025-10-08 17:31:02.841026 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-08 17:31:03.471346 | localhost -> localhost | changed
2025-10-08 17:31:03.479194 | 
2025-10-08 17:31:03.479280 | TASK [Setup log path fact]
2025-10-08 17:31:03.496093 | localhost | ok
2025-10-08 17:31:03.506292 | 
2025-10-08 17:31:03.506378 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-08 17:31:03.523409 | localhost | ok
2025-10-08 17:31:03.530196 | 
2025-10-08 17:31:03.530260 | TASK [emit-job-header : Print job information]
2025-10-08 17:31:03.556883 | # Job Information
2025-10-08 17:31:03.557006 | Ansible Version: 2.15.12
2025-10-08 17:31:03.557035 | Job: cifmw-molecule-ci_gen_kustomize_values
2025-10-08 17:31:03.557055 | Pipeline: github-check
2025-10-08 17:31:03.557073 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-08 17:31:03.557088 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3369
2025-10-08 17:31:03.557104 | Log URL (when completed): https://logserver.rdoproject.org/09d/rdoproject.org/09d40907f76144ebba846d3c31117df7/
2025-10-08 17:31:03.557120 | Event ID: 6645d080-a46c-11f0-80d4-c6e31abe9958
2025-10-08 17:31:03.560443 | 
2025-10-08 17:31:03.560514 | LOOP [emit-job-header : Print node information]
2025-10-08 17:31:03.639283 | localhost | ok:
2025-10-08 17:31:03.639424 | localhost | # Node Information
2025-10-08 17:31:03.639462 | localhost | Inventory Hostname: controller
2025-10-08 17:31:03.639489 | localhost | Hostname: np0005477522
2025-10-08 17:31:03.639511 | localhost | Username: zuul
2025-10-08 17:31:03.639532 | localhost | Distro: CentOS 9
2025-10-08 17:31:03.639552 | localhost | Provider: ibm-bm4-nodepool
2025-10-08 17:31:03.639570 | localhost | Region: regionOne
2025-10-08 17:31:03.639588 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-08 17:31:03.639605 | localhost | Product Name: OpenStack Compute
2025-10-08 17:31:03.639623 | localhost | Interface IP: 192.168.26.220
2025-10-08 17:31:03.662666 | 
2025-10-08 17:31:03.662729 | PLAY [all]
2025-10-08 17:31:03.668225 | 
2025-10-08 17:31:03.668280 | TASK [Gather network facts]
2025-10-08 17:31:04.031441 | controller | ok
2025-10-08 17:31:04.044797 | 
2025-10-08 17:31:04.044859 | TASK [include_role : start-zuul-console]
2025-10-08 17:31:04.061786 | controller | ok
2025-10-08 17:31:04.072478 | 
2025-10-08 17:31:04.072535 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-08 17:31:04.353256 | controller | ok
2025-10-08 17:31:04.360957 | 
2025-10-08 17:31:04.361017 | TASK [include_role : add-build-sshkey]
2025-10-08 17:31:04.378174 | controller | ok
2025-10-08 17:31:04.389321 | 
2025-10-08 17:31:04.389377 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-08 17:31:04.564565 | controller -> localhost | ok
2025-10-08 17:31:04.569770 | 
2025-10-08 17:31:04.569833 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-08 17:31:04.587217 | controller | ok
2025-10-08 17:31:04.599520 | controller | included: /var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-08 17:31:04.604754 | 
2025-10-08 17:31:04.604810 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-08 17:31:05.022200 | controller -> localhost | Generating public/private rsa key pair.
2025-10-08 17:31:05.022409 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/09d40907f76144ebba846d3c31117df7_id_rsa.
2025-10-08 17:31:05.022444 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/09d40907f76144ebba846d3c31117df7_id_rsa.pub.
2025-10-08 17:31:05.022476 | controller -> localhost | The key fingerprint is:
2025-10-08 17:31:05.022497 | controller -> localhost | SHA256:8AZPr3Kt8hgUXlr3j5kkeAQcIWLsfe/Tjqlity9ohfk zuul-build-sshkey
2025-10-08 17:31:05.022516 | controller -> localhost | The key's randomart image is:
2025-10-08 17:31:05.022534 | controller -> localhost | +---[RSA 3072]----+
2025-10-08 17:31:05.022551 | controller -> localhost | |   .o ..+o       |
2025-10-08 17:31:05.022569 | controller -> localhost | |   ... ...       |
2025-10-08 17:31:05.022587 | controller -> localhost | |   . .+ + o      |
2025-10-08 17:31:05.022603 | controller -> localhost | |    ...@.= .     |
2025-10-08 17:31:05.022619 | controller -> localhost | |      ++S.+ o    |
2025-10-08 17:31:05.022636 | controller -> localhost | |     .o..+.o =   |
2025-10-08 17:31:05.022651 | controller -> localhost | |      o+o...+ .  |
2025-10-08 17:31:05.022667 | controller -> localhost | |      *=E.oo.    |
2025-10-08 17:31:05.022683 | controller -> localhost | |     o.===+o.    |
2025-10-08 17:31:05.022698 | controller -> localhost | +----[SHA256]-----+
2025-10-08 17:31:05.022745 | controller -> localhost | ok: Runtime: 0:00:00.118654
2025-10-08 17:31:05.028148 | 
2025-10-08 17:31:05.028211 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-08 17:31:05.046302 | controller | ok
2025-10-08 17:31:05.055110 | controller | included: /var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-08 17:31:05.062248 | 
2025-10-08 17:31:05.062307 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-08 17:31:05.076140 | controller | skipping: Conditional result was False
2025-10-08 17:31:05.081158 | 
2025-10-08 17:31:05.081215 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-08 17:31:05.423260 | controller | changed
2025-10-08 17:31:05.428512 | 
2025-10-08 17:31:05.428573 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-08 17:31:05.619318 | controller | ok
2025-10-08 17:31:05.623624 | 
2025-10-08 17:31:05.623683 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-08 17:31:06.180643 | controller | changed
2025-10-08 17:31:06.184877 | 
2025-10-08 17:31:06.184957 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-08 17:31:06.761610 | controller | changed
2025-10-08 17:31:06.765878 | 
2025-10-08 17:31:06.765950 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-08 17:31:06.779057 | controller | skipping: Conditional result was False
2025-10-08 17:31:06.783713 | 
2025-10-08 17:31:06.783773 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-08 17:31:07.061625 | controller -> localhost | changed
2025-10-08 17:31:07.070005 | 
2025-10-08 17:31:07.070066 | TASK [add-build-sshkey : Add back temp key]
2025-10-08 17:31:07.275959 | controller -> localhost | Identity added: /var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/09d40907f76144ebba846d3c31117df7_id_rsa (zuul-build-sshkey)
2025-10-08 17:31:07.276107 | controller -> localhost | ok: Runtime: 0:00:00.006502
2025-10-08 17:31:07.280967 | 
2025-10-08 17:31:07.281024 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-08 17:31:07.563661 | controller | ok
2025-10-08 17:31:07.567719 | 
2025-10-08 17:31:07.567778 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-08 17:31:07.591682 | controller | skipping: Conditional result was False
2025-10-08 17:31:07.600055 | 
2025-10-08 17:31:07.600124 | TASK [include_role : validate-host]
2025-10-08 17:31:07.617770 | controller | ok
2025-10-08 17:31:07.635411 | 
2025-10-08 17:31:07.635481 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-08 17:31:07.663327 | controller | ok
2025-10-08 17:31:07.667376 | 
2025-10-08 17:31:07.667435 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-08 17:31:07.852785 | controller -> localhost | ok
2025-10-08 17:31:07.858015 | 
2025-10-08 17:31:07.858073 | TASK [validate-host : Collect information about the host]
2025-10-08 17:31:08.466086 | controller | ok
2025-10-08 17:31:08.473203 | 
2025-10-08 17:31:08.473266 | TASK [validate-host : Sanitize hostname]
2025-10-08 17:31:08.531148 | controller | ok
2025-10-08 17:31:08.535401 | 
2025-10-08 17:31:08.535469 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-08 17:31:08.894406 | controller -> localhost | changed
2025-10-08 17:31:08.918572 | 
2025-10-08 17:31:08.918656 | TASK [validate-host : Collect information about zuul worker]
2025-10-08 17:31:09.220839 | controller | ok
2025-10-08 17:31:09.226339 | 
2025-10-08 17:31:09.226403 | TASK [validate-host : Write out all zuul information for each host]
2025-10-08 17:31:09.554024 | controller -> localhost | changed
2025-10-08 17:31:09.562623 | 
2025-10-08 17:31:09.562686 | TASK [include_role : prepare-workspace-openshift]
2025-10-08 17:31:09.576262 | controller | skipping: Conditional result was False
2025-10-08 17:31:09.580874 | 
2025-10-08 17:31:09.580953 | TASK [include_role : remove-zuul-sshkey]
2025-10-08 17:31:09.594252 | controller | skipping: Conditional result was False
2025-10-08 17:31:09.599204 | 
2025-10-08 17:31:09.599266 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-08 17:31:09.788093 | controller | ok: "logs"
2025-10-08 17:31:09.788327 | controller | ok: All items complete
2025-10-08 17:31:09.788356 | 
2025-10-08 17:31:09.944930 | controller | ok: "artifacts"
2025-10-08 17:31:10.097974 | controller | ok: "docs"
2025-10-08 17:31:10.104477 | 
2025-10-08 17:31:10.104563 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-08 17:31:10.293352 | controller | changed: "logs"
2025-10-08 17:31:10.454013 | controller | changed: "artifacts"
2025-10-08 17:31:10.616129 | controller | changed: "docs"
2025-10-08 17:31:10.636473 | 
2025-10-08 17:31:10.636541 | PLAY RECAP
2025-10-08 17:31:10.636582 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-08 17:31:10.636608 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-08 17:31:10.636626 | 
2025-10-08 17:31:10.708824 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-08 17:31:10.709499 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-08 17:31:11.196781 | 
2025-10-08 17:31:11.196933 | PLAY [all]
2025-10-08 17:31:11.214409 | 
2025-10-08 17:31:11.214486 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-08 17:31:11.263300 | controller | ok
2025-10-08 17:31:11.267733 | 
2025-10-08 17:31:11.267806 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-08 17:31:11.601040 | controller | changed
2025-10-08 17:31:11.605787 | 
2025-10-08 17:31:11.605854 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-08 17:31:12.373343 | controller | changed
2025-10-08 17:31:12.382000 | 
2025-10-08 17:31:12.382069 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-08 17:31:12.714887 | controller | changed:
2025-10-08 17:31:12.715074 | controller | {
2025-10-08 17:31:12.715102 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-08 17:31:12.715129 | controller | }
2025-10-08 17:31:12.922554 | controller | changed:
2025-10-08 17:31:12.922606 | controller | {
2025-10-08 17:31:12.922634 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-08 17:31:12.922656 | controller | }
2025-10-08 17:31:13.143818 | controller | changed:
2025-10-08 17:31:13.143865 | controller | {
2025-10-08 17:31:13.143889 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-08 17:31:13.143922 | controller | }
2025-10-08 17:31:13.344283 | controller | changed:
2025-10-08 17:31:13.344332 | controller | {
2025-10-08 17:31:13.344357 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-08 17:31:13.344375 | controller | }
2025-10-08 17:31:13.540115 | controller | changed:
2025-10-08 17:31:13.540162 | controller | {
2025-10-08 17:31:13.540185 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-08 17:31:13.540203 | controller | }
2025-10-08 17:31:13.745056 | controller | changed:
2025-10-08 17:31:13.745120 | controller | {
2025-10-08 17:31:13.745147 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-08 17:31:13.745168 | controller | }
2025-10-08 17:31:13.943204 | controller | changed:
2025-10-08 17:31:13.943255 | controller | {
2025-10-08 17:31:13.943280 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-10-08 17:31:13.943299 | controller | }
2025-10-08 17:31:14.141226 | controller | changed:
2025-10-08 17:31:14.141275 | controller | {
2025-10-08 17:31:14.141301 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-10-08 17:31:14.141320 | controller | }
2025-10-08 17:31:14.343148 | controller | changed:
2025-10-08 17:31:14.343203 | controller | {
2025-10-08 17:31:14.343228 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-08 17:31:14.343247 | controller | }
2025-10-08 17:31:14.536387 | controller | changed:
2025-10-08 17:31:14.536433 | controller | {
2025-10-08 17:31:14.536468 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-08 17:31:14.536488 | controller | }
2025-10-08 17:31:14.743099 | controller | changed:
2025-10-08 17:31:14.743154 | controller | {
2025-10-08 17:31:14.743180 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-08 17:31:14.743200 | controller | }
2025-10-08 17:31:14.961599 | controller | changed:
2025-10-08 17:31:14.961670 | controller | {
2025-10-08 17:31:14.961696 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-08 17:31:14.961716 | controller | }
2025-10-08 17:31:15.150466 | controller | changed:
2025-10-08 17:31:15.150515 | controller | {
2025-10-08 17:31:15.150539 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-08 17:31:15.150557 | controller | }
2025-10-08 17:31:15.358712 | controller | changed:
2025-10-08 17:31:15.358793 | controller | {
2025-10-08 17:31:15.358819 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-08 17:31:15.358839 | controller | }
2025-10-08 17:31:15.557401 | controller | changed:
2025-10-08 17:31:15.557513 | controller | {
2025-10-08 17:31:15.557541 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-08 17:31:15.557562 | controller | }
2025-10-08 17:31:15.757887 | controller | changed:
2025-10-08 17:31:15.757966 | controller | {
2025-10-08 17:31:15.757993 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-08 17:31:15.758012 | controller | }
2025-10-08 17:31:15.967831 | controller | changed:
2025-10-08 17:31:15.967885 | controller | {
2025-10-08 17:31:15.967928 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-10-08 17:31:15.967956 | controller | }
2025-10-08 17:31:16.165448 | controller | changed:
2025-10-08 17:31:16.165528 | controller | {
2025-10-08 17:31:16.165557 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-10-08 17:31:16.165586 | controller | }
2025-10-08 17:31:16.377929 | controller | changed:
2025-10-08 17:31:16.377989 | controller | {
2025-10-08 17:31:16.378014 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-08 17:31:16.378033 | controller | }
2025-10-08 17:31:16.586397 | controller | changed:
2025-10-08 17:31:16.586446 | controller | {
2025-10-08 17:31:16.586488 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-08 17:31:16.586509 | controller | }
2025-10-08 17:31:16.794538 | controller | changed:
2025-10-08 17:31:16.794598 | controller | {
2025-10-08 17:31:16.794623 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-08 17:31:16.794641 | controller | }
2025-10-08 17:31:16.998815 | controller | changed:
2025-10-08 17:31:16.998900 | controller | {
2025-10-08 17:31:16.998945 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-08 17:31:16.998967 | controller | }
2025-10-08 17:31:17.201206 | controller | changed:
2025-10-08 17:31:17.201253 | controller | {
2025-10-08 17:31:17.201278 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-10-08 17:31:17.201297 | controller | }
2025-10-08 17:31:17.403591 | controller | changed:
2025-10-08 17:31:17.403638 | controller | {
2025-10-08 17:31:17.403662 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-08 17:31:17.403680 | controller | }
2025-10-08 17:31:17.606096 | controller | changed:
2025-10-08 17:31:17.606142 | controller | {
2025-10-08 17:31:17.606166 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-08 17:31:17.606184 | controller | }
2025-10-08 17:31:17.806732 | controller | changed:
2025-10-08 17:31:17.806892 | controller | {
2025-10-08 17:31:17.806940 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-08 17:31:17.806964 | controller | }
2025-10-08 17:31:17.830709 | 
2025-10-08 17:31:17.830796 | TASK [Set timezone to UTC]
2025-10-08 17:31:18.225289 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-08 17:31:18.229477 | 
2025-10-08 17:31:18.229538 | TASK [Create nodepool directory]
2025-10-08 17:31:18.440599 | controller | changed
2025-10-08 17:31:18.445344 | 
2025-10-08 17:31:18.445404 | TASK [Create nodepool sub_nodes file]
2025-10-08 17:31:18.970510 | controller | changed
2025-10-08 17:31:18.974744 | 
2025-10-08 17:31:18.974804 | TASK [Create nodepool sub_nodes_private file]
2025-10-08 17:31:19.489632 | controller | changed
2025-10-08 17:31:19.494507 | 
2025-10-08 17:31:19.494565 | LOOP [Populate nodepool sub_nodes file]
2025-10-08 17:31:19.523410 | 
2025-10-08 17:31:19.523535 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-08 17:31:19.551938 | 
2025-10-08 17:31:19.552056 | TASK [Create nodepool primary file]
2025-10-08 17:31:19.575755 | controller | skipping: Conditional result was False
2025-10-08 17:31:19.580718 | 
2025-10-08 17:31:19.580783 | TASK [Create nodepool node_private for this node]
2025-10-08 17:31:20.126317 | controller | changed
2025-10-08 17:31:20.131384 | 
2025-10-08 17:31:20.131449 | LOOP [Copy ssh keys to nodepool directory]
2025-10-08 17:31:20.436568 | controller | ok: Item: id_rsa Runtime: 0:00:00.007125
2025-10-08 17:31:20.436734 | 
2025-10-08 17:31:20.598010 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004212
2025-10-08 17:31:20.610410 | 
2025-10-08 17:31:20.610495 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-08 17:31:21.157613 | controller | changed
2025-10-08 17:31:21.161988 | 
2025-10-08 17:31:21.162045 | TASK [Validate sudoers config after edits]
2025-10-08 17:31:21.372499 | controller | /etc/sudoers: parsed OK
2025-10-08 17:31:21.372563 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-08 17:31:21.372572 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-08 17:31:21.372578 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-08 17:31:21.685844 | controller | ok: Runtime: 0:00:00.006531
2025-10-08 17:31:21.690816 | 
2025-10-08 17:31:21.690874 | TASK [Show the environment passed in to job shell scripts]
2025-10-08 17:31:21.890019 | controller | SHELL=/bin/bash
2025-10-08 17:31:21.890142 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-08 17:31:21.890155 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-08 17:31:21.890162 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/69/3369/1b4939c72ce43a26f0aacb0573344a5c23dbb1a1
2025-10-08 17:31:21.890177 | controller | PWD=/home/zuul
2025-10-08 17:31:21.890183 | controller | ZUUL_PIPELINE=github-check
2025-10-08 17:31:21.890189 | controller | LOGNAME=zuul
2025-10-08 17:31:21.890194 | controller | XDG_SESSION_TYPE=tty
2025-10-08 17:31:21.890199 | controller | _=/usr/bin/env
2025-10-08 17:31:21.890204 | controller | MOTD_SHOWN=pam
2025-10-08 17:31:21.890209 | controller | HOME=/home/zuul
2025-10-08 17:31:21.890214 | controller | LANG=en_US.UTF-8
2025-10-08 17:31:21.890219 | controller | SSH_CONNECTION=192.168.26.12 56714 192.168.26.220 22
2025-10-08 17:31:21.890225 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-10-08 17:31:21.890235 | controller | ZUUL_CHANGE_IDS=3369,1b4939c72ce43a26f0aacb0573344a5c23dbb1a1
2025-10-08 17:31:21.890240 | controller | WORKSPACE=/home/zuul/workspace
2025-10-08 17:31:21.890245 | controller | XDG_SESSION_CLASS=user
2025-10-08 17:31:21.890251 | controller | SELINUX_ROLE_REQUESTED=
2025-10-08 17:31:21.890256 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-08 17:31:21.890261 | controller | USER=zuul
2025-10-08 17:31:21.890266 | controller | ZUUL_VOTING=True
2025-10-08 17:31:21.890271 | controller | BUILD_TIMEOUT=1800000
2025-10-08 17:31:21.890276 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-08 17:31:21.890280 | controller | SHLVL=1
2025-10-08 17:31:21.890286 | controller | ZUUL_PATCHSET=1b4939c72ce43a26f0aacb0573344a5c23dbb1a1
2025-10-08 17:31:21.890291 | controller | XDG_SESSION_ID=1
2025-10-08 17:31:21.890296 | controller | ZUUL_BRANCH=main
2025-10-08 17:31:21.890301 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-08 17:31:21.890305 | controller | SSH_CLIENT=192.168.26.12 56714 22
2025-10-08 17:31:21.890311 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-08 17:31:21.890316 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-08 17:31:21.890321 | controller | which_declare=declare -f
2025-10-08 17:31:21.890328 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-08 17:31:21.890333 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-08 17:31:21.890339 | controller | ZUUL_CHANGE=3369
2025-10-08 17:31:21.890343 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-08 17:31:21.890348 | controller | ZUUL_UUID=09d40907f76144ebba846d3c31117df7
2025-10-08 17:31:21.890355 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-08 17:31:21.890361 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-08 17:31:21.890366 | controller | }
2025-10-08 17:31:22.216089 | controller | ok: Runtime: 0:00:00.007256
2025-10-08 17:31:22.220692 | 
2025-10-08 17:31:22.220753 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-08 17:31:22.234270 | controller | skipping: Conditional result was False
2025-10-08 17:31:22.239227 | 
2025-10-08 17:31:22.239283 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-08 17:31:22.762201 | controller | skipping: Conditional result was False
2025-10-08 17:31:22.767090 | 
2025-10-08 17:31:22.767149 | TASK [Ensure legacy workspace directory]
2025-10-08 17:31:22.947313 | controller | changed
2025-10-08 17:31:22.963049 | 
2025-10-08 17:31:22.963099 | PLAY RECAP
2025-10-08 17:31:22.963139 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-08 17:31:22.963160 | 
2025-10-08 17:31:23.031563 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-08 17:31:23.032390 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-08 17:31:23.499118 | 
2025-10-08 17:31:23.499239 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-08 17:31:23.518436 | 
2025-10-08 17:31:23.518509 | TASK [Create zuul-output directory]
2025-10-08 17:31:23.820769 | controller | changed
2025-10-08 17:31:23.825194 | 
2025-10-08 17:31:23.825264 | TASK [Slurp Zuul inventory test]
2025-10-08 17:31:24.071730 | controller -> localhost | ok
2025-10-08 17:31:24.077463 | 
2025-10-08 17:31:24.077527 | TASK [Save zuul inventory]
2025-10-08 17:31:24.805901 | controller | changed
2025-10-08 17:31:24.810266 | 
2025-10-08 17:31:24.810328 | TASK [Save zuul vars without the change_message]
2025-10-08 17:31:25.388746 | controller | changed
2025-10-08 17:31:25.404579 | 
2025-10-08 17:31:25.404627 | PLAY RECAP
2025-10-08 17:31:25.404668 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-08 17:31:25.404689 | 
2025-10-08 17:31:25.467240 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-08 17:31:25.468047 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-08 17:31:25.962508 | 
2025-10-08 17:31:25.962601 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-08 17:31:25.981016 | 
2025-10-08 17:31:25.981086 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-08 17:31:25.999312 | controller | ok
2025-10-08 17:31:26.015023 | 
2025-10-08 17:31:26.015104 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-08 17:31:26.039618 | controller | skipping: Conditional result was False
2025-10-08 17:31:26.045095 | 
2025-10-08 17:31:26.045163 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-08 17:31:26.347689 | controller | ok
2025-10-08 17:31:26.352530 | 
2025-10-08 17:31:26.352596 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-08 17:31:26.971090 | controller | ok
2025-10-08 17:31:26.980700 | 
2025-10-08 17:31:26.980763 | TASK [Prepare workspace]
2025-10-08 17:31:26.999055 | controller | ok
2025-10-08 17:31:27.014863 | 
2025-10-08 17:31:27.014950 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-08 17:31:27.317855 | controller | ok
2025-10-08 17:31:27.323546 | 
2025-10-08 17:31:27.323624 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-08 17:31:29.707286 | controller | Output suppressed because no_log was given
2025-10-08 17:31:29.716031 | 
2025-10-08 17:31:29.716098 | LOOP [Create zuul-output directory]
2025-10-08 17:31:29.909549 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-08 17:31:30.083654 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-08 17:31:30.089040 | 
2025-10-08 17:31:30.089096 | TASK [Install required packages]
2025-10-08 17:32:19.164324 | controller | changed
2025-10-08 17:32:19.169273 | 
2025-10-08 17:32:19.169336 | TASK [Install venv]
2025-10-08 17:33:22.255185 | controller | changed
2025-10-08 17:33:22.278320 | 
2025-10-08 17:33:22.278413 | PLAY RECAP
2025-10-08 17:33:22.278455 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-08 17:33:22.278477 | 
2025-10-08 17:33:22.347650 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-08 17:33:22.348548 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-08 17:33:22.818394 | 
2025-10-08 17:33:22.818481 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-08 17:33:22.836933 | 
2025-10-08 17:33:22.837002 | TASK [Gather required facts]
2025-10-08 17:33:23.281785 | controller | ok
2025-10-08 17:33:23.286558 | 
2025-10-08 17:33:23.286634 | TASK [Load environment var if instructed to]
2025-10-08 17:33:23.310252 | controller | skipping: Conditional result was False
2025-10-08 17:33:23.315149 | 
2025-10-08 17:33:23.315211 | TASK [Run molecule]
2025-10-08 17:33:24.175018 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-08 17:33:24.239350 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-08 17:33:41.322986 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.323411 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.323896 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.324344 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.324835 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+1b4939c7 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0+1b4939c7 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.325281 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.325737 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.326180 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.326660 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.327105 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.327568 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.328003 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.328437 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.328891 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.329327 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 17:33:41.338750 | controller | INFO     Running default > prepare
2025-10-08 17:33:42.051577 | controller |
2025-10-08 17:33:42.051676 | controller | PLAY [Prepare] *****************************************************************
2025-10-08 17:33:42.051786 | controller |
2025-10-08 17:33:42.051885 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 17:33:42.051981 | controller | Wednesday 08 October 2025  17:33:42 +0000 (0:00:00.017)       0:00:00.017 *****
2025-10-08 17:33:42.908837 | controller | ok: [instance]
2025-10-08 17:33:42.908898 | controller |
2025-10-08 17:33:42.909005 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2025-10-08 17:33:42.909110 | controller | Wednesday 08 October 2025  17:33:42 +0000 (0:00:00.857)       0:00:00.875 *****
2025-10-08 17:33:42.927068 | controller | skipping: [instance]
2025-10-08 17:33:42.927151 | controller |
2025-10-08 17:33:42.927250 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2025-10-08 17:33:42.927353 | controller | Wednesday 08 October 2025  17:33:42 +0000 (0:00:00.018)       0:00:00.894 *****
2025-10-08 17:33:42.957290 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2025-10-08 17:33:42.957375 | controller |
2025-10-08 17:33:42.957475 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2025-10-08 17:33:42.957611 | controller | Wednesday 08 October 2025  17:33:42 +0000 (0:00:00.030)       0:00:00.924 *****
2025-10-08 17:33:43.232862 | controller | ok: [instance]
2025-10-08 17:33:43.232929 | controller |
2025-10-08 17:33:43.233031 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2025-10-08 17:33:43.233133 | controller | Wednesday 08 October 2025  17:33:43 +0000 (0:00:00.275)       0:00:01.199 *****
2025-10-08 17:33:43.532549 | controller | ok: [instance]
2025-10-08 17:33:43.532639 | controller |
2025-10-08 17:33:43.532737 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2025-10-08 17:33:43.532838 | controller | Wednesday 08 October 2025  17:33:43 +0000 (0:00:00.299)       0:00:01.499 *****
2025-10-08 17:33:44.231453 | controller | ok: [instance] => (item=ubi-9-appstream)
2025-10-08 17:33:44.231565 | controller | ok: [instance] => (item=ubi-9-baseos)
2025-10-08 17:33:44.231716 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2025-10-08 17:33:44.231826 | controller |
2025-10-08 17:33:44.231943 | controller | TASK [Deploy repo-setup] *******************************************************
2025-10-08 17:33:44.232090 | controller | Wednesday 08 October 2025  17:33:44 +0000 (0:00:00.698)       0:00:02.197 *****
2025-10-08 17:33:44.288701 | controller |
2025-10-08 17:33:44.289056 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-10-08 17:33:44.793140 | controller | Wednesday 08 October 2025  17:33:44 +0000 (0:00:00.057)       0:00:02.255 *****
2025-10-08 17:33:44.793192 | controller | changed: [instance] => (item=tmp)
2025-10-08 17:33:45.574095 | controller | changed: [instance] => (item=artifacts/repositories)
2025-10-08 17:33:45.574129 | controller | changed: [instance] => (item=venv/repo_setup)
2025-10-08 17:33:45.574138 | controller |
2025-10-08 17:33:45.574144 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-10-08 17:33:45.574150 | controller | Wednesday 08 October 2025  17:33:44 +0000 (0:00:00.503)       0:00:02.759 *****
2025-10-08 17:33:45.574160 | controller | ok: [instance]
2025-10-08 17:33:46.745008 | controller |
2025-10-08 17:33:46.745042 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-10-08 17:33:46.745050 | controller | Wednesday 08 October 2025  17:33:45 +0000 (0:00:00.781)       0:00:03.540 *****
2025-10-08 17:33:46.745060 | controller | changed: [instance]
2025-10-08 17:33:54.259284 | controller |
2025-10-08 17:33:54.259329 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-10-08 17:33:54.259341 | controller | Wednesday 08 October 2025  17:33:46 +0000 (0:00:01.170)       0:00:04.711 *****
2025-10-08 17:33:54.259353 | controller | changed: [instance]
2025-10-08 17:33:54.938769 | controller |
2025-10-08 17:33:54.938807 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-10-08 17:33:54.938815 | controller | Wednesday 08 October 2025  17:33:54 +0000 (0:00:07.513)       0:00:12.225 *****
2025-10-08 17:33:54.938826 | controller | changed: [instance]
2025-10-08 17:33:54.961481 | controller |
2025-10-08 17:33:54.961521 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-10-08 17:33:54.961534 | controller | Wednesday 08 October 2025  17:33:54 +0000 (0:00:00.679)       0:00:12.905 *****
2025-10-08 17:33:54.961545 | controller | skipping: [instance]
2025-10-08 17:33:55.771023 | controller |
2025-10-08 17:33:55.771049 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-10-08 17:33:55.771057 | controller | Wednesday 08 October 2025  17:33:54 +0000 (0:00:00.023)       0:00:12.928 *****
2025-10-08 17:33:55.771067 | controller | changed: [instance]
2025-10-08 17:33:55.800183 | controller |
2025-10-08 17:33:55.800207 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-10-08 17:33:55.800217 | controller | Wednesday 08 October 2025  17:33:55 +0000 (0:00:00.809)       0:00:13.737 *****
2025-10-08 17:33:55.800229 | controller | skipping: [instance]
2025-10-08 17:33:55.827367 | controller |
2025-10-08 17:33:55.827387 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-10-08 17:33:55.827395 | controller | Wednesday 08 October 2025  17:33:55 +0000 (0:00:00.029)       0:00:13.766 *****
2025-10-08 17:33:55.827405 | controller | skipping: [instance]
2025-10-08 17:33:55.854168 | controller |
2025-10-08 17:33:55.854184 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-10-08 17:33:55.854191 | controller | Wednesday 08 October 2025  17:33:55 +0000 (0:00:00.026)       0:00:13.793 *****
2025-10-08 17:33:55.854199 | controller | skipping: [instance]
2025-10-08 17:33:56.401537 | controller |
2025-10-08 17:33:56.401571 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-10-08 17:33:56.401579 | controller | Wednesday 08 October 2025  17:33:55 +0000 (0:00:00.027)       0:00:13.821 *****
2025-10-08 17:33:56.401591 | controller | changed: [instance]
2025-10-08 17:33:56.821304 | controller |
2025-10-08 17:33:56.821336 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-10-08 17:33:56.821344 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.546)       0:00:14.368 *****
2025-10-08 17:33:56.821355 | controller | changed: [instance]
2025-10-08 17:33:56.841108 | controller |
2025-10-08 17:33:56.841144 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-10-08 17:33:56.841154 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.419)       0:00:14.787 *****
2025-10-08 17:33:56.841164 | controller | skipping: [instance]
2025-10-08 17:33:56.859470 | controller |
2025-10-08 17:33:56.859485 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-10-08 17:33:56.859491 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.020)       0:00:14.807 *****
2025-10-08 17:33:56.859516 | controller | skipping: [instance]
2025-10-08 17:33:56.877873 | controller |
2025-10-08 17:33:56.877891 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-10-08 17:33:56.877899 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.018)       0:00:14.826 *****
2025-10-08 17:33:56.877909 | controller | skipping: [instance]
2025-10-08 17:33:56.906579 | controller |
2025-10-08 17:33:56.906594 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-10-08 17:33:56.906600 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.018)       0:00:14.844 *****
2025-10-08 17:33:56.906608 | controller | ok: [instance]
2025-10-08 17:33:56.941020 | controller |
2025-10-08 17:33:56.941043 | controller | TASK [repo_setup : Create download directory] **********************************
2025-10-08 17:33:56.941050 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.028)       0:00:14.873 *****
2025-10-08 17:33:56.941059 | controller | skipping: [instance]
2025-10-08 17:33:56.958241 | controller |
2025-10-08 17:33:56.958264 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-10-08 17:33:56.958272 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.034)       0:00:14.907 *****
2025-10-08 17:33:56.958291 | controller | skipping: [instance]
2025-10-08 17:33:56.975067 | controller |
2025-10-08 17:33:56.975092 | controller | TASK [Download the RPM] ********************************************************
2025-10-08 17:33:56.975101 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.017)       0:00:14.925 *****
2025-10-08 17:33:56.975110 | controller | skipping: [instance]
2025-10-08 17:33:56.975285 | controller |
2025-10-08 17:33:56.975449 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-10-08 17:33:56.975626 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.017)       0:00:14.942 *****
2025-10-08 17:33:56.991302 | controller | skipping: [instance]
2025-10-08 17:33:56.991474 | controller |
2025-10-08 17:33:56.991664 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-10-08 17:33:56.991798 | controller | Wednesday 08 October 2025  17:33:56 +0000 (0:00:00.016)       0:00:14.958 *****
2025-10-08 17:33:57.007601 | controller | skipping: [instance]
2025-10-08 17:33:57.007775 | controller |
2025-10-08 17:33:57.007935 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-10-08 17:33:57.008087 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.016)       0:00:14.974 *****
2025-10-08 17:33:57.024865 | controller | skipping: [instance]
2025-10-08 17:33:57.025034 | controller |
2025-10-08 17:33:57.025220 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-10-08 17:33:57.025378 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.017)       0:00:14.992 *****
2025-10-08 17:33:57.041278 | controller | skipping: [instance]
2025-10-08 17:33:57.041449 | controller |
2025-10-08 17:33:57.041640 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-10-08 17:33:57.041789 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.016)       0:00:15.008 *****
2025-10-08 17:33:57.223240 | controller | ok: [instance]
2025-10-08 17:33:57.442438 | controller |
2025-10-08 17:33:57.442456 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-10-08 17:33:57.442463 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.181)       0:00:15.189 *****
2025-10-08 17:33:57.442472 | controller | changed: [instance]
2025-10-08 17:33:57.668233 | controller |
2025-10-08 17:33:57.668263 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-10-08 17:33:57.668272 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.218)       0:00:15.408 *****
2025-10-08 17:33:57.668282 | controller | changed: [instance]
2025-10-08 17:33:57.691755 | controller |
2025-10-08 17:33:57.691772 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-10-08 17:33:57.691779 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.225)       0:00:15.634 *****
2025-10-08 17:33:57.691787 | controller | skipping: [instance]
2025-10-08 17:33:57.717172 | controller |
2025-10-08 17:33:57.717192 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-10-08 17:33:57.717199 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.023)       0:00:15.658 *****
2025-10-08 17:33:57.717208 | controller | skipping: [instance]
2025-10-08 17:33:57.742625 | controller |
2025-10-08 17:33:57.742643 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-10-08 17:33:57.742650 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.025)       0:00:15.684 *****
2025-10-08 17:33:57.742658 | controller | skipping: [instance]
2025-10-08 17:33:57.766177 | controller |
2025-10-08 17:33:57.766218 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-10-08 17:33:57.766226 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.025)       0:00:15.709 *****
2025-10-08 17:33:57.766234 | controller | skipping: [instance]
2025-10-08 17:33:57.796058 | controller |
2025-10-08 17:33:57.796081 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-10-08 17:33:57.796096 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.023)       0:00:15.732 *****
2025-10-08 17:33:57.796109 | controller | skipping: [instance]
2025-10-08 17:33:57.796275 | controller |
2025-10-08 17:33:57.796423 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-10-08 17:33:57.796598 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.030)       0:00:15.763 *****
2025-10-08 17:33:57.819931 | controller | skipping: [instance]
2025-10-08 17:33:57.838309 | controller |
2025-10-08 17:33:57.838326 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-10-08 17:33:57.838333 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.023)       0:00:15.786 *****
2025-10-08 17:33:57.838341 | controller | skipping: [instance]
2025-10-08 17:33:57.858914 | controller |
2025-10-08 17:33:57.858931 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-10-08 17:33:57.858938 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.018)       0:00:15.805 *****
2025-10-08 17:33:57.858947 | controller | skipping: [instance]
2025-10-08 17:33:57.876251 | controller |
2025-10-08 17:33:57.876275 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-10-08 17:33:57.876284 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.020)       0:00:15.825 *****
2025-10-08 17:33:57.876296 | controller | skipping: [instance]
2025-10-08 17:33:57.899922 | controller |
2025-10-08 17:33:57.899952 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-10-08 17:33:57.899961 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.017)       0:00:15.842 *****
2025-10-08 17:33:57.899972 | controller | skipping: [instance]
2025-10-08 17:33:57.920977 | controller |
2025-10-08 17:33:57.920992 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2025-10-08 17:33:57.920999 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.023)       0:00:15.866 *****
2025-10-08 17:33:57.921006 | controller | skipping: [instance]
2025-10-08 17:33:57.941565 | controller |
2025-10-08 17:33:57.941581 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2025-10-08 17:33:57.941588 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.021)       0:00:15.888 *****
2025-10-08 17:33:57.941595 | controller | skipping: [instance]
2025-10-08 17:33:57.961140 | controller |
2025-10-08 17:33:57.961175 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2025-10-08 17:33:57.961185 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.020)       0:00:15.908 *****
2025-10-08 17:33:57.961197 | controller | skipping: [instance]
2025-10-08 17:33:57.961387 | controller |
2025-10-08 17:33:57.961588 | controller | TASK [test_deps : Install additional packages] *********************************
2025-10-08 17:33:57.961720 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.019)       0:00:15.928 *****
2025-10-08 17:33:57.981308 | controller | skipping: [instance]
2025-10-08 17:33:57.981484 | controller |
2025-10-08 17:33:57.981664 | controller | TASK [test_deps : Install selinux python libs] *********************************
2025-10-08 17:33:57.981808 | controller | Wednesday 08 October 2025  17:33:57 +0000 (0:00:00.020)       0:00:15.948 *****
2025-10-08 17:34:52.109313 | controller | ok: [instance]
2025-10-08 17:34:53.176820 | controller |
2025-10-08 17:34:53.176851 | controller | TASK [test_deps : Install python yaml libs] ************************************
2025-10-08 17:34:53.176859 | controller | Wednesday 08 October 2025  17:34:52 +0000 (0:00:54.127)       0:01:10.075 *****
2025-10-08 17:34:53.176868 | controller | ok: [instance]
2025-10-08 17:34:53.198987 | controller |
2025-10-08 17:34:53.199005 | controller | TASK [test_deps : Install extra packages] **************************************
2025-10-08 17:34:53.199012 | controller | Wednesday 08 October 2025  17:34:53 +0000 (0:00:01.067)       0:01:11.143 *****
2025-10-08 17:34:53.199021 | controller | skipping: [instance]
2025-10-08 17:34:53.233165 | controller |
2025-10-08 17:34:53.233185 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2025-10-08 17:34:53.233193 | controller | Wednesday 08 October 2025  17:34:53 +0000 (0:00:00.022)       0:01:11.165 *****
2025-10-08 17:34:53.233203 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2025-10-08 17:34:53.252740 | controller |
2025-10-08 17:34:53.252811 | controller | TASK [ci_setup : List packages to install] *************************************
2025-10-08 17:34:53.252827 | controller | Wednesday 08 October 2025  17:34:53 +0000 (0:00:00.034)       0:01:11.199 *****
2025-10-08 17:34:53.252861 | controller | ok: [instance] =>
2025-10-08 17:34:53.252906 | controller |   cifmw_ci_setup_packages:
2025-10-08 17:34:53.252920 | controller |   - bash-completion
2025-10-08 17:34:53.252930 | controller |   - ca-certificates
2025-10-08 17:34:53.252940 | controller |   - git-core
2025-10-08 17:34:53.252950 | controller |   - make
2025-10-08 17:34:53.252960 | controller |   - tar
2025-10-08 17:34:53.252973 | controller |   - tmux
2025-10-08 17:34:53.253024 | controller |   - python3-pip
2025-10-08 17:34:53.253038 | controller |
2025-10-08 17:34:53.253175 | controller | TASK [ci_setup : Install needed packages] **************************************
2025-10-08 17:34:53.253208 | controller | Wednesday 08 October 2025  17:34:53 +0000 (0:00:00.019)       0:01:11.219 *****
2025-10-08 17:34:57.433462 | controller | changed: [instance]
2025-10-08 17:34:57.646234 | controller |
2025-10-08 17:34:57.646267 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2025-10-08 17:34:57.646280 | controller | Wednesday 08 October 2025  17:34:57 +0000 (0:00:04.180)       0:01:15.399 *****
2025-10-08 17:34:57.646291 | controller | ok: [instance]
2025-10-08 17:34:57.839717 | controller |
2025-10-08 17:34:57.839767 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2025-10-08 17:34:57.839776 | controller | Wednesday 08 October 2025  17:34:57 +0000 (0:00:00.213)       0:01:15.612 *****
2025-10-08 17:34:57.839787 | controller | changed: [instance]
2025-10-08 17:35:03.644861 | controller |
2025-10-08 17:35:03.644891 | controller | TASK [ci_setup : Install openshift client] *************************************
2025-10-08 17:35:03.644899 | controller | Wednesday 08 October 2025  17:34:57 +0000 (0:00:00.193)       0:01:15.806 *****
2025-10-08 17:35:03.644908 | controller | changed: [instance]
2025-10-08 17:35:03.673384 | controller |
2025-10-08 17:35:03.673402 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2025-10-08 17:35:03.673410 | controller | Wednesday 08 October 2025  17:35:03 +0000 (0:00:05.805)       0:01:21.611 *****
2025-10-08 17:35:03.673419 | controller | ok: [instance]
2025-10-08 17:35:03.931638 | controller |
2025-10-08 17:35:03.931702 | controller | TASK [ci_setup : Create completion file] ***************************************
2025-10-08 17:35:03.931713 | controller | Wednesday 08 October 2025  17:35:03 +0000 (0:00:00.028)       0:01:21.640 *****
2025-10-08 17:35:03.931728 | controller | changed: [instance]
2025-10-08 17:35:03.931762 | controller |
2025-10-08 17:35:03.931942 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2025-10-08 17:35:03.931988 | controller | Wednesday 08 October 2025  17:35:03 +0000 (0:00:00.258)       0:01:21.898 *****
2025-10-08 17:35:04.199989 | controller | changed: [instance]
2025-10-08 17:35:04.220444 | controller |
2025-10-08 17:35:04.220473 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2025-10-08 17:35:04.220481 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.268)       0:01:22.166 *****
2025-10-08 17:35:04.220492 | controller | skipping: [instance]
2025-10-08 17:35:04.237523 | controller |
2025-10-08 17:35:04.237544 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2025-10-08 17:35:04.237551 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.020)       0:01:22.187 *****
2025-10-08 17:35:04.237560 | controller | skipping: [instance]
2025-10-08 17:35:04.255157 | controller |
2025-10-08 17:35:04.255174 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2025-10-08 17:35:04.255181 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.017)       0:01:22.204 *****
2025-10-08 17:35:04.255189 | controller | skipping: [instance]
2025-10-08 17:35:04.271636 | controller |
2025-10-08 17:35:04.271656 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2025-10-08 17:35:04.271663 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.017)       0:01:22.222 *****
2025-10-08 17:35:04.271673 | controller | skipping: [instance]
2025-10-08 17:35:04.307695 | controller |
2025-10-08 17:35:04.307749 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2025-10-08 17:35:04.307759 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.016)       0:01:22.238 *****
2025-10-08 17:35:04.307772 | controller | skipping: [instance]
2025-10-08 17:35:04.307810 | controller |
2025-10-08 17:35:04.307819 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2025-10-08 17:35:04.331397 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.036)       0:01:22.274 *****
2025-10-08 17:35:04.331442 | controller | skipping: [instance]
2025-10-08 17:35:05.347487 | controller |
2025-10-08 17:35:05.347562 | controller | TASK [ci_setup : Manage directories] *******************************************
2025-10-08 17:35:05.347571 | controller | Wednesday 08 October 2025  17:35:04 +0000 (0:00:00.023)       0:01:22.298 *****
2025-10-08 17:35:05.347583 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2025-10-08 17:35:05.549466 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2025-10-08 17:35:05.549533 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2025-10-08 17:35:05.549544 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2025-10-08 17:35:05.549551 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2025-10-08 17:35:05.549556 | controller |
2025-10-08 17:35:05.549562 | controller | TASK [Ensure directory exists] *************************************************
2025-10-08 17:35:05.549568 | controller | Wednesday 08 October 2025  17:35:05 +0000 (0:00:01.015)       0:01:23.313 *****
2025-10-08 17:35:05.549579 | controller | changed: [instance]
2025-10-08 17:35:05.970745 | controller |
2025-10-08 17:35:05.970810 | controller | TASK [Create nova migration keypair] *******************************************
2025-10-08 17:35:05.970822 | controller | Wednesday 08 October 2025  17:35:05 +0000 (0:00:00.202)       0:01:23.515 *****
2025-10-08 17:35:05.970837 | controller | changed: [instance]
2025-10-08 17:35:05.970897 | controller |
2025-10-08 17:35:05.970907 | controller | PLAY [Download tools] **********************************************************
2025-10-08 17:35:05.970916 | controller |
2025-10-08 17:35:05.971002 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 17:35:05.971020 | controller | Wednesday 08 October 2025  17:35:05 +0000 (0:00:00.421)       0:01:23.937 *****
2025-10-08 17:35:06.592542 | controller | ok: [localhost]
2025-10-08 17:35:12.155527 | controller |
2025-10-08 17:35:12.155589 | controller | TASK [download_tools : Install build dependencies] *****************************
2025-10-08 17:35:12.155599 | controller | Wednesday 08 October 2025  17:35:06 +0000 (0:00:00.621)       0:01:24.558 *****
2025-10-08 17:35:12.155612 | controller | changed: [localhost]
2025-10-08 17:35:12.188443 | controller |
2025-10-08 17:35:12.188541 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-10-08 17:35:12.188556 | controller | Wednesday 08 October 2025  17:35:12 +0000 (0:00:05.561)       0:01:30.120 *****
2025-10-08 17:35:12.188570 | controller | skipping: [localhost]
2025-10-08 17:35:12.188594 | controller |
2025-10-08 17:35:12.188603 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-10-08 17:35:12.224424 | controller | Wednesday 08 October 2025  17:35:12 +0000 (0:00:00.034)       0:01:30.155 *****
2025-10-08 17:35:12.224481 | controller | ok: [localhost]
2025-10-08 17:35:12.224659 | controller |
2025-10-08 17:35:12.224701 | controller | TASK [download_tools : Create $HOME/bin dir] ***********************************
2025-10-08 17:35:12.465682 | controller | Wednesday 08 October 2025  17:35:12 +0000 (0:00:00.036)       0:01:30.191 *****
2025-10-08 17:35:12.465734 | controller | ok: [localhost]
2025-10-08 17:35:13.786430 | controller |
2025-10-08 17:35:13.786473 | controller | TASK [download_tools : Download opm] *******************************************
2025-10-08 17:35:13.786480 | controller | Wednesday 08 October 2025  17:35:12 +0000 (0:00:00.240)       0:01:30.431 *****
2025-10-08 17:35:13.786491 | controller | changed: [localhost]
2025-10-08 17:35:13.814053 | controller |
2025-10-08 17:35:13.814074 | controller | TASK [download_tools : Get version from sdk_version] ***************************
2025-10-08 17:35:13.814084 | controller | Wednesday 08 October 2025  17:35:13 +0000 (0:00:01.320)       0:01:31.752 *****
2025-10-08 17:35:13.814094 | controller | ok: [localhost]
2025-10-08 17:35:13.839684 | controller |
2025-10-08 17:35:13.839957 | controller | TASK [download_tools : Set operator-sdk file for version < 1.3.0] **************
2025-10-08 17:35:13.839983 | controller | Wednesday 08 October 2025  17:35:13 +0000 (0:00:00.028)       0:01:31.780 *****
2025-10-08 17:35:13.839999 | controller | skipping: [localhost]
2025-10-08 17:35:13.870213 | controller |
2025-10-08 17:35:13.870253 | controller | TASK [download_tools : Set operator-sdk file for version >= 1.3.0] *************
2025-10-08 17:35:13.870263 | controller | Wednesday 08 October 2025  17:35:13 +0000 (0:00:00.025)       0:01:31.806 *****
2025-10-08 17:35:13.870274 | controller | ok: [localhost]
2025-10-08 17:35:15.317650 | controller |
2025-10-08 17:35:15.317691 | controller | TASK [download_tools : Download operator-sdk] **********************************
2025-10-08 17:35:15.317699 | controller | Wednesday 08 October 2025  17:35:13 +0000 (0:00:00.030)       0:01:31.836 *****
2025-10-08 17:35:15.317709 | controller | changed: [localhost]
2025-10-08 17:35:16.388948 | controller |
2025-10-08 17:35:16.389001 | controller | TASK [download_tools : Download and extract kustomize] *************************
2025-10-08 17:35:16.389010 | controller | Wednesday 08 October 2025  17:35:15 +0000 (0:00:01.446)       0:01:33.283 *****
2025-10-08 17:35:16.389021 | controller | changed: [localhost]
2025-10-08 17:35:16.874382 | controller |
2025-10-08 17:35:16.874410 | controller | TASK [download_tools : Download kubectl] ***************************************
2025-10-08 17:35:16.874418 | controller | Wednesday 08 October 2025  17:35:16 +0000 (0:00:01.071)       0:01:34.355 *****
2025-10-08 17:35:16.874427 | controller | ok: [localhost]
2025-10-08 17:35:17.838128 | controller |
2025-10-08 17:35:17.838162 | controller | TASK [download_tools : Download kuttl] *****************************************
2025-10-08 17:35:17.838170 | controller | Wednesday 08 October 2025  17:35:16 +0000 (0:00:00.485)       0:01:34.840 *****
2025-10-08 17:35:17.838179 | controller | changed: [localhost]
2025-10-08 17:35:20.812252 | controller |
2025-10-08 17:35:20.812288 | controller | TASK [download_tools : Download chainsaw] **************************************
2025-10-08 17:35:20.812295 | controller | Wednesday 08 October 2025  17:35:17 +0000 (0:00:00.963)       0:01:35.804 *****
2025-10-08 17:35:20.812304 | controller | changed: [localhost]
2025-10-08 17:35:21.954838 | controller |
2025-10-08 17:35:21.954876 | controller | TASK [download_tools : Download and extract yq] ********************************
2025-10-08 17:35:21.954883 | controller | Wednesday 08 October 2025  17:35:20 +0000 (0:00:02.974)       0:01:38.778 *****
2025-10-08 17:35:21.954893 | controller | changed: [localhost]
2025-10-08 17:35:22.149543 | controller |
2025-10-08 17:35:22.149580 | controller | TASK [download_tools : Link yq_linux_amd64 as yq] ******************************
2025-10-08 17:35:22.149593 | controller | Wednesday 08 October 2025  17:35:21 +0000 (0:00:01.142)       0:01:39.921 *****
2025-10-08 17:35:22.149603 | controller | changed: [localhost]
2025-10-08 17:35:23.632522 | controller |
2025-10-08 17:35:23.632559 | controller | TASK [download_tools : Deinstall golang] ***************************************
2025-10-08 17:35:23.632566 | controller | Wednesday 08 October 2025  17:35:22 +0000 (0:00:00.194)       0:01:40.115 *****
2025-10-08 17:35:23.632576 | controller | ok: [localhost]
2025-10-08 17:35:24.627596 | controller |
2025-10-08 17:35:24.627632 | controller | TASK [download_tools : Delete old go version installed from upstream] **********
2025-10-08 17:35:24.627640 | controller | Wednesday 08 October 2025  17:35:23 +0000 (0:00:01.483)       0:01:41.599 *****
2025-10-08 17:35:24.627650 | controller | ok: [localhost] => (item=/usr/local/go)
2025-10-08 17:35:24.627677 | controller | ok: [localhost] => (item=/home/zuul/bin/go)
2025-10-08 17:35:24.627683 | controller | ok: [localhost] => (item=/home/zuul/bin/gofmt)
2025-10-08 17:35:24.627688 | controller | ok: [localhost] => (item=/usr/local/bin/go)
2025-10-08 17:35:24.627693 | controller | ok: [localhost] => (item=/usr/local/bin/gofmt)
2025-10-08 17:35:24.627698 | controller |
2025-10-08 17:35:24.627712 | controller | TASK [download_tools : Download and extract golang] ****************************
2025-10-08 17:35:36.286046 | controller | Wednesday 08 October 2025  17:35:24 +0000 (0:00:00.994)       0:01:42.593 *****
2025-10-08 17:35:36.286091 | controller | changed: [localhost]
2025-10-08 17:35:36.701187 | controller |
2025-10-08 17:35:36.701226 | controller | TASK [download_tools : Set alternatives link to installed go version] **********
2025-10-08 17:35:36.701234 | controller | Wednesday 08 October 2025  17:35:36 +0000 (0:00:11.657)       0:01:54.251 *****
2025-10-08 17:35:36.701245 | controller | changed: [localhost] => (item=go)
2025-10-08 17:35:36.740656 | controller | changed: [localhost] => (item=gofmt)
2025-10-08 17:35:36.740700 | controller |
2025-10-08 17:35:36.740710 | controller | TASK [download_tools : Clean bash cache] ***************************************
2025-10-08 17:35:36.740729 | controller | Wednesday 08 October 2025  17:35:36 +0000 (0:00:00.415)       0:01:54.667 *****
2025-10-08 17:35:36.740743 | controller | ok: [localhost] =>
2025-10-08 17:35:36.740778 | controller |   msg: When move from rpm to upstream version, make sure to clean bash cache using `hash -d go`
2025-10-08 17:35:36.740787 | controller |
2025-10-08 17:35:36.740795 | controller | PLAY RECAP *********************************************************************
2025-10-08 17:35:36.740803 | controller | instance                   : ok=31   changed=17   unreachable=0    failed=0    skipped=36   rescued=0    ignored=0
2025-10-08 17:35:36.740813 | controller | localhost                  : ok=19   changed=10   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-08 17:35:36.742591 | controller |
2025-10-08 17:35:36.742631 | controller | Wednesday 08 October 2025  17:35:36 +0000 (0:00:00.039)       0:01:54.706 *****
2025-10-08 17:35:36.742655 | controller | ===============================================================================
2025-10-08 17:35:36.742661 | controller | test_deps : Install selinux python libs -------------------------------- 54.13s
2025-10-08 17:35:36.742666 | controller | download_tools : Download and extract golang --------------------------- 11.66s
2025-10-08 17:35:36.742671 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.51s
2025-10-08 17:35:36.742676 | controller | ci_setup : Install openshift client ------------------------------------- 5.81s
2025-10-08 17:35:36.742681 | controller | download_tools : Install build dependencies ----------------------------- 5.56s
2025-10-08 17:35:36.742686 | controller | ci_setup : Install needed packages -------------------------------------- 4.18s
2025-10-08 17:35:36.742690 | controller | download_tools : Download chainsaw -------------------------------------- 2.97s
2025-10-08 17:35:36.742695 | controller | download_tools : Deinstall golang --------------------------------------- 1.48s
2025-10-08 17:35:36.742700 | controller | download_tools : Download operator-sdk ---------------------------------- 1.45s
2025-10-08 17:35:36.742706 | controller | download_tools : Download opm ------------------------------------------- 1.32s
2025-10-08 17:35:36.742711 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.17s
2025-10-08 17:35:36.742716 | controller | download_tools : Download and extract yq -------------------------------- 1.14s
2025-10-08 17:35:36.742720 | controller | download_tools : Download and extract kustomize ------------------------- 1.07s
2025-10-08 17:35:36.742725 | controller | test_deps : Install python yaml libs ------------------------------------ 1.07s
2025-10-08 17:35:36.742730 | controller | ci_setup : Manage directories ------------------------------------------- 1.02s
2025-10-08 17:35:36.742735 | controller | download_tools : Delete old go version installed from upstream ---------- 0.99s
2025-10-08 17:35:36.742739 | controller | download_tools : Download kuttl ----------------------------------------- 0.96s
2025-10-08 17:35:36.742754 | controller | Gathering Facts --------------------------------------------------------- 0.86s
2025-10-08 17:35:36.742776 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.81s
2025-10-08 17:35:36.833363 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.78s
2025-10-08 17:35:36.833392 | controller | INFO     Running default > converge
2025-10-08 17:35:37.230333 | controller |
2025-10-08 17:35:37.230533 | controller | PLAY [Converge] ****************************************************************
2025-10-08 17:35:37.230620 | controller |
2025-10-08 17:35:37.230771 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 17:35:37.230854 | controller | Wednesday 08 October 2025  17:35:37 +0000 (0:00:00.012)       0:00:00.012 *****
2025-10-08 17:35:38.071673 | controller | ok: [instance]
2025-10-08 17:35:38.782668 | controller |
2025-10-08 17:35:38.782720 | controller | TASK [Ensure architecture repository is building] ******************************
2025-10-08 17:35:38.782730 | controller | Wednesday 08 October 2025  17:35:38 +0000 (0:00:00.841)       0:00:00.854 *****
2025-10-08 17:35:38.782743 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-10-08 17:35:38.782783 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-10-08 17:35:38.782807 | controller |
2025-10-08 17:35:38.782920 | controller | TASK [Create nova migration keypair] *******************************************
2025-10-08 17:35:38.782973 | controller | Wednesday 08 October 2025  17:35:38 +0000 (0:00:00.711)       0:00:01.565 *****
2025-10-08 17:35:39.182235 | controller | changed: [instance]
2025-10-08 17:35:39.243038 | controller |
2025-10-08 17:35:39.243072 | controller | TASK [Generate needed facts out of local files] ********************************
2025-10-08 17:35:39.243080 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.399)       0:00:01.965 *****
2025-10-08 17:35:39.243091 | controller | ok: [instance]
2025-10-08 17:35:39.269994 | controller |
2025-10-08 17:35:39.270019 | controller | TASK [Generate network-values] *************************************************
2025-10-08 17:35:39.270029 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.061)       0:00:02.026 *****
2025-10-08 17:35:39.270041 | controller |
2025-10-08 17:35:39.297434 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 17:35:39.297461 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.027)       0:00:02.053 *****
2025-10-08 17:35:39.297478 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 17:35:39.324318 | controller |
2025-10-08 17:35:39.324336 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 17:35:39.324342 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.027)       0:00:02.080 *****
2025-10-08 17:35:39.324352 | controller | ok: [instance] => changed=false
2025-10-08 17:35:39.627456 | controller |   msg: All assertions passed
2025-10-08 17:35:39.627499 | controller |
2025-10-08 17:35:39.627526 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 17:35:39.627533 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.027)       0:00:02.107 *****
2025-10-08 17:35:39.627544 | controller | ok: [instance]
2025-10-08 17:35:39.664380 | controller |
2025-10-08 17:35:39.664412 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 17:35:39.664425 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.302)       0:00:02.410 *****
2025-10-08 17:35:39.664441 | controller | ok: [instance] => changed=false
2025-10-08 17:35:39.959738 | controller |   msg: All assertions passed
2025-10-08 17:35:39.959757 | controller |
2025-10-08 17:35:39.959764 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 17:35:39.959769 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.036)       0:00:02.447 *****
2025-10-08 17:35:39.959777 | controller | ok: [instance]
2025-10-08 17:35:39.960120 | controller |
2025-10-08 17:35:40.226119 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 17:35:40.226137 | controller | Wednesday 08 October 2025  17:35:39 +0000 (0:00:00.295)       0:00:02.743 *****
2025-10-08 17:35:40.226146 | controller | ok: [instance]
2025-10-08 17:35:40.271946 | controller |
2025-10-08 17:35:40.271963 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 17:35:40.271970 | controller | Wednesday 08 October 2025  17:35:40 +0000 (0:00:00.266)       0:00:03.009 *****
2025-10-08 17:35:40.271978 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 17:35:40.298552 | controller |
2025-10-08 17:35:40.298569 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 17:35:40.298576 | controller | Wednesday 08 October 2025  17:35:40 +0000 (0:00:00.045)       0:00:03.055 *****
2025-10-08 17:35:40.298584 | controller | ok: [instance] => changed=false
2025-10-08 17:35:40.298707 | controller |   msg: All assertions passed
2025-10-08 17:35:40.298717 | controller |
2025-10-08 17:35:40.298723 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 17:35:40.298730 | controller | Wednesday 08 October 2025  17:35:40 +0000 (0:00:00.026)       0:00:03.082 *****
2025-10-08 17:35:40.598979 | controller | changed: [instance]
2025-10-08 17:35:41.169639 | controller |
2025-10-08 17:35:41.169679 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 17:35:41.169695 | controller | Wednesday 08 October 2025  17:35:40 +0000 (0:00:00.300)       0:00:03.382 *****
2025-10-08 17:35:41.169706 | controller | changed: [instance]
2025-10-08 17:35:41.210547 | controller |
2025-10-08 17:35:41.210576 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 17:35:41.210584 | controller | Wednesday 08 October 2025  17:35:41 +0000 (0:00:00.570)       0:00:03.952 *****
2025-10-08 17:35:41.210596 | controller | ok: [instance]
2025-10-08 17:35:41.545575 | controller |
2025-10-08 17:35:41.545617 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 17:35:41.545625 | controller | Wednesday 08 October 2025  17:35:41 +0000 (0:00:00.040)       0:00:03.993 *****
2025-10-08 17:35:41.545636 | controller | changed: [instance]
2025-10-08 17:35:41.875361 | controller |
2025-10-08 17:35:41.875397 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 17:35:41.875405 | controller | Wednesday 08 October 2025  17:35:41 +0000 (0:00:00.335)       0:00:04.328 *****
2025-10-08 17:35:41.875415 | controller | changed: [instance]
2025-10-08 17:35:42.216697 | controller |
2025-10-08 17:35:42.216732 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 17:35:42.216739 | controller | Wednesday 08 October 2025  17:35:41 +0000 (0:00:00.329)       0:00:04.658 *****
2025-10-08 17:35:42.216749 | controller | changed: [instance]
2025-10-08 17:35:42.248644 | controller |
2025-10-08 17:35:42.248686 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 17:35:42.248696 | controller | Wednesday 08 October 2025  17:35:42 +0000 (0:00:00.341)       0:00:04.999 *****
2025-10-08 17:35:42.248710 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 17:35:42.248747 | controller |
2025-10-08 17:35:42.248855 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 17:35:42.248875 | controller | Wednesday 08 October 2025  17:35:42 +0000 (0:00:00.032)       0:00:05.032 *****
2025-10-08 17:35:42.279833 | controller | ok: [instance] => changed=false
2025-10-08 17:35:42.565984 | controller |   msg: All assertions passed
2025-10-08 17:35:42.566003 | controller |
2025-10-08 17:35:42.566010 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 17:35:42.566016 | controller | Wednesday 08 October 2025  17:35:42 +0000 (0:00:00.030)       0:00:05.062 *****
2025-10-08 17:35:42.566031 | controller | ok: [instance]
2025-10-08 17:35:42.588346 | controller |
2025-10-08 17:35:42.588361 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 17:35:42.588367 | controller | Wednesday 08 October 2025  17:35:42 +0000 (0:00:00.286)       0:00:05.349 *****
2025-10-08 17:35:42.588375 | controller | ok: [instance]
2025-10-08 17:35:43.087293 | controller |
2025-10-08 17:35:43.087330 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 17:35:43.087337 | controller | Wednesday 08 October 2025  17:35:42 +0000 (0:00:00.022)       0:00:05.371 *****
2025-10-08 17:35:43.087346 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 17:35:43.155597 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 17:35:43.155642 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 17:35:43.155649 | controller |
2025-10-08 17:35:43.155655 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 17:35:43.155661 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.498)       0:00:05.870 *****
2025-10-08 17:35:43.155671 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 17:35:43.155688 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 17:35:43.155695 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 17:35:43.155962 | controller |
2025-10-08 17:35:43.364278 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 17:35:43.364296 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.068)       0:00:05.939 *****
2025-10-08 17:35:43.364314 | controller | changed: [instance]
2025-10-08 17:35:43.738240 | controller |
2025-10-08 17:35:43.738267 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 17:35:43.738274 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.208)       0:00:06.147 *****
2025-10-08 17:35:43.738284 | controller | changed: [instance]
2025-10-08 17:35:43.766634 | controller |
2025-10-08 17:35:43.766700 | controller | TASK [Generate edpm-nodeset-values] ********************************************
2025-10-08 17:35:43.766712 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.373)       0:00:06.521 *****
2025-10-08 17:35:43.766729 | controller |
2025-10-08 17:35:43.793061 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 17:35:43.793091 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.028)       0:00:06.550 *****
2025-10-08 17:35:43.793107 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 17:35:43.822327 | controller |
2025-10-08 17:35:43.822361 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 17:35:43.822383 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.026)       0:00:06.576 *****
2025-10-08 17:35:43.822400 | controller | ok: [instance] => changed=false
2025-10-08 17:35:44.021367 | controller |   msg: All assertions passed
2025-10-08 17:35:44.021393 | controller |
2025-10-08 17:35:44.021400 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 17:35:44.021407 | controller | Wednesday 08 October 2025  17:35:43 +0000 (0:00:00.029)       0:00:06.605 *****
2025-10-08 17:35:44.021416 | controller | ok: [instance]
2025-10-08 17:35:44.058315 | controller |
2025-10-08 17:35:44.058344 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 17:35:44.058354 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.199)       0:00:06.804 *****
2025-10-08 17:35:44.058368 | controller | ok: [instance] => changed=false
2025-10-08 17:35:44.252774 | controller |   msg: All assertions passed
2025-10-08 17:35:44.252810 | controller |
2025-10-08 17:35:44.252818 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 17:35:44.252825 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.036)       0:00:06.841 *****
2025-10-08 17:35:44.252836 | controller | ok: [instance]
2025-10-08 17:35:44.479534 | controller |
2025-10-08 17:35:44.479585 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 17:35:44.479595 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.194)       0:00:07.036 *****
2025-10-08 17:35:44.479607 | controller | ok: [instance]
2025-10-08 17:35:44.524816 | controller |
2025-10-08 17:35:44.524879 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 17:35:44.524894 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.226)       0:00:07.262 *****
2025-10-08 17:35:44.524913 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-10-08 17:35:44.560018 | controller |
2025-10-08 17:35:44.560060 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-10-08 17:35:44.560075 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.045)       0:00:07.307 *****
2025-10-08 17:35:44.560093 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-10-08 17:35:44.591658 | controller |
2025-10-08 17:35:44.591706 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-10-08 17:35:44.591720 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.035)       0:00:07.343 *****
2025-10-08 17:35:44.591736 | controller | ok: [instance] => changed=false
2025-10-08 17:35:44.591769 | controller |   msg: All assertions passed
2025-10-08 17:35:44.591780 | controller |
2025-10-08 17:35:44.591803 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-10-08 17:35:44.591851 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.031)       0:00:07.375 *****
2025-10-08 17:35:44.619579 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-10-08 17:35:44.619681 | controller |
2025-10-08 17:35:44.619823 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-10-08 17:35:44.619963 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.028)       0:00:07.403 *****
2025-10-08 17:35:44.644177 | controller | skipping: [instance]
2025-10-08 17:35:44.669634 | controller |
2025-10-08 17:35:44.669682 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-10-08 17:35:44.669693 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.023)       0:00:07.427 *****
2025-10-08 17:35:44.669707 | controller | ok: [instance]
2025-10-08 17:35:44.699558 | controller |
2025-10-08 17:35:44.699586 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-10-08 17:35:44.699596 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.025)       0:00:07.453 *****
2025-10-08 17:35:44.699609 | controller | ok: [instance] => changed=false
2025-10-08 17:35:44.699826 | controller |   msg: All assertions passed
2025-10-08 17:35:44.699846 | controller |
2025-10-08 17:35:44.887615 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 17:35:44.887661 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.030)       0:00:07.483 *****
2025-10-08 17:35:44.887674 | controller | changed: [instance]
2025-10-08 17:35:44.887704 | controller |
2025-10-08 17:35:44.887832 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 17:35:44.887854 | controller | Wednesday 08 October 2025  17:35:44 +0000 (0:00:00.188)       0:00:07.671 *****
2025-10-08 17:35:45.271599 | controller | changed: [instance]
2025-10-08 17:35:45.271638 | controller |
2025-10-08 17:35:45.271645 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 17:35:45.271653 | controller | Wednesday 08 October 2025  17:35:45 +0000 (0:00:00.383)       0:00:08.054 *****
2025-10-08 17:35:45.295171 | controller | ok: [instance]
2025-10-08 17:35:45.622382 | controller |
2025-10-08 17:35:45.622436 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 17:35:45.622446 | controller | Wednesday 08 October 2025  17:35:45 +0000 (0:00:00.024)       0:00:08.078 *****
2025-10-08 17:35:45.622458 | controller | changed: [instance]
2025-10-08 17:35:45.936718 | controller |
2025-10-08 17:35:45.936770 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 17:35:45.936778 | controller | Wednesday 08 October 2025  17:35:45 +0000 (0:00:00.326)       0:00:08.405 *****
2025-10-08 17:35:45.936789 | controller | changed: [instance]
2025-10-08 17:35:46.243621 | controller |
2025-10-08 17:35:46.243675 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 17:35:46.243684 | controller | Wednesday 08 October 2025  17:35:45 +0000 (0:00:00.314)       0:00:08.719 *****
2025-10-08 17:35:46.243702 | controller | changed: [instance]
2025-10-08 17:35:46.272272 | controller |
2025-10-08 17:35:46.272293 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 17:35:46.272301 | controller | Wednesday 08 October 2025  17:35:46 +0000 (0:00:00.306)       0:00:09.026 *****
2025-10-08 17:35:46.272311 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 17:35:46.321110 | controller |
2025-10-08 17:35:46.321146 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 17:35:46.321153 | controller | Wednesday 08 October 2025  17:35:46 +0000 (0:00:00.029)       0:00:09.055 *****
2025-10-08 17:35:46.321164 | controller | ok: [instance] => changed=false
2025-10-08 17:35:46.502752 | controller |   msg: All assertions passed
2025-10-08 17:35:46.502802 | controller |
2025-10-08 17:35:46.502810 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 17:35:46.502817 | controller | Wednesday 08 October 2025  17:35:46 +0000 (0:00:00.048)       0:00:09.104 *****
2025-10-08 17:35:46.502834 | controller | ok: [instance]
2025-10-08 17:35:46.521321 | controller |
2025-10-08 17:35:46.521351 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 17:35:46.521358 | controller | Wednesday 08 October 2025  17:35:46 +0000 (0:00:00.180)       0:00:09.285 *****
2025-10-08 17:35:46.521369 | controller | ok: [instance]
2025-10-08 17:35:46.983483 | controller |
2025-10-08 17:35:46.983544 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 17:35:46.983552 | controller | Wednesday 08 October 2025  17:35:46 +0000 (0:00:00.019)       0:00:09.304 *****
2025-10-08 17:35:46.983563 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-10-08 17:35:47.033997 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-10-08 17:35:47.034026 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-10-08 17:35:47.034034 | controller |
2025-10-08 17:35:47.034048 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 17:35:47.034054 | controller | Wednesday 08 October 2025  17:35:46 +0000 (0:00:00.461)       0:00:09.766 *****
2025-10-08 17:35:47.034064 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 17:35:47.034084 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 17:35:47.034091 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 17:35:47.034099 | controller |
2025-10-08 17:35:47.034266 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 17:35:47.216585 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.051)       0:00:09.817 *****
2025-10-08 17:35:47.216632 | controller | changed: [instance]
2025-10-08 17:35:47.536499 | controller |
2025-10-08 17:35:47.536566 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 17:35:47.536574 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.182)       0:00:09.999 *****
2025-10-08 17:35:47.536584 | controller | changed: [instance]
2025-10-08 17:35:47.855314 | controller |
2025-10-08 17:35:47.855362 | controller | TASK [Get generated files status] **********************************************
2025-10-08 17:35:47.855370 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.319)       0:00:10.319 *****
2025-10-08 17:35:47.855380 | controller | ok: [instance] => (item=network-values)
2025-10-08 17:35:47.882573 | controller | ok: [instance] => (item=edpm-nodeset-values)
2025-10-08 17:35:47.882609 | controller |
2025-10-08 17:35:47.882617 | controller | TASK [Assert generated values.yaml exists] *************************************
2025-10-08 17:35:47.882623 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.318)       0:00:10.638 *****
2025-10-08 17:35:47.882633 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml) => changed=false
2025-10-08 17:35:47.882656 | controller |   ansible_loop_var: item
2025-10-08 17:35:47.884555 | controller |   item:
2025-10-08 17:35:47.884624 | controller |     ansible_loop_var: item
2025-10-08 17:35:47.884636 | controller |     changed: false
2025-10-08 17:35:47.884642 | controller |     failed: false
2025-10-08 17:35:47.884648 | controller |     invocation:
2025-10-08 17:35:47.884653 | controller |       module_args:
2025-10-08 17:35:47.884659 | controller |         checksum_algorithm: sha1
2025-10-08 17:35:47.884665 | controller |         follow: false
2025-10-08 17:35:47.884670 | controller |         get_attributes: false
2025-10-08 17:35:47.884675 | controller |         get_checksum: false
2025-10-08 17:35:47.884680 | controller |         get_md5: false
2025-10-08 17:35:47.884686 | controller |         get_mime: false
2025-10-08 17:35:47.884692 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 17:35:47.884697 | controller |     item: network-values
2025-10-08 17:35:47.884703 | controller |     stat:
2025-10-08 17:35:47.884708 | controller |       atime: 1759944943.6946766
2025-10-08 17:35:47.884713 | controller |       block_size: 4096
2025-10-08 17:35:47.884718 | controller |       blocks: 16
2025-10-08 17:35:47.884723 | controller |       ctime: 1759944943.6986766
2025-10-08 17:35:47.884729 | controller |       dev: 64513
2025-10-08 17:35:47.884736 | controller |       device_type: 0
2025-10-08 17:35:47.884860 | controller |       executable: false
2025-10-08 17:35:47.884871 | controller |       exists: true
2025-10-08 17:35:47.884974 | controller |       gid: 1000
2025-10-08 17:35:47.885088 | controller |       gr_name: zuul
2025-10-08 17:35:47.885201 | controller |       inode: 79734117
2025-10-08 17:35:47.885335 | controller |       isblk: false
2025-10-08 17:35:47.885448 | controller |       ischr: false
2025-10-08 17:35:47.885578 | controller |       isdir: false
2025-10-08 17:35:47.885702 | controller |       isfifo: false
2025-10-08 17:35:47.885816 | controller |       isgid: false
2025-10-08 17:35:47.885929 | controller |       islnk: false
2025-10-08 17:35:47.886040 | controller |       isreg: true
2025-10-08 17:35:47.886150 | controller |       issock: false
2025-10-08 17:35:47.886269 | controller |       isuid: false
2025-10-08 17:35:47.886374 | controller |       mode: '0644'
2025-10-08 17:35:47.886475 | controller |       mtime: 1759944943.5536747
2025-10-08 17:35:47.886596 | controller |       nlink: 1
2025-10-08 17:35:47.886714 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 17:35:47.886818 | controller |       pw_name: zuul
2025-10-08 17:35:47.886927 | controller |       readable: true
2025-10-08 17:35:47.887029 | controller |       rgrp: true
2025-10-08 17:35:47.887133 | controller |       roth: true
2025-10-08 17:35:47.887243 | controller |       rusr: true
2025-10-08 17:35:47.887349 | controller |       size: 5726
2025-10-08 17:35:47.887451 | controller |       uid: 1000
2025-10-08 17:35:47.887568 | controller |       wgrp: false
2025-10-08 17:35:47.887677 | controller |       woth: false
2025-10-08 17:35:47.887777 | controller |       writeable: true
2025-10-08 17:35:47.887876 | controller |       wusr: true
2025-10-08 17:35:47.887976 | controller |       xgrp: false
2025-10-08 17:35:47.888076 | controller |       xoth: false
2025-10-08 17:35:47.888178 | controller |       xusr: false
2025-10-08 17:35:47.888299 | controller |   msg: All assertions passed
2025-10-08 17:35:47.888415 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml) => changed=false
2025-10-08 17:35:47.888535 | controller |   ansible_loop_var: item
2025-10-08 17:35:47.888641 | controller |   item:
2025-10-08 17:35:47.888745 | controller |     ansible_loop_var: item
2025-10-08 17:35:47.888847 | controller |     changed: false
2025-10-08 17:35:47.888947 | controller |     failed: false
2025-10-08 17:35:47.889052 | controller |     invocation:
2025-10-08 17:35:47.889155 | controller |       module_args:
2025-10-08 17:35:47.889271 | controller |         checksum_algorithm: sha1
2025-10-08 17:35:47.889377 | controller |         follow: false
2025-10-08 17:35:47.889478 | controller |         get_attributes: false
2025-10-08 17:35:47.889603 | controller |         get_checksum: false
2025-10-08 17:35:47.889712 | controller |         get_md5: false
2025-10-08 17:35:47.889817 | controller |         get_mime: false
2025-10-08 17:35:47.889928 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 17:35:47.890031 | controller |     item: edpm-nodeset-values
2025-10-08 17:35:47.890132 | controller |     stat:
2025-10-08 17:35:47.890243 | controller |       atime: 1759944947.4977293
2025-10-08 17:35:47.890347 | controller |       block_size: 4096
2025-10-08 17:35:47.890446 | controller |       blocks: 40
2025-10-08 17:35:47.890563 | controller |       ctime: 1759944947.5007293
2025-10-08 17:35:47.890674 | controller |       dev: 64513
2025-10-08 17:35:47.890776 | controller |       device_type: 0
2025-10-08 17:35:47.890877 | controller |       executable: false
2025-10-08 17:35:47.890975 | controller |       exists: true
2025-10-08 17:35:47.891076 | controller |       gid: 1000
2025-10-08 17:35:47.891175 | controller |       gr_name: zuul
2025-10-08 17:35:47.891292 | controller |       inode: 50381857
2025-10-08 17:35:47.891394 | controller |       isblk: false
2025-10-08 17:35:47.891496 | controller |       ischr: false
2025-10-08 17:35:47.891618 | controller |       isdir: false
2025-10-08 17:35:47.891728 | controller |       isfifo: false
2025-10-08 17:35:47.891828 | controller |       isgid: false
2025-10-08 17:35:47.891928 | controller |       islnk: false
2025-10-08 17:35:47.892027 | controller |       isreg: true
2025-10-08 17:35:47.892127 | controller |       issock: false
2025-10-08 17:35:47.892235 | controller |       isuid: false
2025-10-08 17:35:47.892339 | controller |       mode: '0644'
2025-10-08 17:35:47.892440 | controller |       mtime: 1759944947.3717275
2025-10-08 17:35:47.892560 | controller |       nlink: 1
2025-10-08 17:35:47.892676 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 17:35:47.892785 | controller |       pw_name: zuul
2025-10-08 17:35:47.892886 | controller |       readable: true
2025-10-08 17:35:47.892986 | controller |       rgrp: true
2025-10-08 17:35:47.893085 | controller |       roth: true
2025-10-08 17:35:47.893188 | controller |       rusr: true
2025-10-08 17:35:47.893301 | controller |       size: 16482
2025-10-08 17:35:47.893402 | controller |       uid: 1000
2025-10-08 17:35:47.893509 | controller |       wgrp: false
2025-10-08 17:35:47.893623 | controller |       woth: false
2025-10-08 17:35:47.893732 | controller |       writeable: true
2025-10-08 17:35:47.893834 | controller |       wusr: true
2025-10-08 17:35:47.893934 | controller |       xgrp: false
2025-10-08 17:35:47.894036 | controller |       xoth: false
2025-10-08 17:35:47.894142 | controller |       xusr: false
2025-10-08 17:35:47.894255 | controller |   msg: All assertions passed
2025-10-08 17:35:47.894355 | controller |
2025-10-08 17:35:47.894459 | controller | TASK [Ensure we have correct MAC] **********************************************
2025-10-08 17:35:47.894585 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.028)       0:00:10.666 *****
2025-10-08 17:35:47.912948 | controller | ok: [instance] => changed=false
2025-10-08 17:35:47.913088 | controller |   msg: All assertions passed
2025-10-08 17:35:47.913211 | controller |
2025-10-08 17:35:47.913350 | controller | TASK [Ensure we don't have node_1 nor node_2] **********************************
2025-10-08 17:35:47.913459 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.030)       0:00:10.696 *****
2025-10-08 17:35:47.943439 | controller | ok: [instance] => changed=false
2025-10-08 17:35:47.943590 | controller |   msg: All assertions passed
2025-10-08 17:35:47.943721 | controller |
2025-10-08 17:35:47.943852 | controller | TASK [Update cifmw_networking_env_definition] **********************************
2025-10-08 17:35:47.943982 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.030)       0:00:10.727 *****
2025-10-08 17:35:47.967912 | controller | ok: [instance]
2025-10-08 17:35:47.968045 | controller |
2025-10-08 17:35:47.968177 | controller | TASK [Regenerate network-values] ***********************************************
2025-10-08 17:35:47.968327 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.024)       0:00:10.751 *****
2025-10-08 17:35:47.990836 | controller |
2025-10-08 17:35:47.990967 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 17:35:47.991087 | controller | Wednesday 08 October 2025  17:35:47 +0000 (0:00:00.022)       0:00:10.774 *****
2025-10-08 17:35:48.016884 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 17:35:48.017035 | controller |
2025-10-08 17:35:48.017197 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 17:35:48.017383 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.026)       0:00:10.800 *****
2025-10-08 17:35:48.042649 | controller | ok: [instance] => changed=false
2025-10-08 17:35:48.042762 | controller |   msg: All assertions passed
2025-10-08 17:35:48.042863 | controller |
2025-10-08 17:35:48.042972 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 17:35:48.043091 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.025)       0:00:10.826 *****
2025-10-08 17:35:48.207599 | controller | ok: [instance]
2025-10-08 17:35:48.207806 | controller |
2025-10-08 17:35:48.207824 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 17:35:48.230974 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.164)       0:00:10.990 *****
2025-10-08 17:35:48.230996 | controller | ok: [instance] => changed=false
2025-10-08 17:35:48.391546 | controller |   msg: All assertions passed
2025-10-08 17:35:48.391593 | controller |
2025-10-08 17:35:48.391600 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 17:35:48.391606 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.023)       0:00:11.014 *****
2025-10-08 17:35:48.391616 | controller | ok: [instance]
2025-10-08 17:35:48.614362 | controller |
2025-10-08 17:35:48.614410 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 17:35:48.614419 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.160)       0:00:11.174 *****
2025-10-08 17:35:48.614431 | controller | ok: [instance]
2025-10-08 17:35:48.647638 | controller |
2025-10-08 17:35:48.647688 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 17:35:48.647711 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.222)       0:00:11.397 *****
2025-10-08 17:35:48.647725 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 17:35:48.647760 | controller |
2025-10-08 17:35:48.647789 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 17:35:48.647912 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.033)       0:00:11.431 *****
2025-10-08 17:35:48.671586 | controller | ok: [instance] => changed=false
2025-10-08 17:35:48.852371 | controller |   msg: All assertions passed
2025-10-08 17:35:48.852415 | controller |
2025-10-08 17:35:48.852423 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 17:35:48.852429 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.023)       0:00:11.454 *****
2025-10-08 17:35:48.852438 | controller | ok: [instance]
2025-10-08 17:35:49.283979 | controller |
2025-10-08 17:35:49.284024 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 17:35:49.284032 | controller | Wednesday 08 October 2025  17:35:48 +0000 (0:00:00.180)       0:00:11.635 *****
2025-10-08 17:35:49.284042 | controller | changed: [instance]
2025-10-08 17:35:49.305551 | controller |
2025-10-08 17:35:49.305583 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 17:35:49.305592 | controller | Wednesday 08 October 2025  17:35:49 +0000 (0:00:00.431)       0:00:12.067 *****
2025-10-08 17:35:49.305602 | controller | ok: [instance]
2025-10-08 17:35:49.637576 | controller |
2025-10-08 17:35:49.637618 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 17:35:49.637625 | controller | Wednesday 08 October 2025  17:35:49 +0000 (0:00:00.021)       0:00:12.088 *****
2025-10-08 17:35:49.637634 | controller | ok: [instance]
2025-10-08 17:35:49.637873 | controller |
2025-10-08 17:35:49.637887 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 17:35:49.950892 | controller | Wednesday 08 October 2025  17:35:49 +0000 (0:00:00.332)       0:00:12.421 *****
2025-10-08 17:35:49.950992 | controller | ok: [instance]
2025-10-08 17:35:50.306469 | controller |
2025-10-08 17:35:50.306540 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 17:35:50.306552 | controller | Wednesday 08 October 2025  17:35:49 +0000 (0:00:00.312)       0:00:12.734 *****
2025-10-08 17:35:50.306563 | controller | ok: [instance]
2025-10-08 17:35:50.334480 | controller |
2025-10-08 17:35:50.334498 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 17:35:50.334525 | controller | Wednesday 08 October 2025  17:35:50 +0000 (0:00:00.355)       0:00:13.089 *****
2025-10-08 17:35:50.334536 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 17:35:50.360554 | controller |
2025-10-08 17:35:50.360571 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 17:35:50.360578 | controller | Wednesday 08 October 2025  17:35:50 +0000 (0:00:00.028)       0:00:13.118 *****
2025-10-08 17:35:50.360586 | controller | ok: [instance] => changed=false
2025-10-08 17:35:50.360606 | controller |   msg: All assertions passed
2025-10-08 17:35:50.360611 | controller |
2025-10-08 17:35:50.360623 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 17:35:50.360630 | controller | Wednesday 08 October 2025  17:35:50 +0000 (0:00:00.026)       0:00:13.144 *****
2025-10-08 17:35:50.536087 | controller | ok: [instance]
2025-10-08 17:35:50.553492 | controller |
2025-10-08 17:35:50.553533 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 17:35:50.553543 | controller | Wednesday 08 October 2025  17:35:50 +0000 (0:00:00.175)       0:00:13.319 *****
2025-10-08 17:35:50.553553 | controller | ok: [instance]
2025-10-08 17:35:51.013173 | controller |
2025-10-08 17:35:51.013227 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 17:35:51.013245 | controller | Wednesday 08 October 2025  17:35:50 +0000 (0:00:00.017)       0:00:13.337 *****
2025-10-08 17:35:51.013260 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 17:35:51.065580 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 17:35:51.065607 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 17:35:51.065616 | controller |
2025-10-08 17:35:51.065623 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 17:35:51.065630 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.459)       0:00:13.796 *****
2025-10-08 17:35:51.065640 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 17:35:51.065664 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 17:35:51.065674 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 17:35:51.065951 | controller |
2025-10-08 17:35:51.245462 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 17:35:51.245523 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.053)       0:00:13.849 *****
2025-10-08 17:35:51.245539 | controller | ok: [instance]
2025-10-08 17:35:51.592636 | controller |
2025-10-08 17:35:51.592679 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 17:35:51.592687 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.179)       0:00:14.028 *****
2025-10-08 17:35:51.592696 | controller | changed: [instance]
2025-10-08 17:35:51.617388 | controller |
2025-10-08 17:35:51.617410 | controller | TASK [Regenerate edpm-nodeset-values] ******************************************
2025-10-08 17:35:51.617418 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.347)       0:00:14.375 *****
2025-10-08 17:35:51.617426 | controller |
2025-10-08 17:35:51.642682 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 17:35:51.642724 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.024)       0:00:14.400 *****
2025-10-08 17:35:51.642738 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 17:35:51.668481 | controller |
2025-10-08 17:35:51.668517 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 17:35:51.668544 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.025)       0:00:14.426 *****
2025-10-08 17:35:51.668553 | controller | ok: [instance] => changed=false
2025-10-08 17:35:51.836616 | controller |   msg: All assertions passed
2025-10-08 17:35:51.836653 | controller |
2025-10-08 17:35:51.836660 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 17:35:51.836666 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.025)       0:00:14.451 *****
2025-10-08 17:35:51.836675 | controller | ok: [instance]
2025-10-08 17:35:51.858660 | controller |
2025-10-08 17:35:51.858681 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 17:35:51.858689 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.168)       0:00:14.619 *****
2025-10-08 17:35:51.858699 | controller | ok: [instance] => changed=false
2025-10-08 17:35:52.021829 | controller |   msg: All assertions passed
2025-10-08 17:35:52.021867 | controller |
2025-10-08 17:35:52.021875 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 17:35:52.021881 | controller | Wednesday 08 October 2025  17:35:51 +0000 (0:00:00.022)       0:00:14.642 *****
2025-10-08 17:35:52.021891 | controller | ok: [instance]
2025-10-08 17:35:52.212892 | controller |
2025-10-08 17:35:52.212913 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 17:35:52.212920 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.163)       0:00:14.805 *****
2025-10-08 17:35:52.212928 | controller | ok: [instance]
2025-10-08 17:35:52.246074 | controller |
2025-10-08 17:35:52.246091 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 17:35:52.246098 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.191)       0:00:14.996 *****
2025-10-08 17:35:52.246106 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-10-08 17:35:52.269596 | controller |
2025-10-08 17:35:52.269616 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-10-08 17:35:52.269625 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.033)       0:00:15.029 *****
2025-10-08 17:35:52.269634 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-10-08 17:35:52.269811 | controller |
2025-10-08 17:35:52.269830 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-10-08 17:35:52.301398 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.023)       0:00:15.053 *****
2025-10-08 17:35:52.301423 | controller | ok: [instance] => changed=false
2025-10-08 17:35:52.326046 | controller |   msg: All assertions passed
2025-10-08 17:35:52.326061 | controller |
2025-10-08 17:35:52.326068 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-10-08 17:35:52.326073 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.031)       0:00:15.084 *****
2025-10-08 17:35:52.326081 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-10-08 17:35:52.342599 | controller |
2025-10-08 17:35:52.342621 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-10-08 17:35:52.342630 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.024)       0:00:15.109 *****
2025-10-08 17:35:52.342641 | controller | skipping: [instance]
2025-10-08 17:35:52.342667 | controller |
2025-10-08 17:35:52.342678 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-10-08 17:35:52.342780 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.016)       0:00:15.126 *****
2025-10-08 17:35:52.362964 | controller | ok: [instance]
2025-10-08 17:35:52.389581 | controller |
2025-10-08 17:35:52.389607 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-10-08 17:35:52.389616 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.020)       0:00:15.146 *****
2025-10-08 17:35:52.389627 | controller | ok: [instance] => changed=false
2025-10-08 17:35:52.564408 | controller |   msg: All assertions passed
2025-10-08 17:35:52.564447 | controller |
2025-10-08 17:35:52.564455 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 17:35:52.564461 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.026)       0:00:15.173 *****
2025-10-08 17:35:52.564470 | controller | ok: [instance]
2025-10-08 17:35:52.946317 | controller |
2025-10-08 17:35:52.946358 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 17:35:52.946365 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.174)       0:00:15.347 *****
2025-10-08 17:35:52.946375 | controller | ok: [instance]
2025-10-08 17:35:52.969444 | controller |
2025-10-08 17:35:52.969475 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 17:35:52.969483 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.381)       0:00:15.729 *****
2025-10-08 17:35:52.969494 | controller | ok: [instance]
2025-10-08 17:35:53.292500 | controller |
2025-10-08 17:35:53.292564 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 17:35:53.292572 | controller | Wednesday 08 October 2025  17:35:52 +0000 (0:00:00.023)       0:00:15.752 *****
2025-10-08 17:35:53.292588 | controller | ok: [instance]
2025-10-08 17:35:53.605434 | controller |
2025-10-08 17:35:53.605478 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 17:35:53.605486 | controller | Wednesday 08 October 2025  17:35:53 +0000 (0:00:00.322)       0:00:16.075 *****
2025-10-08 17:35:53.605497 | controller | ok: [instance]
2025-10-08 17:35:53.933738 | controller |
2025-10-08 17:35:53.933778 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 17:35:53.933786 | controller | Wednesday 08 October 2025  17:35:53 +0000 (0:00:00.312)       0:00:16.388 *****
2025-10-08 17:35:53.933796 | controller | ok: [instance]
2025-10-08 17:35:53.960668 | controller |
2025-10-08 17:35:53.960698 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 17:35:53.960707 | controller | Wednesday 08 October 2025  17:35:53 +0000 (0:00:00.328)       0:00:16.716 *****
2025-10-08 17:35:53.960718 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 17:35:53.985474 | controller |
2025-10-08 17:35:53.985490 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 17:35:53.985496 | controller | Wednesday 08 October 2025  17:35:53 +0000 (0:00:00.027)       0:00:16.744 *****
2025-10-08 17:35:53.985518 | controller | ok: [instance] => changed=false
2025-10-08 17:35:54.159153 | controller |   msg: All assertions passed
2025-10-08 17:35:54.159187 | controller |
2025-10-08 17:35:54.159195 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 17:35:54.159200 | controller | Wednesday 08 October 2025  17:35:53 +0000 (0:00:00.024)       0:00:16.769 *****
2025-10-08 17:35:54.159209 | controller | ok: [instance]
2025-10-08 17:35:54.176759 | controller |
2025-10-08 17:35:54.176777 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 17:35:54.176783 | controller | Wednesday 08 October 2025  17:35:54 +0000 (0:00:00.173)       0:00:16.942 *****
2025-10-08 17:35:54.176791 | controller | ok: [instance]
2025-10-08 17:35:54.632133 | controller |
2025-10-08 17:35:54.632172 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 17:35:54.632180 | controller | Wednesday 08 October 2025  17:35:54 +0000 (0:00:00.017)       0:00:16.960 *****
2025-10-08 17:35:54.632189 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-10-08 17:35:54.700246 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-10-08 17:35:54.700293 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-10-08 17:35:54.700299 | controller |
2025-10-08 17:35:54.700305 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 17:35:54.700310 | controller | Wednesday 08 October 2025  17:35:54 +0000 (0:00:00.454)       0:00:17.415 *****
2025-10-08 17:35:54.700320 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 17:35:54.882566 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 17:35:54.882605 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 17:35:54.882612 | controller |
2025-10-08 17:35:54.882618 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 17:35:54.882623 | controller | Wednesday 08 October 2025  17:35:54 +0000 (0:00:00.067)       0:00:17.483 *****
2025-10-08 17:35:54.882631 | controller | ok: [instance]
2025-10-08 17:35:54.882652 | controller |
2025-10-08 17:35:54.882658 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 17:35:54.882664 | controller | Wednesday 08 October 2025  17:35:54 +0000 (0:00:00.182)       0:00:17.666 *****
2025-10-08 17:35:55.208532 | controller | ok: [instance]
2025-10-08 17:35:55.547248 | controller |
2025-10-08 17:35:55.547296 | controller | TASK [Copy generated values to correct location] *******************************
2025-10-08 17:35:55.547309 | controller | Wednesday 08 October 2025  17:35:55 +0000 (0:00:00.325)       0:00:17.991 *****
2025-10-08 17:35:55.547320 | controller | changed: [instance] => (item={'key': 'network-values', 'value': 'examples/va/hci/control-plane/networking/nncp/values.yaml'})
2025-10-08 17:35:56.064795 | controller | changed: [instance] => (item={'key': 'edpm-nodeset-values', 'value': 'examples/va/hci/edpm-pre-ceph/nodeset/values.yaml'})
2025-10-08 17:35:56.064830 | controller |
2025-10-08 17:35:56.064837 | controller | TASK [Ensure kustomize is able to build] ***************************************
2025-10-08 17:35:56.064843 | controller | Wednesday 08 October 2025  17:35:55 +0000 (0:00:00.338)       0:00:18.330 *****
2025-10-08 17:35:56.064858 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-10-08 17:35:56.064876 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-10-08 17:35:56.067154 | controller |
2025-10-08 17:35:56.124459 | controller | PLAY RECAP *********************************************************************
2025-10-08 17:35:56.124498 | controller | instance                   : ok=107  changed=20   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-10-08 17:35:56.124527 | controller |
2025-10-08 17:35:56.124533 | controller | Wednesday 08 October 2025  17:35:56 +0000 (0:00:00.517)       0:00:18.848 *****
2025-10-08 17:35:56.124539 | controller | ===============================================================================
2025-10-08 17:35:56.124544 | controller | Gathering Facts --------------------------------------------------------- 0.84s
2025-10-08 17:35:56.124548 | controller | Ensure architecture repository is building ------------------------------ 0.71s
2025-10-08 17:35:56.124553 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.57s
2025-10-08 17:35:56.124558 | controller | Ensure kustomize is able to build --------------------------------------- 0.52s
2025-10-08 17:35:56.124563 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.50s
2025-10-08 17:35:56.124568 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.46s
2025-10-08 17:35:56.124572 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.46s
2025-10-08 17:35:56.124577 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.45s
2025-10-08 17:35:56.124582 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.43s
2025-10-08 17:35:56.124587 | controller | Create nova migration keypair ------------------------------------------- 0.40s
2025-10-08 17:35:56.124591 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.38s
2025-10-08 17:35:56.124596 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.38s
2025-10-08 17:35:56.124601 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.37s
2025-10-08 17:35:56.124605 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.36s
2025-10-08 17:35:56.124610 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.35s
2025-10-08 17:35:56.124615 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.34s
2025-10-08 17:35:56.124620 | controller | Copy generated values to correct location ------------------------------- 0.34s
2025-10-08 17:35:56.124624 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.34s
2025-10-08 17:35:56.124629 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.33s
2025-10-08 17:35:56.124634 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.33s
2025-10-08 17:35:56.124643 | controller | INFO     Running default > cleanup
2025-10-08 17:35:56.125077 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-08 17:35:56.125675 | controller | INFO     Writing /tmp/report.html report.
2025-10-08 17:35:56.552238 | controller | changed
2025-10-08 17:35:56.573274 | 
2025-10-08 17:35:56.573323 | PLAY RECAP
2025-10-08 17:35:56.573362 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-08 17:35:56.573383 | 
2025-10-08 17:35:56.632297 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-08 17:35:56.633083 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-08 17:35:57.107921 | 
2025-10-08 17:35:57.108013 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-08 17:35:57.126161 | 
2025-10-08 17:35:57.126232 | TASK [Filter out host if needed]
2025-10-08 17:35:57.133866 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-08 17:35:57.137966 | 
2025-10-08 17:35:57.138029 | TASK [Ensure file is present]
2025-10-08 17:35:57.419790 | controller | ok
2025-10-08 17:35:57.426100 | 
2025-10-08 17:35:57.426174 | TASK [Manage molecule report file]
2025-10-08 17:35:57.950631 | controller | changed
2025-10-08 17:35:57.956105 | 
2025-10-08 17:35:57.956166 | TASK [Check if we get ci-framework-data basedir]
2025-10-08 17:35:58.127011 | controller | ok
2025-10-08 17:35:58.131477 | 
2025-10-08 17:35:58.131535 | TASK [Create ci-framework-data log directory for zuul]
2025-10-08 17:35:58.413524 | controller | changed
2025-10-08 17:35:58.418239 | 
2025-10-08 17:35:58.418298 | TASK [Copy ci-framework interesting files]
2025-10-08 17:35:58.596883 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-08 17:35:58.939743 | controller | changed
2025-10-08 17:35:58.944550 | 
2025-10-08 17:35:58.944619 | TASK [Get SELinux listing]
2025-10-08 17:35:59.468452 | controller | changed
2025-10-08 17:35:59.474074 | 
2025-10-08 17:35:59.474135 | TASK [Generate log index]
2025-10-08 17:36:00.071887 | controller | changed
2025-10-08 17:36:00.076209 | 
2025-10-08 17:36:00.076271 | TASK [Get some env related data]
2025-10-08 17:36:00.563587 | controller | /home/zuul/.local/bin/ansible
2025-10-08 17:36:01.103447 | controller | changed
2025-10-08 17:36:01.108622 | 
2025-10-08 17:36:01.108697 | TASK [Generate list of logs to collect in home directory]
2025-10-08 17:36:01.391939 | controller | ok: All paths examined
2025-10-08 17:36:01.396793 | 
2025-10-08 17:36:01.396850 | LOOP [Copy logs from home directory]
2025-10-08 17:36:01.681136 | controller | changed:
2025-10-08 17:36:01.681305 | controller | {
2025-10-08 17:36:01.681335 | controller |   "atime": 1759944786.007732,
2025-10-08 17:36:01.681355 | controller |   "ctime": 1759944801.8234997,
2025-10-08 17:36:01.681373 | controller |   "dev": 64513,
2025-10-08 17:36:01.681389 | controller |   "gid": 1000,
2025-10-08 17:36:01.681403 | controller |   "gr_name": "zuul",
2025-10-08 17:36:01.681419 | controller |   "inode": 4349057,
2025-10-08 17:36:01.681434 | controller |   "isblk": false,
2025-10-08 17:36:01.681448 | controller |   "ischr": false,
2025-10-08 17:36:01.681462 | controller |   "isdir": false,
2025-10-08 17:36:01.681476 | controller |   "isfifo": false,
2025-10-08 17:36:01.681490 | controller |   "isgid": false,
2025-10-08 17:36:01.681503 | controller |   "islnk": false,
2025-10-08 17:36:01.681516 | controller |   "isreg": true,
2025-10-08 17:36:01.681529 | controller |   "issock": false,
2025-10-08 17:36:01.681542 | controller |   "isuid": false,
2025-10-08 17:36:01.681556 | controller |   "mode": "0644",
2025-10-08 17:36:01.681570 | controller |   "mtime": 1759944801.8234997,
2025-10-08 17:36:01.681584 | controller |   "nlink": 1,
2025-10-08 17:36:01.681599 | controller |   "path": "/home/zuul/ansible.log",
2025-10-08 17:36:01.681616 | controller |   "pw_name": "zuul",
2025-10-08 17:36:01.681631 | controller |   "rgrp": true,
2025-10-08 17:36:01.681657 | controller |   "roth": true,
2025-10-08 17:36:01.681673 | controller |   "rusr": true,
2025-10-08 17:36:01.681688 | controller |   "size": 6749,
2025-10-08 17:36:01.681701 | controller |   "uid": 1000,
2025-10-08 17:36:01.681715 | controller |   "wgrp": false,
2025-10-08 17:36:01.681728 | controller |   "woth": false,
2025-10-08 17:36:01.681744 | controller |   "wusr": true,
2025-10-08 17:36:01.681758 | controller |   "xgrp": false,
2025-10-08 17:36:01.681772 | controller |   "xoth": false,
2025-10-08 17:36:01.681785 | controller |   "xusr": false
2025-10-08 17:36:01.681799 | controller | }
2025-10-08 17:36:01.709580 | 
2025-10-08 17:36:01.709680 | TASK [Copy crio stats log file]
2025-10-08 17:36:01.724024 | controller | skipping: Conditional result was False
2025-10-08 17:36:01.728863 | 
2025-10-08 17:36:01.728934 | TASK [Get SELinux related data]
2025-10-08 17:36:01.928533 | controller | <no matches>
2025-10-08 17:36:02.253077 | controller | ERROR
2025-10-08 17:36:02.253257 | controller | {
2025-10-08 17:36:02.253289 | controller |   "delta": "0:00:00.013712",
2025-10-08 17:36:02.253310 | controller |   "end": "2025-10-08 17:36:01.929493",
2025-10-08 17:36:02.253327 | controller |   "msg": "non-zero return code",
2025-10-08 17:36:02.253343 | controller |   "rc": 1,
2025-10-08 17:36:02.253359 | controller |   "start": "2025-10-08 17:36:01.915781"
2025-10-08 17:36:02.253375 | controller | }
2025-10-08 17:36:02.253396 | controller | ERROR: Ignoring Errors
2025-10-08 17:36:02.258205 | 
2025-10-08 17:36:02.258266 | TASK [Create system configuration directory]
2025-10-08 17:36:02.449409 | controller | changed
2025-10-08 17:36:02.454161 | 
2025-10-08 17:36:02.454221 | TASK [Get some of the system configurations]
2025-10-08 17:36:02.978031 | controller | changed
2025-10-08 17:36:02.982426 | 
2025-10-08 17:36:02.982484 | TASK [Copy generated documentation if available]
2025-10-08 17:36:02.996136 | controller | skipping: Conditional result was False
2025-10-08 17:36:03.000949 | 
2025-10-08 17:36:03.001008 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-08 17:36:03.014429 | controller | skipping: Conditional result was False
2025-10-08 17:36:03.019413 | 
2025-10-08 17:36:03.019470 | TASK [Compress logs bigger than 2MB]
2025-10-08 17:36:03.545606 | controller | changed
2025-10-08 17:36:03.550825 | 
2025-10-08 17:36:03.550885 | TASK [Copy files from workspace on node]
2025-10-08 17:36:03.569585 | controller | ok
2025-10-08 17:36:03.590498 | 
2025-10-08 17:36:03.590558 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-08 17:36:03.605111 | controller | skipping: Conditional result was False
2025-10-08 17:36:03.610603 | 
2025-10-08 17:36:03.610680 | TASK [fetch-output : Set log path for single node]
2025-10-08 17:36:03.639296 | controller | ok
2025-10-08 17:36:03.643951 | 
2025-10-08 17:36:03.644015 | LOOP [fetch-output : Ensure local output dirs]
2025-10-08 17:36:03.836411 | controller -> localhost | ok: "/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/logs"
2025-10-08 17:36:03.836679 | controller -> localhost | changed: All items complete
2025-10-08 17:36:03.837271 | 
2025-10-08 17:36:04.003023 | controller -> localhost | changed: "/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/artifacts"
2025-10-08 17:36:04.166232 | controller -> localhost | changed: "/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/docs"
2025-10-08 17:36:04.183393 | 
2025-10-08 17:36:04.183485 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-08 17:36:04.697136 | controller | changed:
2025-10-08 17:36:04.697310 | controller | .d..t...... ./
2025-10-08 17:36:04.697339 | controller | >f+++++++++ README.html
2025-10-08 17:36:04.697360 | controller | >f+++++++++ ansible-execution.log
2025-10-08 17:36:04.697378 | controller | >f+++++++++ ansible.log
2025-10-08 17:36:04.697395 | controller | >f+++++++++ dmesg.log
2025-10-08 17:36:04.697411 | controller | >f+++++++++ installed-pkgs.log
2025-10-08 17:36:04.697429 | controller | >f+++++++++ python.log
2025-10-08 17:36:04.697446 | controller | >f+++++++++ registries.conf
2025-10-08 17:36:04.697462 | controller | >f+++++++++ report.html
2025-10-08 17:36:04.697480 | controller | >f+++++++++ selinux-denials.log
2025-10-08 17:36:04.697495 | controller | >f+++++++++ selinux-listing.log
2025-10-08 17:36:04.697509 | controller | cd+++++++++ ci-framework-data/
2025-10-08 17:36:04.697524 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-08 17:36:04.697537 | controller | >f+++++++++ ci-framework-data/artifacts/ctlplane.yaml
2025-10-08 17:36:04.697552 | controller | >f+++++++++ ci-framework-data/artifacts/dataplane.yaml
2025-10-08 17:36:04.697567 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key
2025-10-08 17:36:04.697582 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub
2025-10-08 17:36:04.697596 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-ctlplane.yaml
2025-10-08 17:36:04.697609 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-dataplane.yaml
2025-10-08 17:36:04.697623 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-08 17:36:04.697649 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/
2025-10-08 17:36:04.697665 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/
2025-10-08 17:36:04.697681 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 17:36:04.697697 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/
2025-10-08 17:36:04.697712 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 17:36:04.697726 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml.28990.2025-10-08@17:35:51~
2025-10-08 17:36:04.697741 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/
2025-10-08 17:36:04.697755 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/
2025-10-08 17:36:04.697771 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml
2025-10-08 17:36:04.697785 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml
2025-10-08 17:36:04.697800 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml
2025-10-08 17:36:04.697813 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml
2025-10-08 17:36:04.697828 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/
2025-10-08 17:36:04.697847 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml
2025-10-08 17:36:04.697864 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml
2025-10-08 17:36:04.697879 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml.28821.2025-10-08@17:35:49~
2025-10-08 17:36:04.697894 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml
2025-10-08 17:36:04.697925 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml
2025-10-08 17:36:04.697952 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2025-10-08 17:36:04.697971 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2025-10-08 17:36:04.697987 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2025-10-08 17:36:04.698003 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-08 17:36:04.698019 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-08 17:36:04.698034 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2025-10-08 17:36:04.698049 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2025-10-08 17:36:04.698065 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-08 17:36:04.698079 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-08 17:36:04.698094 | controller | cd+++++++++ registries.conf.d/
2025-10-08 17:36:04.698108 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-08 17:36:04.698123 | controller | cd+++++++++ system-config/
2025-10-08 17:36:04.698138 | controller | cd+++++++++ system-config/libvirt/
2025-10-08 17:36:04.698154 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-08 17:36:04.698169 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-08 17:36:05.043948 | controller | changed: .d..t...... ./
2025-10-08 17:36:05.397977 | controller | changed: .d..t...... ./
2025-10-08 17:36:05.410243 | 
2025-10-08 17:36:05.410315 | TASK [Return artifact to Zuul]
2025-10-08 17:36:05.438182 | controller | ok
2025-10-08 17:36:05.455760 | 
2025-10-08 17:36:05.455814 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-08 17:36:05.455924 | 
2025-10-08 17:36:05.455958 | PLAY RECAP
2025-10-08 17:36:05.455998 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-08 17:36:05.456020 | 
2025-10-08 17:36:05.527579 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-08 17:36:05.528304 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-08 17:36:06.027566 | 
2025-10-08 17:36:06.027663 | PLAY [all]
2025-10-08 17:36:06.045633 | 
2025-10-08 17:36:06.045713 | TASK [include_role : fetch-output]
2025-10-08 17:36:06.074111 | controller | ok
2025-10-08 17:36:06.090149 | 
2025-10-08 17:36:06.090230 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-08 17:36:06.133702 | controller | skipping: Conditional result was False
2025-10-08 17:36:06.139036 | 
2025-10-08 17:36:06.139107 | TASK [fetch-output : Set log path for single node]
2025-10-08 17:36:06.166781 | controller | ok
2025-10-08 17:36:06.171588 | 
2025-10-08 17:36:06.171666 | LOOP [fetch-output : Ensure local output dirs]
2025-10-08 17:36:06.467402 | controller -> localhost | ok: "/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/logs"
2025-10-08 17:36:06.634189 | controller -> localhost | ok: "/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/artifacts"
2025-10-08 17:36:06.805407 | controller -> localhost | ok: "/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/docs"
2025-10-08 17:36:06.817887 | 
2025-10-08 17:36:06.818002 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-08 17:36:07.301299 | controller | ok
2025-10-08 17:36:07.301472 | controller | ok: All items complete
2025-10-08 17:36:07.301499 | 
2025-10-08 17:36:07.663988 | controller | ok
2025-10-08 17:36:08.018096 | controller | ok
2025-10-08 17:36:08.036792 | 
2025-10-08 17:36:08.036887 | TASK [include_role : fetch-output-openshift]
2025-10-08 17:36:08.050263 | controller | skipping: Conditional result was False
2025-10-08 17:36:08.055387 | 
2025-10-08 17:36:08.055450 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-08 17:36:08.372493 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.005923
2025-10-08 17:36:08.549349 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006526
2025-10-08 17:36:08.579168 | 
2025-10-08 17:36:08.579253 | PLAY [all]
2025-10-08 17:36:08.592838 | 
2025-10-08 17:36:08.592905 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-08 17:36:08.986258 | controller | changed
2025-10-08 17:36:09.007866 | 
2025-10-08 17:36:09.007961 | PLAY RECAP
2025-10-08 17:36:09.008029 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-08 17:36:09.008056 | 
2025-10-08 17:36:09.076173 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-08 17:36:09.076893 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-08 17:36:09.584267 | 
2025-10-08 17:36:09.584374 | PLAY [localhost]
2025-10-08 17:36:09.600403 | 
2025-10-08 17:36:09.600472 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-08 17:36:09.870938 | localhost | changed
2025-10-08 17:36:09.875104 | 
2025-10-08 17:36:09.875178 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-08 17:36:09.892631 | localhost | ok
2025-10-08 17:36:09.899691 | 
2025-10-08 17:36:09.899756 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-08 17:36:10.170015 | localhost | changed
2025-10-08 17:36:10.175389 | 
2025-10-08 17:36:10.175460 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-08 17:36:10.658740 | localhost | changed
2025-10-08 17:36:10.663749 | 
2025-10-08 17:36:10.663811 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-08 17:36:10.964970 | localhost | Identity added: /var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/tmp/ansible.jlwceh5b (/var/lib/zuul/builds/09d40907f76144ebba846d3c31117df7/work/tmp/ansible.jlwceh5b)
2025-10-08 17:36:10.965116 | localhost | ok: Runtime: 0:00:00.006336
2025-10-08 17:36:10.968881 | 
2025-10-08 17:36:10.968962 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-08 17:36:11.167684 | localhost | ok: Runtime: 0:00:00.004466
2025-10-08 17:36:11.171888 | 
2025-10-08 17:36:11.171974 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-08 17:36:11.209436 | localhost | changed
2025-10-08 17:36:11.213688 | 
2025-10-08 17:36:11.213749 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-08 17:36:11.492888 | localhost | changed
2025-10-08 17:36:11.510428 | 
2025-10-08 17:36:11.510486 | PLAY [localhost]
2025-10-08 17:36:11.520598 | 
2025-10-08 17:36:11.520666 | TASK [Generate bulk log download script]
2025-10-08 17:36:11.537427 | localhost | ok
2025-10-08 17:36:11.548683 | 
2025-10-08 17:36:11.548746 | TASK [local-log-download : Check API endpoint is defined]
2025-10-08 17:36:11.575622 | localhost | ok: All assertions passed
2025-10-08 17:36:11.579551 | 
2025-10-08 17:36:11.579612 | TASK [local-log-download : Create download script]
2025-10-08 17:36:11.886490 | localhost -> localhost | changed
2025-10-08 17:36:11.894097 | 
2025-10-08 17:36:11.894157 | TASK [Register quick-download link]
2025-10-08 17:36:11.910983 | localhost | ok
2025-10-08 17:36:11.940206 | 
2025-10-08 17:36:11.940267 | PLAY [logserver.rdoproject.org]
2025-10-08 17:36:11.948550 | 
2025-10-08 17:36:11.948606 | TASK [Set zuul-log-path fact]
2025-10-08 17:36:11.964377 | logserver.rdoproject.org | ok
2025-10-08 17:36:11.972187 | 
2025-10-08 17:36:11.972249 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-08 17:36:11.988432 | logserver.rdoproject.org | ok
2025-10-08 17:36:11.993174 | 
2025-10-08 17:36:11.993234 | TASK [upload-logs : Create log directories]
2025-10-08 17:36:13.850435 | logserver.rdoproject.org | changed
2025-10-08 17:36:13.853347 | 
2025-10-08 17:36:13.853408 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-08 17:36:14.050159 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.003682
2025-10-08 17:36:14.054087 | 
2025-10-08 17:36:14.054145 | TASK [upload-logs : Upload logs to log server]
2025-10-08 17:36:16.126995 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-08 17:36:16.129711 | 
2025-10-08 17:36:16.129786 | LOOP [upload-logs : Compress console log and json output]
2025-10-08 17:36:16.163649 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 17:36:16.171217 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 17:36:16.177431 | 
2025-10-08 17:36:16.177521 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-08 17:36:16.207665 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 17:36:16.207861 | 
2025-10-08 17:36:16.210852 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 17:36:16.223771 | 
2025-10-08 17:36:16.223859 | LOOP [upload-logs : Upload console log and json output]