2025-12-05 09:11:32.431240 | Job console starting...
2025-12-05 09:11:32.642538 | Updating repositories
2025-12-05 09:11:33.354406 | Preparing job workspace
2025-12-05 09:11:40.911281 | Running Ansible setup...
2025-12-05 09:11:43.976283 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-05 09:11:44.586899 | 
2025-12-05 09:11:44.587083 | PLAY [localhost]
2025-12-05 09:11:44.599213 | 
2025-12-05 09:11:44.599288 | TASK [Gathering Facts]
2025-12-05 09:11:45.500209 | localhost | ok
2025-12-05 09:11:45.513709 | 
2025-12-05 09:11:45.513817 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-12-05 09:11:45.872691 | localhost -> localhost | changed
2025-12-05 09:11:45.878201 | 
2025-12-05 09:11:45.878278 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-12-05 09:11:46.610366 | localhost -> localhost | changed
2025-12-05 09:11:46.619054 | 
2025-12-05 09:11:46.619120 | TASK [Setup log path fact]
2025-12-05 09:11:46.638416 | localhost | ok
2025-12-05 09:11:46.650953 | 
2025-12-05 09:11:46.651022 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-05 09:11:46.678630 | localhost | ok
2025-12-05 09:11:46.685937 | 
2025-12-05 09:11:46.686006 | TASK [emit-job-header : Print job information]
2025-12-05 09:11:46.713086 | # Job Information
2025-12-05 09:11:46.713203 | Ansible Version: 2.15.12
2025-12-05 09:11:46.713233 | Job: cifmw-molecule-ci_gen_kustomize_values
2025-12-05 09:11:46.713257 | Pipeline: github-check
2025-12-05 09:11:46.713278 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-12-05 09:11:46.713297 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3476
2025-12-05 09:11:46.713317 | Log URL (when completed): https://logserver.rdoproject.org/f68/rdoproject.org/f682485f07f041c3a6e1f5d451191645/
2025-12-05 09:11:46.713336 | Event ID: 42c64e20-d1ba-11f0-8eed-560f67e4e13a
2025-12-05 09:11:46.716935 | 
2025-12-05 09:11:46.717000 | LOOP [emit-job-header : Print node information]
2025-12-05 09:11:46.807830 | localhost | ok:
2025-12-05 09:11:46.808081 | localhost | # Node Information
2025-12-05 09:11:46.808114 | localhost | Inventory Hostname: controller
2025-12-05 09:11:46.808140 | localhost | Hostname: np0005546649
2025-12-05 09:11:46.808160 | localhost | Username: zuul
2025-12-05 09:11:46.808182 | localhost | Distro: CentOS 9
2025-12-05 09:11:46.808201 | localhost | Provider: ibm-bm4-nodepool
2025-12-05 09:11:46.808219 | localhost | Region: regionOne
2025-12-05 09:11:46.808235 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-12-05 09:11:46.808252 | localhost | Product Name: OpenStack Compute
2025-12-05 09:11:46.808269 | localhost | Interface IP: 192.168.26.48
2025-12-05 09:11:46.841269 | 
2025-12-05 09:11:46.841523 | PLAY [all]
2025-12-05 09:11:46.848399 | 
2025-12-05 09:11:46.848468 | TASK [Gather network facts]
2025-12-05 09:11:47.215708 | controller | ok
2025-12-05 09:11:47.230280 | 
2025-12-05 09:11:47.230348 | TASK [include_role : start-zuul-console]
2025-12-05 09:11:47.248559 | controller | ok
2025-12-05 09:11:47.261114 | 
2025-12-05 09:11:47.261181 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-12-05 09:11:47.552939 | controller | ok
2025-12-05 09:11:47.561996 | 
2025-12-05 09:11:47.562060 | TASK [include_role : add-build-sshkey]
2025-12-05 09:11:47.580253 | controller | ok
2025-12-05 09:11:47.593232 | 
2025-12-05 09:11:47.593309 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-12-05 09:11:47.790743 | controller -> localhost | ok
2025-12-05 09:11:47.796324 | 
2025-12-05 09:11:47.796389 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-12-05 09:11:47.814697 | controller | ok
2025-12-05 09:11:47.828777 | controller | included: /var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-12-05 09:11:47.834447 | 
2025-12-05 09:11:47.834508 | TASK [add-build-sshkey : Create Temp SSH key]
2025-12-05 09:11:48.263974 | controller -> localhost | Generating public/private rsa key pair.
2025-12-05 09:11:48.264203 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/f682485f07f041c3a6e1f5d451191645_id_rsa.
2025-12-05 09:11:48.264238 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/f682485f07f041c3a6e1f5d451191645_id_rsa.pub.
2025-12-05 09:11:48.264263 | controller -> localhost | The key fingerprint is:
2025-12-05 09:11:48.264284 | controller -> localhost | SHA256:2nig3g/gIzMUmrfNjGBpU7tFA2zBUf2R9HTQASOCV6U zuul-build-sshkey
2025-12-05 09:11:48.264304 | controller -> localhost | The key's randomart image is:
2025-12-05 09:11:48.264324 | controller -> localhost | +---[RSA 3072]----+
2025-12-05 09:11:48.264342 | controller -> localhost | |  o++.o.o+o*+o.  |
2025-12-05 09:11:48.264362 | controller -> localhost | |   +.. o.o= o.   |
2025-12-05 09:11:48.264380 | controller -> localhost | |  o. o. .E..     |
2025-12-05 09:11:48.264398 | controller -> localhost | | oo.o .  .       |
2025-12-05 09:11:48.264416 | controller -> localhost | |+=o.... S        |
2025-12-05 09:11:48.264435 | controller -> localhost | |o+.Boo =         |
2025-12-05 09:11:48.264454 | controller -> localhost | |  *.B + o        |
2025-12-05 09:11:48.264472 | controller -> localhost | |   = o o         |
2025-12-05 09:11:48.264491 | controller -> localhost | |    . ...        |
2025-12-05 09:11:48.264508 | controller -> localhost | +----[SHA256]-----+
2025-12-05 09:11:48.264555 | controller -> localhost | ok: Runtime: 0:00:00.111900
2025-12-05 09:11:48.270516 | 
2025-12-05 09:11:48.270576 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-12-05 09:11:48.320031 | controller | ok
2025-12-05 09:11:48.330951 | controller | included: /var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-12-05 09:11:48.339071 | 
2025-12-05 09:11:48.339135 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-12-05 09:11:48.363321 | controller | skipping: Conditional result was False
2025-12-05 09:11:48.368964 | 
2025-12-05 09:11:48.369031 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-12-05 09:11:48.746823 | controller | changed
2025-12-05 09:11:48.753869 | 
2025-12-05 09:11:48.753985 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-12-05 09:11:48.973381 | controller | ok
2025-12-05 09:11:48.978968 | 
2025-12-05 09:11:48.979043 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-12-05 09:11:49.542970 | controller | changed
2025-12-05 09:11:49.548358 | 
2025-12-05 09:11:49.548425 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-12-05 09:11:50.105757 | controller | changed
2025-12-05 09:11:50.110882 | 
2025-12-05 09:11:50.110972 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-12-05 09:11:50.125499 | controller | skipping: Conditional result was False
2025-12-05 09:11:50.131524 | 
2025-12-05 09:11:50.131591 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-12-05 09:11:50.462779 | controller -> localhost | changed
2025-12-05 09:11:50.473435 | 
2025-12-05 09:11:50.473512 | TASK [add-build-sshkey : Add back temp key]
2025-12-05 09:11:50.705184 | controller -> localhost | Identity added: /var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/f682485f07f041c3a6e1f5d451191645_id_rsa (zuul-build-sshkey)
2025-12-05 09:11:50.705510 | controller -> localhost | ok: Runtime: 0:00:00.010641
2025-12-05 09:11:50.712267 | 
2025-12-05 09:11:50.712366 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-12-05 09:11:51.009981 | controller | ok
2025-12-05 09:11:51.014616 | 
2025-12-05 09:11:51.014678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-12-05 09:11:51.038502 | controller | skipping: Conditional result was False
2025-12-05 09:11:51.048001 | 
2025-12-05 09:11:51.048063 | TASK [include_role : validate-host]
2025-12-05 09:11:51.076609 | controller | ok
2025-12-05 09:11:51.097052 | 
2025-12-05 09:11:51.097125 | TASK [validate-host : Define zuul_info_dir fact]
2025-12-05 09:11:51.136989 | controller | ok
2025-12-05 09:11:51.143324 | 
2025-12-05 09:11:51.143390 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-12-05 09:11:51.359171 | controller -> localhost | ok
2025-12-05 09:11:51.365035 | 
2025-12-05 09:11:51.365098 | TASK [validate-host : Collect information about the host]
2025-12-05 09:11:51.991508 | controller | ok
2025-12-05 09:11:51.999705 | 
2025-12-05 09:11:51.999771 | TASK [validate-host : Sanitize hostname]
2025-12-05 09:11:52.080345 | controller | ok
2025-12-05 09:11:52.086586 | 
2025-12-05 09:11:52.086647 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-12-05 09:11:52.539440 | controller -> localhost | changed
2025-12-05 09:11:52.544470 | 
2025-12-05 09:11:52.544532 | TASK [validate-host : Collect information about zuul worker]
2025-12-05 09:11:52.856852 | controller | ok
2025-12-05 09:11:52.862344 | 
2025-12-05 09:11:52.862408 | TASK [validate-host : Write out all zuul information for each host]
2025-12-05 09:11:53.274220 | controller -> localhost | changed
2025-12-05 09:11:53.284154 | 
2025-12-05 09:11:53.284219 | TASK [include_role : prepare-workspace-openshift]
2025-12-05 09:11:53.300045 | controller | skipping: Conditional result was False
2025-12-05 09:11:53.305029 | 
2025-12-05 09:11:53.305091 | TASK [include_role : remove-zuul-sshkey]
2025-12-05 09:11:53.318632 | controller | skipping: Conditional result was False
2025-12-05 09:11:53.324197 | 
2025-12-05 09:11:53.324264 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-12-05 09:11:53.516468 | controller | ok: "logs"
2025-12-05 09:11:53.516749 | controller | ok: All items complete
2025-12-05 09:11:53.516781 | 
2025-12-05 09:11:53.686823 | controller | ok: "artifacts"
2025-12-05 09:11:53.852942 | controller | ok: "docs"
2025-12-05 09:11:53.868276 | 
2025-12-05 09:11:53.868348 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-12-05 09:11:54.057170 | controller | changed: "logs"
2025-12-05 09:11:54.228219 | controller | changed: "artifacts"
2025-12-05 09:11:54.388580 | controller | changed: "docs"
2025-12-05 09:11:54.412836 | 
2025-12-05 09:11:54.412937 | PLAY RECAP
2025-12-05 09:11:54.412988 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-05 09:11:54.413018 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-05 09:11:54.413038 | 
2025-12-05 09:11:54.488527 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-12-05 09:11:54.491118 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-05 09:11:55.057359 | 
2025-12-05 09:11:55.057485 | PLAY [all]
2025-12-05 09:11:55.077089 | 
2025-12-05 09:11:55.077165 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-05 09:11:55.126508 | controller | ok
2025-12-05 09:11:55.131544 | 
2025-12-05 09:11:55.131626 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-05 09:11:55.515362 | controller | changed
2025-12-05 09:11:55.521216 | 
2025-12-05 09:11:55.521292 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-05 09:11:56.341411 | controller | changed
2025-12-05 09:11:56.351776 | 
2025-12-05 09:11:56.351933 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-12-05 09:11:56.730372 | controller | changed:
2025-12-05 09:11:56.730799 | controller | {
2025-12-05 09:11:56.730868 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-12-05 09:11:56.730931 | controller | }
2025-12-05 09:11:56.929572 | controller | changed:
2025-12-05 09:11:56.929778 | controller | {
2025-12-05 09:11:56.929831 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-12-05 09:11:56.929858 | controller | }
2025-12-05 09:11:57.129292 | controller | changed:
2025-12-05 09:11:57.129504 | controller | {
2025-12-05 09:11:57.129534 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-12-05 09:11:57.129556 | controller | }
2025-12-05 09:11:57.331649 | controller | changed:
2025-12-05 09:11:57.331797 | controller | {
2025-12-05 09:11:57.331837 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-12-05 09:11:57.331875 | controller | }
2025-12-05 09:11:57.532044 | controller | changed:
2025-12-05 09:11:57.532352 | controller | {
2025-12-05 09:11:57.532379 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-12-05 09:11:57.532400 | controller | }
2025-12-05 09:11:57.735663 | controller | changed:
2025-12-05 09:11:57.735829 | controller | {
2025-12-05 09:11:57.735859 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-12-05 09:11:57.735881 | controller | }
2025-12-05 09:11:57.943263 | controller | changed:
2025-12-05 09:11:57.943389 | controller | {
2025-12-05 09:11:57.943416 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-12-05 09:11:57.943438 | controller | }
2025-12-05 09:11:58.147692 | controller | changed:
2025-12-05 09:11:58.147883 | controller | {
2025-12-05 09:11:58.147937 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-12-05 09:11:58.147965 | controller | }
2025-12-05 09:11:58.352025 | controller | changed:
2025-12-05 09:11:58.352262 | controller | {
2025-12-05 09:11:58.352290 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-12-05 09:11:58.352314 | controller | }
2025-12-05 09:11:58.554317 | controller | changed:
2025-12-05 09:11:58.554452 | controller | {
2025-12-05 09:11:58.554477 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-12-05 09:11:58.554497 | controller | }
2025-12-05 09:11:58.757975 | controller | changed:
2025-12-05 09:11:58.758103 | controller | {
2025-12-05 09:11:58.758129 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-12-05 09:11:58.758148 | controller | }
2025-12-05 09:11:59.013266 | controller | changed:
2025-12-05 09:11:59.013382 | controller | {
2025-12-05 09:11:59.013410 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-12-05 09:11:59.013430 | controller | }
2025-12-05 09:11:59.190270 | controller | changed:
2025-12-05 09:11:59.190407 | controller | {
2025-12-05 09:11:59.190435 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-12-05 09:11:59.190457 | controller | }
2025-12-05 09:11:59.392704 | controller | changed:
2025-12-05 09:11:59.392872 | controller | {
2025-12-05 09:11:59.392902 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-12-05 09:11:59.392950 | controller | }
2025-12-05 09:11:59.597309 | controller | changed:
2025-12-05 09:11:59.597442 | controller | {
2025-12-05 09:11:59.597468 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-12-05 09:11:59.597489 | controller | }
2025-12-05 09:11:59.799810 | controller | changed:
2025-12-05 09:11:59.800007 | controller | {
2025-12-05 09:11:59.800036 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-12-05 09:11:59.800058 | controller | }
2025-12-05 09:12:00.000084 | controller | changed:
2025-12-05 09:12:00.000180 | controller | {
2025-12-05 09:12:00.000207 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-12-05 09:12:00.000229 | controller | }
2025-12-05 09:12:00.201435 | controller | changed:
2025-12-05 09:12:00.201542 | controller | {
2025-12-05 09:12:00.201571 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-12-05 09:12:00.201602 | controller | }
2025-12-05 09:12:00.402876 | controller | changed:
2025-12-05 09:12:00.403013 | controller | {
2025-12-05 09:12:00.403043 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-12-05 09:12:00.403064 | controller | }
2025-12-05 09:12:00.605587 | controller | changed:
2025-12-05 09:12:00.605716 | controller | {
2025-12-05 09:12:00.605744 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-12-05 09:12:00.605765 | controller | }
2025-12-05 09:12:00.810056 | controller | changed:
2025-12-05 09:12:00.810175 | controller | {
2025-12-05 09:12:00.810201 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-12-05 09:12:00.810221 | controller | }
2025-12-05 09:12:01.012735 | controller | changed:
2025-12-05 09:12:01.012860 | controller | {
2025-12-05 09:12:01.012887 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-12-05 09:12:01.012927 | controller | }
2025-12-05 09:12:01.220999 | controller | changed:
2025-12-05 09:12:01.221177 | controller | {
2025-12-05 09:12:01.221203 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-12-05 09:12:01.221226 | controller | }
2025-12-05 09:12:01.426749 | controller | changed:
2025-12-05 09:12:01.426978 | controller | {
2025-12-05 09:12:01.427008 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-12-05 09:12:01.427029 | controller | }
2025-12-05 09:12:01.629496 | controller | changed:
2025-12-05 09:12:01.629634 | controller | {
2025-12-05 09:12:01.629661 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-12-05 09:12:01.629692 | controller | }
2025-12-05 09:12:01.843616 | controller | changed:
2025-12-05 09:12:01.843816 | controller | {
2025-12-05 09:12:01.843861 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-12-05 09:12:01.843887 | controller | }
2025-12-05 09:12:01.864117 | 
2025-12-05 09:12:01.864280 | TASK [Set timezone to UTC]
2025-12-05 09:12:02.248384 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-12-05 09:12:02.253256 | 
2025-12-05 09:12:02.253330 | TASK [Create nodepool directory]
2025-12-05 09:12:02.448599 | controller | changed
2025-12-05 09:12:02.454405 | 
2025-12-05 09:12:02.454480 | TASK [Create nodepool sub_nodes file]
2025-12-05 09:12:02.920391 | controller | changed
2025-12-05 09:12:02.925479 | 
2025-12-05 09:12:02.925579 | TASK [Create nodepool sub_nodes_private file]
2025-12-05 09:12:03.395386 | controller | changed
2025-12-05 09:12:03.401506 | 
2025-12-05 09:12:03.401576 | LOOP [Populate nodepool sub_nodes file]
2025-12-05 09:12:03.441808 | 
2025-12-05 09:12:03.442032 | LOOP [Populate nodepool sub_nodes_private file]
2025-12-05 09:12:03.475622 | 
2025-12-05 09:12:03.475794 | TASK [Create nodepool primary file]
2025-12-05 09:12:03.500127 | controller | skipping: Conditional result was False
2025-12-05 09:12:03.505529 | 
2025-12-05 09:12:03.505603 | TASK [Create nodepool node_private for this node]
2025-12-05 09:12:04.022310 | controller | changed
2025-12-05 09:12:04.028005 | 
2025-12-05 09:12:04.028075 | LOOP [Copy ssh keys to nodepool directory]
2025-12-05 09:12:04.397632 | controller | ok: Item: id_rsa Runtime: 0:00:00.004125
2025-12-05 09:12:04.397841 | 
2025-12-05 09:12:04.568121 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004021
2025-12-05 09:12:04.577233 | 
2025-12-05 09:12:04.577347 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-12-05 09:12:05.090503 | controller | changed
2025-12-05 09:12:05.096704 | 
2025-12-05 09:12:05.096771 | TASK [Validate sudoers config after edits]
2025-12-05 09:12:05.307547 | controller | /etc/sudoers: parsed OK
2025-12-05 09:12:05.307629 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-12-05 09:12:05.307640 | controller | /etc/sudoers.d/zuul: parsed OK
2025-12-05 09:12:05.307646 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-12-05 09:12:05.622607 | controller | ok: Runtime: 0:00:00.004657
2025-12-05 09:12:05.628250 | 
2025-12-05 09:12:05.628322 | TASK [Show the environment passed in to job shell scripts]
2025-12-05 09:12:05.837665 | controller | SHELL=/bin/bash
2025-12-05 09:12:05.837729 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-12-05 09:12:05.837739 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-12-05 09:12:05.837747 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/76/3476/28f10cad22dc58ce4bf4f1c703524f8f196af456
2025-12-05 09:12:05.837753 | controller | PWD=/home/zuul
2025-12-05 09:12:05.837766 | controller | ZUUL_PIPELINE=github-check
2025-12-05 09:12:05.837782 | controller | LOGNAME=zuul
2025-12-05 09:12:05.837829 | controller | XDG_SESSION_TYPE=tty
2025-12-05 09:12:05.837839 | controller | _=/usr/bin/env
2025-12-05 09:12:05.837845 | controller | MOTD_SHOWN=pam
2025-12-05 09:12:05.837851 | controller | HOME=/home/zuul
2025-12-05 09:12:05.837856 | controller | LANG=en_US.UTF-8
2025-12-05 09:12:05.837862 | controller | SSH_CONNECTION=192.168.26.12 42070 192.168.26.48 22
2025-12-05 09:12:05.837870 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-12-05 09:12:05.837879 | controller | ZUUL_CHANGE_IDS=3476,28f10cad22dc58ce4bf4f1c703524f8f196af456
2025-12-05 09:12:05.837884 | controller | WORKSPACE=/home/zuul/workspace
2025-12-05 09:12:05.837890 | controller | XDG_SESSION_CLASS=user
2025-12-05 09:12:05.837895 | controller | SELINUX_ROLE_REQUESTED=
2025-12-05 09:12:05.837901 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-12-05 09:12:05.837906 | controller | USER=zuul
2025-12-05 09:12:05.837912 | controller | ZUUL_VOTING=True
2025-12-05 09:12:05.837917 | controller | BUILD_TIMEOUT=1800000
2025-12-05 09:12:05.837922 | controller | SELINUX_USE_CURRENT_RANGE=
2025-12-05 09:12:05.837928 | controller | SHLVL=1
2025-12-05 09:12:05.837933 | controller | ZUUL_PATCHSET=28f10cad22dc58ce4bf4f1c703524f8f196af456
2025-12-05 09:12:05.837939 | controller | XDG_SESSION_ID=1
2025-12-05 09:12:05.837944 | controller | ZUUL_BRANCH=main
2025-12-05 09:12:05.837949 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-12-05 09:12:05.837955 | controller | SSH_CLIENT=192.168.26.12 42070 22
2025-12-05 09:12:05.837961 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-12-05 09:12:05.837966 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-12-05 09:12:05.837972 | controller | which_declare=declare -f
2025-12-05 09:12:05.837978 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-12-05 09:12:05.837983 | controller | SELINUX_LEVEL_REQUESTED=
2025-12-05 09:12:05.837989 | controller | ZUUL_CHANGE=3476
2025-12-05 09:12:05.837994 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-12-05 09:12:05.838000 | controller | ZUUL_UUID=f682485f07f041c3a6e1f5d451191645
2025-12-05 09:12:05.838005 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-12-05 09:12:05.838010 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-12-05 09:12:05.838016 | controller | }
2025-12-05 09:12:06.156784 | controller | ok: Runtime: 0:00:00.005769
2025-12-05 09:12:06.162777 | 
2025-12-05 09:12:06.162853 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-12-05 09:12:06.176515 | controller | skipping: Conditional result was False
2025-12-05 09:12:06.182022 | 
2025-12-05 09:12:06.182087 | TASK [Symlink /home/zuul-worker/workspace]
2025-12-05 09:12:06.707255 | controller | skipping: Conditional result was False
2025-12-05 09:12:06.712827 | 
2025-12-05 09:12:06.712905 | TASK [Ensure legacy workspace directory]
2025-12-05 09:12:06.893974 | controller | changed
2025-12-05 09:12:06.912277 | 
2025-12-05 09:12:06.912337 | PLAY RECAP
2025-12-05 09:12:06.912385 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-12-05 09:12:06.912410 | 
2025-12-05 09:12:06.989350 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-12-05 09:12:06.990199 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-05 09:12:07.500203 | 
2025-12-05 09:12:07.500313 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-12-05 09:12:07.520352 | 
2025-12-05 09:12:07.520435 | TASK [Create zuul-output directory]
2025-12-05 09:12:07.814276 | controller | changed
2025-12-05 09:12:07.819281 | 
2025-12-05 09:12:07.819354 | TASK [Slurp Zuul inventory test]
2025-12-05 09:12:08.097278 | controller -> localhost | ok
2025-12-05 09:12:08.104010 | 
2025-12-05 09:12:08.104096 | TASK [Save zuul inventory]
2025-12-05 09:12:08.841903 | controller | changed
2025-12-05 09:12:08.846709 | 
2025-12-05 09:12:08.846779 | TASK [Save zuul vars without the change_message]
2025-12-05 09:12:09.392590 | controller | changed
2025-12-05 09:12:09.411361 | 
2025-12-05 09:12:09.411451 | PLAY RECAP
2025-12-05 09:12:09.411502 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-12-05 09:12:09.411527 | 
2025-12-05 09:12:09.480823 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-12-05 09:12:09.481629 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-05 09:12:10.037498 | 
2025-12-05 09:12:10.037643 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-12-05 09:12:10.058689 | 
2025-12-05 09:12:10.058760 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-12-05 09:12:10.090114 | controller | ok
2025-12-05 09:12:10.106978 | 
2025-12-05 09:12:10.107068 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-12-05 09:12:10.130241 | controller | skipping: Conditional result was False
2025-12-05 09:12:10.136121 | 
2025-12-05 09:12:10.136198 | TASK [mirror-info-fork : Create /etc/ci]
2025-12-05 09:12:10.448259 | controller | ok
2025-12-05 09:12:10.454496 | 
2025-12-05 09:12:10.454586 | TASK [mirror-info-fork : Install ci_mirror script]
2025-12-05 09:12:11.071192 | controller | ok
2025-12-05 09:12:11.081530 | 
2025-12-05 09:12:11.081622 | TASK [Prepare workspace]
2025-12-05 09:12:11.099945 | controller | ok
2025-12-05 09:12:11.124489 | 
2025-12-05 09:12:11.124568 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-12-05 09:12:11.457927 | controller | ok
2025-12-05 09:12:11.465777 | 
2025-12-05 09:12:11.465862 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-12-05 09:12:14.354988 | controller | Output suppressed because no_log was given
2025-12-05 09:12:14.363746 | 
2025-12-05 09:12:14.363809 | LOOP [Create zuul-output directory]
2025-12-05 09:12:14.549218 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-12-05 09:12:14.705321 | controller | ok: "/home/zuul/zuul-output/logs"
2025-12-05 09:12:14.717428 | 
2025-12-05 09:12:14.717532 | TASK [Install required packages]
2025-12-05 09:13:06.611307 | controller | changed
2025-12-05 09:13:06.616374 | 
2025-12-05 09:13:06.616459 | TASK [Install venv]
2025-12-05 09:14:06.595269 | controller | changed
2025-12-05 09:14:06.657931 | 
2025-12-05 09:14:06.658048 | PLAY RECAP
2025-12-05 09:14:06.658095 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-05 09:14:06.658118 | 
2025-12-05 09:14:06.753247 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-12-05 09:14:06.754234 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-12-05 09:14:07.306303 | 
2025-12-05 09:14:07.306453 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-12-05 09:14:07.328845 | 
2025-12-05 09:14:07.328960 | TASK [Gather required facts]
2025-12-05 09:14:07.858512 | controller | ok
2025-12-05 09:14:07.864036 | 
2025-12-05 09:14:07.864116 | TASK [Load environment var if instructed to]
2025-12-05 09:14:07.888094 | controller | skipping: Conditional result was False
2025-12-05 09:14:07.893730 | 
2025-12-05 09:14:07.893825 | TASK [Ensure group_vars dir exists]
2025-12-05 09:14:08.208149 | controller | ok
2025-12-05 09:14:08.215532 | 
2025-12-05 09:14:08.215647 | TASK [Print related variables]
2025-12-05 09:14:08.244589 | controller | ok:
2025-12-05 09:14:08.244770 | controller | mol_config_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config_local.yml
2025-12-05 09:14:08.244800 | controller | roles_dir: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values
2025-12-05 09:14:08.249579 | 
2025-12-05 09:14:08.249644 | TASK [Run molecule]
2025-12-05 09:14:09.205558 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-12-05 09:14:09.275880 | controller | INFO     Performing prerun with role_name_check=0...
2025-12-05 09:14:27.224011 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.224445 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.224903 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.225341 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.225821 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+28f10cad was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0+28f10cad (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.226269 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.226719 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.227147 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.227610 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.228038 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.228507 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.228913 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.229354 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.229797 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.230238 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-12-05 09:14:27.239300 | controller | INFO     Running default > prepare
2025-12-05 09:14:27.940226 | controller |
2025-12-05 09:14:27.940322 | controller | PLAY [Prepare] *****************************************************************
2025-12-05 09:14:27.940424 | controller |
2025-12-05 09:14:27.940529 | controller | TASK [Gathering Facts] *********************************************************
2025-12-05 09:14:27.940627 | controller | Friday 05 December 2025  09:14:27 +0000 (0:00:00.019)       0:00:00.019 *******
2025-12-05 09:14:28.756745 | controller | ok: [instance]
2025-12-05 09:14:28.756835 | controller |
2025-12-05 09:14:28.756954 | controller | TASK [test_deps : Gather facts if they don't exist] ****************************
2025-12-05 09:14:28.757061 | controller | Friday 05 December 2025  09:14:28 +0000 (0:00:00.816)       0:00:00.836 *******
2025-12-05 09:14:28.773197 | controller | skipping: [instance]
2025-12-05 09:14:28.773322 | controller |
2025-12-05 09:14:28.773462 | controller | TASK [test_deps : Gather variables for each operating system] ******************
2025-12-05 09:14:28.773590 | controller | Friday 05 December 2025  09:14:28 +0000 (0:00:00.016)       0:00:00.852 *******
2025-12-05 09:14:28.803658 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml)
2025-12-05 09:14:28.803777 | controller |
2025-12-05 09:14:28.803906 | controller | TASK [test_deps : Detect mirrors file] *****************************************
2025-12-05 09:14:28.804021 | controller | Friday 05 December 2025  09:14:28 +0000 (0:00:00.030)       0:00:00.883 *******
2025-12-05 09:14:29.075098 | controller | ok: [instance]
2025-12-05 09:14:29.075194 | controller |
2025-12-05 09:14:29.075326 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] ***********
2025-12-05 09:14:29.075445 | controller | Friday 05 December 2025  09:14:29 +0000 (0:00:00.271)       0:00:01.154 *******
2025-12-05 09:14:29.368394 | controller | ok: [instance]
2025-12-05 09:14:29.368456 | controller |
2025-12-05 09:14:29.368578 | controller | TASK [test_deps : Disable ubi 9 repos] *****************************************
2025-12-05 09:14:29.368686 | controller | Friday 05 December 2025  09:14:29 +0000 (0:00:00.293)       0:00:01.447 *******
2025-12-05 09:14:30.048916 | controller | ok: [instance] => (item=ubi-9-appstream)
2025-12-05 09:14:30.049003 | controller | ok: [instance] => (item=ubi-9-baseos)
2025-12-05 09:14:30.049107 | controller | ok: [instance] => (item=ubi-9-codeready-builder)
2025-12-05 09:14:30.049216 | controller |
2025-12-05 09:14:30.049329 | controller | TASK [Deploy repo-setup] *******************************************************
2025-12-05 09:14:30.049437 | controller | Friday 05 December 2025  09:14:30 +0000 (0:00:00.680)       0:00:02.128 *******
2025-12-05 09:14:30.105580 | controller |
2025-12-05 09:14:30.105726 | controller | TASK [repo_setup : Ensure directories are present] *****************************
2025-12-05 09:14:30.105854 | controller | Friday 05 December 2025  09:14:30 +0000 (0:00:00.056)       0:00:02.185 *******
2025-12-05 09:14:30.633275 | controller | changed: [instance] => (item=tmp)
2025-12-05 09:14:30.633364 | controller | changed: [instance] => (item=artifacts/repositories)
2025-12-05 09:14:30.633496 | controller | changed: [instance] => (item=venv/repo_setup)
2025-12-05 09:14:30.633593 | controller |
2025-12-05 09:14:30.633691 | controller | TASK [repo_setup : Make sure git-core package is installed] ********************
2025-12-05 09:14:30.633794 | controller | Friday 05 December 2025  09:14:30 +0000 (0:00:00.527)       0:00:02.712 *******
2025-12-05 09:14:31.417040 | controller | ok: [instance]
2025-12-05 09:14:31.417356 | controller |
2025-12-05 09:14:32.468969 | controller | TASK [repo_setup : Get repo-setup repository] **********************************
2025-12-05 09:14:32.468998 | controller | Friday 05 December 2025  09:14:31 +0000 (0:00:00.783)       0:00:03.496 *******
2025-12-05 09:14:32.469013 | controller | changed: [instance]
2025-12-05 09:14:40.351324 | controller |
2025-12-05 09:14:40.351363 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************
2025-12-05 09:14:40.351372 | controller | Friday 05 December 2025  09:14:32 +0000 (0:00:01.051)       0:00:04.548 *******
2025-12-05 09:14:40.351382 | controller | changed: [instance]
2025-12-05 09:14:41.045149 | controller |
2025-12-05 09:14:41.045197 | controller | TASK [repo_setup : Install repo-setup package] *********************************
2025-12-05 09:14:41.045209 | controller | Friday 05 December 2025  09:14:40 +0000 (0:00:07.882)       0:00:12.430 *******
2025-12-05 09:14:41.045219 | controller | changed: [instance]
2025-12-05 09:14:41.065084 | controller |
2025-12-05 09:14:41.065105 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] ***
2025-12-05 09:14:41.065115 | controller | Friday 05 December 2025  09:14:41 +0000 (0:00:00.693)       0:00:13.124 *******
2025-12-05 09:14:41.065126 | controller | skipping: [instance]
2025-12-05 09:14:41.855241 | controller |
2025-12-05 09:14:41.855270 | controller | TASK [repo_setup : Run repo-setup] *********************************************
2025-12-05 09:14:41.855278 | controller | Friday 05 December 2025  09:14:41 +0000 (0:00:00.020)       0:00:13.144 *******
2025-12-05 09:14:41.855288 | controller | changed: [instance]
2025-12-05 09:14:41.855294 | controller |
2025-12-05 09:14:41.855300 | controller | TASK [repo_setup : Get component repo] *****************************************
2025-12-05 09:14:41.855307 | controller | Friday 05 December 2025  09:14:41 +0000 (0:00:00.789)       0:00:13.934 *******
2025-12-05 09:14:41.880771 | controller | skipping: [instance]
2025-12-05 09:14:41.905899 | controller |
2025-12-05 09:14:41.905920 | controller | TASK [repo_setup : Rename component repo] **************************************
2025-12-05 09:14:41.905928 | controller | Friday 05 December 2025  09:14:41 +0000 (0:00:00.025)       0:00:13.960 *******
2025-12-05 09:14:41.905937 | controller | skipping: [instance]
2025-12-05 09:14:41.930904 | controller |
2025-12-05 09:14:41.930923 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] *******
2025-12-05 09:14:41.930931 | controller | Friday 05 December 2025  09:14:41 +0000 (0:00:00.024)       0:00:13.985 *******
2025-12-05 09:14:41.930940 | controller | skipping: [instance]
2025-12-05 09:14:42.442237 | controller |
2025-12-05 09:14:42.442267 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************
2025-12-05 09:14:42.442275 | controller | Friday 05 December 2025  09:14:41 +0000 (0:00:00.025)       0:00:14.010 *******
2025-12-05 09:14:42.442285 | controller | changed: [instance]
2025-12-05 09:14:42.442307 | controller |
2025-12-05 09:14:42.442315 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] *******************
2025-12-05 09:14:42.442403 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.511)       0:00:14.521 *******
2025-12-05 09:14:42.850507 | controller | changed: [instance]
2025-12-05 09:14:42.869218 | controller |
2025-12-05 09:14:42.869240 | controller | TASK [repo_setup : Dump current-podified hash] *********************************
2025-12-05 09:14:42.869248 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.408)       0:00:14.929 *******
2025-12-05 09:14:42.869258 | controller | skipping: [instance]
2025-12-05 09:14:42.887271 | controller |
2025-12-05 09:14:42.887307 | controller | TASK [repo_setup : Slurp current podified hash] ********************************
2025-12-05 09:14:42.887317 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.018)       0:00:14.948 *******
2025-12-05 09:14:42.887332 | controller | skipping: [instance]
2025-12-05 09:14:42.887363 | controller |
2025-12-05 09:14:42.887630 | controller | TASK [repo_setup : Update the value of full_hash] ******************************
2025-12-05 09:14:42.905606 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.018)       0:00:14.966 *******
2025-12-05 09:14:42.905635 | controller | skipping: [instance]
2025-12-05 09:14:42.933269 | controller |
2025-12-05 09:14:42.933292 | controller | TASK [repo_setup : Export hashes facts for further use] ************************
2025-12-05 09:14:42.933302 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.017)       0:00:14.984 *******
2025-12-05 09:14:42.933313 | controller | ok: [instance]
2025-12-05 09:14:42.950227 | controller |
2025-12-05 09:14:42.950242 | controller | TASK [repo_setup : Create download directory] **********************************
2025-12-05 09:14:42.950250 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.027)       0:00:15.012 *******
2025-12-05 09:14:42.950260 | controller | skipping: [instance]
2025-12-05 09:14:42.950321 | controller |
2025-12-05 09:14:42.950336 | controller | TASK [repo_setup : Print the URL to request] ***********************************
2025-12-05 09:14:42.950346 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.016)       0:00:15.029 *******
2025-12-05 09:14:42.966699 | controller | skipping: [instance]
2025-12-05 09:14:42.983221 | controller |
2025-12-05 09:14:42.983240 | controller | TASK [Download the RPM] ********************************************************
2025-12-05 09:14:42.983247 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.016)       0:00:15.046 *******
2025-12-05 09:14:42.983256 | controller | skipping: [instance]
2025-12-05 09:14:42.983278 | controller |
2025-12-05 09:14:42.983563 | controller | TASK [repo_setup : Install RHOS Release tool] **********************************
2025-12-05 09:14:43.000117 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.016)       0:00:15.062 *******
2025-12-05 09:14:43.000138 | controller | skipping: [instance]
2025-12-05 09:14:43.016768 | controller |
2025-12-05 09:14:43.016791 | controller | TASK [repo_setup : Get rhos-release tool version] ******************************
2025-12-05 09:14:43.016800 | controller | Friday 05 December 2025  09:14:42 +0000 (0:00:00.016)       0:00:15.079 *******
2025-12-05 09:14:43.016811 | controller | skipping: [instance]
2025-12-05 09:14:43.036015 | controller |
2025-12-05 09:14:43.036033 | controller | TASK [repo_setup : Print rhos-release tool version] ****************************
2025-12-05 09:14:43.036040 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.016)       0:00:15.096 *******
2025-12-05 09:14:43.036049 | controller | skipping: [instance]
2025-12-05 09:14:43.053833 | controller |
2025-12-05 09:14:43.053852 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] ***
2025-12-05 09:14:43.053861 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.019)       0:00:15.115 *******
2025-12-05 09:14:43.053872 | controller | skipping: [instance]
2025-12-05 09:14:43.233982 | controller |
2025-12-05 09:14:43.234012 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] ***************************
2025-12-05 09:14:43.234020 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.017)       0:00:15.133 *******
2025-12-05 09:14:43.234030 | controller | ok: [instance]
2025-12-05 09:14:43.445239 | controller |
2025-12-05 09:14:43.445269 | controller | TASK [repo_setup : Use RDO proxy mirrors] **************************************
2025-12-05 09:14:43.445277 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.179)       0:00:15.313 *******
2025-12-05 09:14:43.445287 | controller | changed: [instance]
2025-12-05 09:14:43.445638 | controller |
2025-12-05 09:14:43.664449 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] ***
2025-12-05 09:14:43.664479 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.211)       0:00:15.524 *******
2025-12-05 09:14:43.664508 | controller | changed: [instance]
2025-12-05 09:14:43.685928 | controller |
2025-12-05 09:14:43.685950 | controller | TASK [repo_setup : Check for gating.repo file on content provider] *************
2025-12-05 09:14:43.685958 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.218)       0:00:15.743 *******
2025-12-05 09:14:43.685967 | controller | skipping: [instance]
2025-12-05 09:14:43.709167 | controller |
2025-12-05 09:14:43.709211 | controller | TASK [repo_setup : Populate gating repo from content provider ip] **************
2025-12-05 09:14:43.709229 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.021)       0:00:15.764 *******
2025-12-05 09:14:43.709238 | controller | skipping: [instance]
2025-12-05 09:14:43.730258 | controller |
2025-12-05 09:14:43.730291 | controller | TASK [repo_setup : Check for DLRN repo at the destination] *********************
2025-12-05 09:14:43.730299 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.023)       0:00:15.788 *******
2025-12-05 09:14:43.730310 | controller | skipping: [instance]
2025-12-05 09:14:43.730329 | controller |
2025-12-05 09:14:43.730524 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] ***
2025-12-05 09:14:43.751248 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.021)       0:00:15.809 *******
2025-12-05 09:14:43.751277 | controller | skipping: [instance]
2025-12-05 09:14:43.751306 | controller |
2025-12-05 09:14:43.751317 | controller | TASK [repo_setup : Check for DLRN component repo] ******************************
2025-12-05 09:14:43.751421 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.021)       0:00:15.830 *******
2025-12-05 09:14:43.772782 | controller | skipping: [instance]
2025-12-05 09:14:43.794160 | controller |
2025-12-05 09:14:43.794192 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] ***
2025-12-05 09:14:43.794208 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.021)       0:00:15.852 *******
2025-12-05 09:14:43.794217 | controller | skipping: [instance]
2025-12-05 09:14:43.810267 | controller |
2025-12-05 09:14:43.810289 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ********
2025-12-05 09:14:43.810299 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.021)       0:00:15.873 *******
2025-12-05 09:14:43.810309 | controller | skipping: [instance]
2025-12-05 09:14:43.810478 | controller |
2025-12-05 09:14:43.810505 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ******
2025-12-05 09:14:43.829760 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.016)       0:00:15.889 *******
2025-12-05 09:14:43.829781 | controller | skipping: [instance]
2025-12-05 09:14:43.845705 | controller |
2025-12-05 09:14:43.845722 | controller | TASK [repo_setup : Cleanup existing metadata] **********************************
2025-12-05 09:14:43.845730 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.019)       0:00:15.909 *******
2025-12-05 09:14:43.845739 | controller | skipping: [instance]
2025-12-05 09:14:43.865316 | controller |
2025-12-05 09:14:43.865349 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] *********
2025-12-05 09:14:43.865358 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.015)       0:00:15.925 *******
2025-12-05 09:14:43.865368 | controller | skipping: [instance]
2025-12-05 09:14:43.865544 | controller |
2025-12-05 09:14:43.865565 | controller | TASK [test_deps : Look for redhat-release rpm] *********************************
2025-12-05 09:14:43.885595 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.019)       0:00:15.944 *******
2025-12-05 09:14:43.885615 | controller | skipping: [instance]
2025-12-05 09:14:43.905686 | controller |
2025-12-05 09:14:43.905704 | controller | TASK [test_deps : Remove redhat-release] ***************************************
2025-12-05 09:14:43.905711 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.020)       0:00:15.965 *******
2025-12-05 09:14:43.905720 | controller | skipping: [instance]
2025-12-05 09:14:43.925626 | controller |
2025-12-05 09:14:43.925642 | controller | TASK [test_deps : Install centos-stream-release] *******************************
2025-12-05 09:14:43.925649 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.020)       0:00:15.985 *******
2025-12-05 09:14:43.925658 | controller | skipping: [instance]
2025-12-05 09:14:43.948246 | controller |
2025-12-05 09:14:43.948269 | controller | TASK [test_deps : Install additional packages] *********************************
2025-12-05 09:14:43.948278 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.019)       0:00:16.005 *******
2025-12-05 09:14:43.948289 | controller | skipping: [instance]
2025-12-05 09:14:43.948424 | controller |
2025-12-05 09:14:43.948442 | controller | TASK [test_deps : Install selinux python libs] *********************************
2025-12-05 09:15:23.025817 | controller | Friday 05 December 2025  09:14:43 +0000 (0:00:00.022)       0:00:16.027 *******
2025-12-05 09:15:23.025855 | controller | ok: [instance]
2025-12-05 09:15:24.162251 | controller |
2025-12-05 09:15:24.162283 | controller | TASK [test_deps : Install python yaml libs] ************************************
2025-12-05 09:15:24.162291 | controller | Friday 05 December 2025  09:15:23 +0000 (0:00:39.076)       0:00:55.104 *******
2025-12-05 09:15:24.162301 | controller | ok: [instance]
2025-12-05 09:15:24.162324 | controller |
2025-12-05 09:15:24.162332 | controller | TASK [test_deps : Install extra packages] **************************************
2025-12-05 09:15:24.162354 | controller | Friday 05 December 2025  09:15:24 +0000 (0:00:01.136)       0:00:56.241 *******
2025-12-05 09:15:24.184914 | controller | skipping: [instance]
2025-12-05 09:15:24.217347 | controller |
2025-12-05 09:15:24.217388 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2025-12-05 09:15:24.217398 | controller | Friday 05 December 2025  09:15:24 +0000 (0:00:00.022)       0:00:56.264 *******
2025-12-05 09:15:24.217413 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2025-12-05 09:15:24.217441 | controller |
2025-12-05 09:15:24.217451 | controller | TASK [ci_setup : List packages to install] *************************************
2025-12-05 09:15:24.217521 | controller | Friday 05 December 2025  09:15:24 +0000 (0:00:00.032)       0:00:56.296 *******
2025-12-05 09:15:24.237401 | controller | ok: [instance] =>
2025-12-05 09:15:28.154251 | controller |   cifmw_ci_setup_packages:
2025-12-05 09:15:28.154282 | controller |   - bash-completion
2025-12-05 09:15:28.154290 | controller |   - ca-certificates
2025-12-05 09:15:28.154297 | controller |   - git-core
2025-12-05 09:15:28.154302 | controller |   - make
2025-12-05 09:15:28.154308 | controller |   - tar
2025-12-05 09:15:28.154314 | controller |   - tmux
2025-12-05 09:15:28.154322 | controller |   - python3-pip
2025-12-05 09:15:28.154327 | controller |
2025-12-05 09:15:28.154333 | controller | TASK [ci_setup : Install needed packages] **************************************
2025-12-05 09:15:28.154339 | controller | Friday 05 December 2025  09:15:24 +0000 (0:00:00.019)       0:00:56.315 *******
2025-12-05 09:15:28.154353 | controller | changed: [instance]
2025-12-05 09:15:28.334865 | controller |
2025-12-05 09:15:28.334894 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2025-12-05 09:15:28.334903 | controller | Friday 05 December 2025  09:15:28 +0000 (0:00:03.917)       0:01:00.233 *******
2025-12-05 09:15:28.334913 | controller | ok: [instance]
2025-12-05 09:15:28.519245 | controller |
2025-12-05 09:15:28.519275 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2025-12-05 09:15:28.519283 | controller | Friday 05 December 2025  09:15:28 +0000 (0:00:00.180)       0:01:00.414 *******
2025-12-05 09:15:28.519293 | controller | changed: [instance]
2025-12-05 09:15:28.519501 | controller |
2025-12-05 09:15:28.519514 | controller | TASK [ci_setup : Install openshift client] *************************************
2025-12-05 09:15:34.598103 | controller | Friday 05 December 2025  09:15:28 +0000 (0:00:00.184)       0:01:00.598 *******
2025-12-05 09:15:34.598148 | controller | changed: [instance]
2025-12-05 09:15:34.625655 | controller |
2025-12-05 09:15:34.625677 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2025-12-05 09:15:34.625686 | controller | Friday 05 December 2025  09:15:34 +0000 (0:00:06.078)       0:01:06.677 *******
2025-12-05 09:15:34.625697 | controller | ok: [instance]
2025-12-05 09:15:34.889245 | controller |
2025-12-05 09:15:34.889279 | controller | TASK [ci_setup : Create completion file] ***************************************
2025-12-05 09:15:34.889288 | controller | Friday 05 December 2025  09:15:34 +0000 (0:00:00.027)       0:01:06.704 *******
2025-12-05 09:15:34.889299 | controller | changed: [instance]
2025-12-05 09:15:34.889322 | controller |
2025-12-05 09:15:34.889330 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2025-12-05 09:15:34.889430 | controller | Friday 05 December 2025  09:15:34 +0000 (0:00:00.263)       0:01:06.968 *******
2025-12-05 09:15:35.163248 | controller | changed: [instance]
2025-12-05 09:15:35.179821 | controller |
2025-12-05 09:15:35.179849 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2025-12-05 09:15:35.179857 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.273)       0:01:07.242 *******
2025-12-05 09:15:35.179867 | controller | skipping: [instance]
2025-12-05 09:15:35.195556 | controller |
2025-12-05 09:15:35.195583 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2025-12-05 09:15:35.195592 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.016)       0:01:07.259 *******
2025-12-05 09:15:35.195603 | controller | skipping: [instance]
2025-12-05 09:15:35.212085 | controller |
2025-12-05 09:15:35.212106 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2025-12-05 09:15:35.212113 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.015)       0:01:07.274 *******
2025-12-05 09:15:35.212123 | controller | skipping: [instance]
2025-12-05 09:15:35.227618 | controller |
2025-12-05 09:15:35.227638 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2025-12-05 09:15:35.227646 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.016)       0:01:07.291 *******
2025-12-05 09:15:35.227655 | controller | skipping: [instance]
2025-12-05 09:15:35.243625 | controller |
2025-12-05 09:15:35.243644 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2025-12-05 09:15:35.243651 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.015)       0:01:07.307 *******
2025-12-05 09:15:35.243660 | controller | skipping: [instance]
2025-12-05 09:15:35.294158 | controller |
2025-12-05 09:15:35.294210 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2025-12-05 09:15:35.294227 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.016)       0:01:07.323 *******
2025-12-05 09:15:35.294238 | controller | skipping: [instance]
2025-12-05 09:15:36.262281 | controller |
2025-12-05 09:15:36.262312 | controller | TASK [ci_setup : Manage directories] *******************************************
2025-12-05 09:15:36.262321 | controller | Friday 05 December 2025  09:15:35 +0000 (0:00:00.050)       0:01:07.373 *******
2025-12-05 09:15:36.262331 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2025-12-05 09:15:36.458816 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2025-12-05 09:15:36.458847 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2025-12-05 09:15:36.458855 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2025-12-05 09:15:36.458861 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2025-12-05 09:15:36.458867 | controller |
2025-12-05 09:15:36.458873 | controller | TASK [Ensure directory exists] *************************************************
2025-12-05 09:15:36.458878 | controller | Friday 05 December 2025  09:15:36 +0000 (0:00:00.967)       0:01:08.341 *******
2025-12-05 09:15:36.458888 | controller | changed: [instance]
2025-12-05 09:15:36.840312 | controller |
2025-12-05 09:15:36.840350 | controller | TASK [Create nova migration keypair] *******************************************
2025-12-05 09:15:36.840360 | controller | Friday 05 December 2025  09:15:36 +0000 (0:00:00.196)       0:01:08.537 *******
2025-12-05 09:15:36.840380 | controller | changed: [instance]
2025-12-05 09:15:36.840411 | controller |
2025-12-05 09:15:36.840419 | controller | PLAY [Download tools] **********************************************************
2025-12-05 09:15:36.840427 | controller |
2025-12-05 09:15:36.840433 | controller | TASK [Gathering Facts] *********************************************************
2025-12-05 09:15:36.840443 | controller | Friday 05 December 2025  09:15:36 +0000 (0:00:00.381)       0:01:08.919 *******
2025-12-05 09:15:37.425314 | controller | ok: [localhost]
2025-12-05 09:15:37.425348 | controller |
2025-12-05 09:15:37.425358 | controller | TASK [download_tools : Install build dependencies] *****************************
2025-12-05 09:15:37.425368 | controller | Friday 05 December 2025  09:15:37 +0000 (0:00:00.585)       0:01:09.504 *******
2025-12-05 09:15:49.170023 | controller | changed: [localhost]
2025-12-05 09:15:49.190735 | controller |
2025-12-05 09:15:49.190762 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-12-05 09:15:49.190770 | controller | Friday 05 December 2025  09:15:49 +0000 (0:00:11.743)       0:01:21.248 *******
2025-12-05 09:15:49.190780 | controller | skipping: [localhost]
2025-12-05 09:15:49.213476 | controller |
2025-12-05 09:15:49.213496 | controller | TASK [download_tools : Set opm download url suffix] ****************************
2025-12-05 09:15:49.213504 | controller | Friday 05 December 2025  09:15:49 +0000 (0:00:00.021)       0:01:21.270 *******
2025-12-05 09:15:49.213513 | controller | ok: [localhost]
2025-12-05 09:15:49.398459 | controller |
2025-12-05 09:15:49.398489 | controller | TASK [download_tools : Create $HOME/bin dir] ***********************************
2025-12-05 09:15:49.398498 | controller | Friday 05 December 2025  09:15:49 +0000 (0:00:00.022)       0:01:21.292 *******
2025-12-05 09:15:49.398509 | controller | ok: [localhost]
2025-12-05 09:15:50.600983 | controller |
2025-12-05 09:15:50.601013 | controller | TASK [download_tools : Download opm] *******************************************
2025-12-05 09:15:50.601021 | controller | Friday 05 December 2025  09:15:49 +0000 (0:00:00.181)       0:01:21.474 *******
2025-12-05 09:15:50.601031 | controller | changed: [localhost]
2025-12-05 09:15:50.621700 | controller |
2025-12-05 09:15:50.621722 | controller | TASK [download_tools : Get version from sdk_version] ***************************
2025-12-05 09:15:50.621730 | controller | Friday 05 December 2025  09:15:50 +0000 (0:00:01.205)       0:01:22.680 *******
2025-12-05 09:15:50.621740 | controller | ok: [localhost]
2025-12-05 09:15:50.642087 | controller |
2025-12-05 09:15:50.642106 | controller | TASK [download_tools : Set operator-sdk file for version < 1.3.0] **************
2025-12-05 09:15:50.642114 | controller | Friday 05 December 2025  09:15:50 +0000 (0:00:00.020)       0:01:22.701 *******
2025-12-05 09:15:50.642123 | controller | skipping: [localhost]
2025-12-05 09:15:50.663658 | controller |
2025-12-05 09:15:50.663690 | controller | TASK [download_tools : Set operator-sdk file for version >= 1.3.0] *************
2025-12-05 09:15:50.663700 | controller | Friday 05 December 2025  09:15:50 +0000 (0:00:00.020)       0:01:22.721 *******
2025-12-05 09:15:50.663711 | controller | ok: [localhost]
2025-12-05 09:15:52.470189 | controller |
2025-12-05 09:15:52.470222 | controller | TASK [download_tools : Download operator-sdk] **********************************
2025-12-05 09:15:52.470230 | controller | Friday 05 December 2025  09:15:50 +0000 (0:00:00.021)       0:01:22.742 *******
2025-12-05 09:15:52.470240 | controller | changed: [localhost]
2025-12-05 09:15:53.464013 | controller |
2025-12-05 09:15:53.464044 | controller | TASK [download_tools : Download and extract kustomize] *************************
2025-12-05 09:15:53.464053 | controller | Friday 05 December 2025  09:15:52 +0000 (0:00:01.806)       0:01:24.549 *******
2025-12-05 09:15:53.464063 | controller | changed: [localhost]
2025-12-05 09:15:53.811963 | controller |
2025-12-05 09:15:53.811993 | controller | TASK [download_tools : Download kubectl] ***************************************
2025-12-05 09:15:53.812002 | controller | Friday 05 December 2025  09:15:53 +0000 (0:00:00.993)       0:01:25.543 *******
2025-12-05 09:15:53.812012 | controller | ok: [localhost]
2025-12-05 09:15:54.738195 | controller |
2025-12-05 09:15:54.738228 | controller | TASK [download_tools : Download kuttl] *****************************************
2025-12-05 09:15:54.738237 | controller | Friday 05 December 2025  09:15:53 +0000 (0:00:00.347)       0:01:25.891 *******
2025-12-05 09:15:54.738247 | controller | changed: [localhost]
2025-12-05 09:15:57.728651 | controller |
2025-12-05 09:15:57.728681 | controller | TASK [download_tools : Download chainsaw] **************************************
2025-12-05 09:15:57.728690 | controller | Friday 05 December 2025  09:15:54 +0000 (0:00:00.926)       0:01:26.817 *******
2025-12-05 09:15:57.728700 | controller | changed: [localhost]
2025-12-05 09:15:58.833407 | controller |
2025-12-05 09:15:58.833437 | controller | TASK [download_tools : Download and extract yq] ********************************
2025-12-05 09:15:58.833446 | controller | Friday 05 December 2025  09:15:57 +0000 (0:00:02.990)       0:01:29.807 *******
2025-12-05 09:15:58.833461 | controller | changed: [localhost]
2025-12-05 09:15:59.011249 | controller |
2025-12-05 09:15:59.011281 | controller | TASK [download_tools : Link yq_linux_amd64 as yq] ******************************
2025-12-05 09:15:59.011289 | controller | Friday 05 December 2025  09:15:58 +0000 (0:00:01.104)       0:01:30.912 *******
2025-12-05 09:15:59.011300 | controller | changed: [localhost]
2025-12-05 09:15:59.011322 | controller |
2025-12-05 09:15:59.011328 | controller | TASK [download_tools : Deinstall golang] ***************************************
2025-12-05 09:15:59.011336 | controller | Friday 05 December 2025  09:15:59 +0000 (0:00:00.177)       0:01:31.090 *******
2025-12-05 09:16:00.479790 | controller | ok: [localhost]
2025-12-05 09:16:01.395979 | controller |
2025-12-05 09:16:01.396011 | controller | TASK [download_tools : Delete old go version installed from upstream] **********
2025-12-05 09:16:01.396020 | controller | Friday 05 December 2025  09:16:00 +0000 (0:00:01.468)       0:01:32.558 *******
2025-12-05 09:16:01.396030 | controller | ok: [localhost] => (item=/usr/local/go)
2025-12-05 09:16:13.446858 | controller | ok: [localhost] => (item=/home/zuul/bin/go)
2025-12-05 09:16:13.446889 | controller | ok: [localhost] => (item=/home/zuul/bin/gofmt)
2025-12-05 09:16:13.446897 | controller | ok: [localhost] => (item=/usr/local/bin/go)
2025-12-05 09:16:13.446903 | controller | ok: [localhost] => (item=/usr/local/bin/gofmt)
2025-12-05 09:16:13.446909 | controller |
2025-12-05 09:16:13.446915 | controller | TASK [download_tools : Download and extract golang] ****************************
2025-12-05 09:16:13.446921 | controller | Friday 05 December 2025  09:16:01 +0000 (0:00:00.915)       0:01:33.474 *******
2025-12-05 09:16:13.446930 | controller | changed: [localhost]
2025-12-05 09:16:13.823252 | controller |
2025-12-05 09:16:13.823282 | controller | TASK [download_tools : Set alternatives link to installed go version] **********
2025-12-05 09:16:13.823290 | controller | Friday 05 December 2025  09:16:13 +0000 (0:00:12.051)       0:01:45.525 *******
2025-12-05 09:16:13.823300 | controller | changed: [localhost] => (item=go)
2025-12-05 09:16:13.856269 | controller | changed: [localhost] => (item=gofmt)
2025-12-05 09:16:13.856307 | controller |
2025-12-05 09:16:13.856317 | controller | TASK [download_tools : Clean bash cache] ***************************************
2025-12-05 09:16:13.856334 | controller | Friday 05 December 2025  09:16:13 +0000 (0:00:00.376)       0:01:45.902 *******
2025-12-05 09:16:13.856346 | controller | ok: [localhost] =>
2025-12-05 09:16:13.856375 | controller |   msg: When move from rpm to upstream version, make sure to clean bash cache using `hash -d go`
2025-12-05 09:16:13.856385 | controller |
2025-12-05 09:16:13.858728 | controller | PLAY RECAP *********************************************************************
2025-12-05 09:16:13.858760 | controller | instance                   : ok=31   changed=17   unreachable=0    failed=0    skipped=36   rescued=0    ignored=0
2025-12-05 09:16:13.911825 | controller | localhost                  : ok=19   changed=10   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-12-05 09:16:13.911856 | controller |
2025-12-05 09:16:13.911864 | controller | Friday 05 December 2025  09:16:13 +0000 (0:00:00.033)       0:01:45.935 *******
2025-12-05 09:16:13.911871 | controller | ===============================================================================
2025-12-05 09:16:13.911877 | controller | test_deps : Install selinux python libs -------------------------------- 39.08s
2025-12-05 09:16:13.911882 | controller | download_tools : Download and extract golang --------------------------- 12.05s
2025-12-05 09:16:13.911887 | controller | download_tools : Install build dependencies ---------------------------- 11.74s
2025-12-05 09:16:13.911893 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.88s
2025-12-05 09:16:13.911898 | controller | ci_setup : Install openshift client ------------------------------------- 6.08s
2025-12-05 09:16:13.911903 | controller | ci_setup : Install needed packages -------------------------------------- 3.92s
2025-12-05 09:16:13.911908 | controller | download_tools : Download chainsaw -------------------------------------- 2.99s
2025-12-05 09:16:13.911914 | controller | download_tools : Download operator-sdk ---------------------------------- 1.81s
2025-12-05 09:16:13.911919 | controller | download_tools : Deinstall golang --------------------------------------- 1.47s
2025-12-05 09:16:13.911924 | controller | download_tools : Download opm ------------------------------------------- 1.21s
2025-12-05 09:16:13.911929 | controller | test_deps : Install python yaml libs ------------------------------------ 1.14s
2025-12-05 09:16:13.911935 | controller | download_tools : Download and extract yq -------------------------------- 1.10s
2025-12-05 09:16:13.911940 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.05s
2025-12-05 09:16:13.911945 | controller | download_tools : Download and extract kustomize ------------------------- 0.99s
2025-12-05 09:16:13.911950 | controller | ci_setup : Manage directories ------------------------------------------- 0.97s
2025-12-05 09:16:13.911956 | controller | download_tools : Download kuttl ----------------------------------------- 0.93s
2025-12-05 09:16:13.911961 | controller | download_tools : Delete old go version installed from upstream ---------- 0.92s
2025-12-05 09:16:13.911967 | controller | Gathering Facts --------------------------------------------------------- 0.82s
2025-12-05 09:16:13.911972 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.79s
2025-12-05 09:16:13.911977 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.78s
2025-12-05 09:16:13.911988 | controller | INFO     Running default > converge
2025-12-05 09:16:14.325890 | controller |
2025-12-05 09:16:15.109113 | controller | PLAY [Converge] ****************************************************************
2025-12-05 09:16:15.109143 | controller |
2025-12-05 09:16:15.109152 | controller | TASK [Gathering Facts] *********************************************************
2025-12-05 09:16:15.109158 | controller | Friday 05 December 2025  09:16:14 +0000 (0:00:00.013)       0:00:00.013 *******
2025-12-05 09:16:15.109167 | controller | ok: [instance]
2025-12-05 09:16:15.740238 | controller |
2025-12-05 09:16:15.740269 | controller | TASK [Ensure architecture repository is building] ******************************
2025-12-05 09:16:15.740278 | controller | Friday 05 December 2025  09:16:15 +0000 (0:00:00.783)       0:00:00.796 *******
2025-12-05 09:16:15.740288 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-12-05 09:16:15.740312 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-12-05 09:16:15.740607 | controller |
2025-12-05 09:16:16.097837 | controller | TASK [Create nova migration keypair] *******************************************
2025-12-05 09:16:16.097867 | controller | Friday 05 December 2025  09:16:15 +0000 (0:00:00.631)       0:00:01.428 *******
2025-12-05 09:16:16.097880 | controller | changed: [instance]
2025-12-05 09:16:16.153983 | controller |
2025-12-05 09:16:16.154020 | controller | TASK [Generate needed facts out of local files] ********************************
2025-12-05 09:16:16.154029 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.357)       0:00:01.785 *******
2025-12-05 09:16:16.154040 | controller | ok: [instance]
2025-12-05 09:16:16.178767 | controller |
2025-12-05 09:16:16.178792 | controller | TASK [Generate network-values] *************************************************
2025-12-05 09:16:16.178800 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.056)       0:00:01.841 *******
2025-12-05 09:16:16.178811 | controller |
2025-12-05 09:16:16.206015 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-05 09:16:16.206037 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.024)       0:00:01.866 *******
2025-12-05 09:16:16.206049 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-05 09:16:16.231679 | controller |
2025-12-05 09:16:16.231701 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-05 09:16:16.231709 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.027)       0:00:01.893 *******
2025-12-05 09:16:16.231719 | controller | ok: [instance] => changed=false
2025-12-05 09:16:16.510627 | controller |   msg: All assertions passed
2025-12-05 09:16:16.510657 | controller |
2025-12-05 09:16:16.510665 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-05 09:16:16.510672 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.025)       0:00:01.919 *******
2025-12-05 09:16:16.510681 | controller | ok: [instance]
2025-12-05 09:16:16.542789 | controller |
2025-12-05 09:16:16.542814 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-05 09:16:16.542822 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.278)       0:00:02.198 *******
2025-12-05 09:16:16.542833 | controller | ok: [instance] => changed=false
2025-12-05 09:16:16.816770 | controller |   msg: All assertions passed
2025-12-05 09:16:16.816800 | controller |
2025-12-05 09:16:16.816809 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-05 09:16:16.816816 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.032)       0:00:02.230 *******
2025-12-05 09:16:16.816826 | controller | ok: [instance]
2025-12-05 09:16:17.077753 | controller |
2025-12-05 09:16:17.077783 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-05 09:16:17.077792 | controller | Friday 05 December 2025  09:16:16 +0000 (0:00:00.273)       0:00:02.504 *******
2025-12-05 09:16:17.077802 | controller | ok: [instance]
2025-12-05 09:16:17.120229 | controller |
2025-12-05 09:16:17.120254 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-05 09:16:17.120262 | controller | Friday 05 December 2025  09:16:17 +0000 (0:00:00.260)       0:00:02.765 *******
2025-12-05 09:16:17.120272 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-12-05 09:16:17.120611 | controller |
2025-12-05 09:16:17.145778 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-12-05 09:16:17.145799 | controller | Friday 05 December 2025  09:16:17 +0000 (0:00:00.043)       0:00:02.808 *******
2025-12-05 09:16:17.145810 | controller | ok: [instance] => changed=false
2025-12-05 09:16:17.423271 | controller |   msg: All assertions passed
2025-12-05 09:16:17.423300 | controller |
2025-12-05 09:16:17.423308 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-05 09:16:17.423319 | controller | Friday 05 December 2025  09:16:17 +0000 (0:00:00.025)       0:00:02.833 *******
2025-12-05 09:16:17.423330 | controller | changed: [instance]
2025-12-05 09:16:17.423675 | controller |
2025-12-05 09:16:17.940065 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-05 09:16:17.940103 | controller | Friday 05 December 2025  09:16:17 +0000 (0:00:00.277)       0:00:03.111 *******
2025-12-05 09:16:17.940116 | controller | changed: [instance]
2025-12-05 09:16:17.972259 | controller |
2025-12-05 09:16:17.972291 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-05 09:16:17.972299 | controller | Friday 05 December 2025  09:16:17 +0000 (0:00:00.516)       0:00:03.627 *******
2025-12-05 09:16:17.972310 | controller | ok: [instance]
2025-12-05 09:16:18.310252 | controller |
2025-12-05 09:16:18.310288 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-05 09:16:18.310298 | controller | Friday 05 December 2025  09:16:17 +0000 (0:00:00.032)       0:00:03.660 *******
2025-12-05 09:16:18.310310 | controller | changed: [instance]
2025-12-05 09:16:18.646239 | controller |
2025-12-05 09:16:18.646276 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-05 09:16:18.646285 | controller | Friday 05 December 2025  09:16:18 +0000 (0:00:00.337)       0:00:03.997 *******
2025-12-05 09:16:18.646296 | controller | changed: [instance]
2025-12-05 09:16:18.646505 | controller |
2025-12-05 09:16:18.646538 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-05 09:16:18.987636 | controller | Friday 05 December 2025  09:16:18 +0000 (0:00:00.336)       0:00:04.334 *******
2025-12-05 09:16:18.987671 | controller | changed: [instance]
2025-12-05 09:16:19.015884 | controller |
2025-12-05 09:16:19.015909 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-05 09:16:19.015917 | controller | Friday 05 December 2025  09:16:18 +0000 (0:00:00.341)       0:00:04.675 *******
2025-12-05 09:16:19.015927 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-05 09:16:19.042940 | controller |
2025-12-05 09:16:19.042966 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-05 09:16:19.042974 | controller | Friday 05 December 2025  09:16:19 +0000 (0:00:00.028)       0:00:04.703 *******
2025-12-05 09:16:19.042984 | controller | ok: [instance] => changed=false
2025-12-05 09:16:19.314401 | controller |   msg: All assertions passed
2025-12-05 09:16:19.314433 | controller |
2025-12-05 09:16:19.314441 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-05 09:16:19.314448 | controller | Friday 05 December 2025  09:16:19 +0000 (0:00:00.026)       0:00:04.730 *******
2025-12-05 09:16:19.314462 | controller | ok: [instance]
2025-12-05 09:16:19.330766 | controller |
2025-12-05 09:16:19.330785 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-05 09:16:19.330792 | controller | Friday 05 December 2025  09:16:19 +0000 (0:00:00.271)       0:00:05.002 *******
2025-12-05 09:16:19.330800 | controller | ok: [instance]
2025-12-05 09:16:19.820102 | controller |
2025-12-05 09:16:19.820137 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-05 09:16:19.820146 | controller | Friday 05 December 2025  09:16:19 +0000 (0:00:00.016)       0:00:05.018 *******
2025-12-05 09:16:19.820156 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-12-05 09:16:19.885032 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-12-05 09:16:19.885058 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-12-05 09:16:19.885065 | controller |
2025-12-05 09:16:19.885071 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-05 09:16:19.885077 | controller | Friday 05 December 2025  09:16:19 +0000 (0:00:00.488)       0:00:05.507 *******
2025-12-05 09:16:19.885087 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-05 09:16:20.092266 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-05 09:16:20.092301 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-05 09:16:20.092311 | controller |
2025-12-05 09:16:20.092320 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-05 09:16:20.092330 | controller | Friday 05 December 2025  09:16:19 +0000 (0:00:00.065)       0:00:05.572 *******
2025-12-05 09:16:20.092350 | controller | changed: [instance]
2025-12-05 09:16:20.092468 | controller |
2025-12-05 09:16:20.092498 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-05 09:16:20.092511 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.207)       0:00:05.780 *******
2025-12-05 09:16:20.451266 | controller | changed: [instance]
2025-12-05 09:16:20.451296 | controller |
2025-12-05 09:16:20.451304 | controller | TASK [Generate edpm-nodeset-values] ********************************************
2025-12-05 09:16:20.451312 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.359)       0:00:06.139 *******
2025-12-05 09:16:20.476626 | controller |
2025-12-05 09:16:20.501783 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-05 09:16:20.501800 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.025)       0:00:06.164 *******
2025-12-05 09:16:20.501817 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-05 09:16:20.527627 | controller |
2025-12-05 09:16:20.527644 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-05 09:16:20.527651 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.025)       0:00:06.189 *******
2025-12-05 09:16:20.527663 | controller | ok: [instance] => changed=false
2025-12-05 09:16:20.715565 | controller |   msg: All assertions passed
2025-12-05 09:16:20.715597 | controller |
2025-12-05 09:16:20.715605 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-05 09:16:20.715612 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.025)       0:00:06.215 *******
2025-12-05 09:16:20.715622 | controller | ok: [instance]
2025-12-05 09:16:20.749053 | controller |
2025-12-05 09:16:20.749082 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-05 09:16:20.749090 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.187)       0:00:06.403 *******
2025-12-05 09:16:20.749100 | controller | ok: [instance] => changed=false
2025-12-05 09:16:20.931032 | controller |   msg: All assertions passed
2025-12-05 09:16:20.931060 | controller |
2025-12-05 09:16:20.931068 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-05 09:16:20.931074 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.033)       0:00:06.436 *******
2025-12-05 09:16:20.931084 | controller | ok: [instance]
2025-12-05 09:16:21.162311 | controller |
2025-12-05 09:16:21.162343 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-05 09:16:21.162351 | controller | Friday 05 December 2025  09:16:20 +0000 (0:00:00.182)       0:00:06.618 *******
2025-12-05 09:16:21.162361 | controller | ok: [instance]
2025-12-05 09:16:21.162612 | controller |
2025-12-05 09:16:21.205299 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-05 09:16:21.205339 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.231)       0:00:06.850 *******
2025-12-05 09:16:21.205355 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-12-05 09:16:21.205390 | controller |
2025-12-05 09:16:21.205609 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-12-05 09:16:21.239117 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.043)       0:00:06.893 *******
2025-12-05 09:16:21.239141 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-12-05 09:16:21.269194 | controller |
2025-12-05 09:16:21.269214 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-12-05 09:16:21.269222 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.033)       0:00:06.927 *******
2025-12-05 09:16:21.269231 | controller | ok: [instance] => changed=false
2025-12-05 09:16:21.295794 | controller |   msg: All assertions passed
2025-12-05 09:16:21.295820 | controller |
2025-12-05 09:16:21.295838 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-12-05 09:16:21.295855 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.029)       0:00:06.957 *******
2025-12-05 09:16:21.295866 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-12-05 09:16:21.312133 | controller |
2025-12-05 09:16:21.312153 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-12-05 09:16:21.312161 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.026)       0:00:06.983 *******
2025-12-05 09:16:21.312188 | controller | skipping: [instance]
2025-12-05 09:16:21.332122 | controller |
2025-12-05 09:16:21.332142 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-12-05 09:16:21.332150 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.016)       0:00:07.000 *******
2025-12-05 09:16:21.332159 | controller | ok: [instance]
2025-12-05 09:16:21.358278 | controller |
2025-12-05 09:16:21.358313 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-12-05 09:16:21.358321 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.020)       0:00:07.020 *******
2025-12-05 09:16:21.358332 | controller | ok: [instance] => changed=false
2025-12-05 09:16:21.358356 | controller |   msg: All assertions passed
2025-12-05 09:16:21.358363 | controller |
2025-12-05 09:16:21.358650 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-05 09:16:21.541119 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.026)       0:00:07.046 *******
2025-12-05 09:16:21.541157 | controller | changed: [instance]
2025-12-05 09:16:21.915631 | controller |
2025-12-05 09:16:21.915661 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-05 09:16:21.915670 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.182)       0:00:07.228 *******
2025-12-05 09:16:21.915680 | controller | changed: [instance]
2025-12-05 09:16:21.938792 | controller |
2025-12-05 09:16:21.938816 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-05 09:16:21.938824 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.374)       0:00:07.603 *******
2025-12-05 09:16:21.938833 | controller | ok: [instance]
2025-12-05 09:16:22.261731 | controller |
2025-12-05 09:16:22.261761 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-05 09:16:22.261769 | controller | Friday 05 December 2025  09:16:21 +0000 (0:00:00.023)       0:00:07.626 *******
2025-12-05 09:16:22.261779 | controller | changed: [instance]
2025-12-05 09:16:22.601309 | controller |
2025-12-05 09:16:22.601344 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-05 09:16:22.601354 | controller | Friday 05 December 2025  09:16:22 +0000 (0:00:00.322)       0:00:07.949 *******
2025-12-05 09:16:22.601366 | controller | changed: [instance]
2025-12-05 09:16:22.601394 | controller |
2025-12-05 09:16:22.601404 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-05 09:16:22.601511 | controller | Friday 05 December 2025  09:16:22 +0000 (0:00:00.339)       0:00:08.289 *******
2025-12-05 09:16:22.916641 | controller | changed: [instance]
2025-12-05 09:16:22.944272 | controller |
2025-12-05 09:16:22.944301 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-05 09:16:22.944312 | controller | Friday 05 December 2025  09:16:22 +0000 (0:00:00.315)       0:00:08.604 *******
2025-12-05 09:16:22.944324 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-05 09:16:22.944351 | controller |
2025-12-05 09:16:22.944362 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-05 09:16:22.944443 | controller | Friday 05 December 2025  09:16:22 +0000 (0:00:00.027)       0:00:08.632 *******
2025-12-05 09:16:22.969203 | controller | ok: [instance] => changed=false
2025-12-05 09:16:23.146825 | controller |   msg: All assertions passed
2025-12-05 09:16:23.146855 | controller |
2025-12-05 09:16:23.146863 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-05 09:16:23.146870 | controller | Friday 05 December 2025  09:16:22 +0000 (0:00:00.024)       0:00:08.656 *******
2025-12-05 09:16:23.146885 | controller | ok: [instance]
2025-12-05 09:16:23.164265 | controller |
2025-12-05 09:16:23.164298 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-05 09:16:23.164306 | controller | Friday 05 December 2025  09:16:23 +0000 (0:00:00.177)       0:00:08.834 *******
2025-12-05 09:16:23.164317 | controller | ok: [instance]
2025-12-05 09:16:23.164392 | controller |
2025-12-05 09:16:23.164423 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-05 09:16:23.164437 | controller | Friday 05 December 2025  09:16:23 +0000 (0:00:00.018)       0:00:08.852 *******
2025-12-05 09:16:23.647455 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-12-05 09:16:23.693826 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-12-05 09:16:23.693851 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-12-05 09:16:23.693859 | controller |
2025-12-05 09:16:23.693865 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-05 09:16:23.693871 | controller | Friday 05 December 2025  09:16:23 +0000 (0:00:00.482)       0:00:09.335 *******
2025-12-05 09:16:23.693880 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-05 09:16:23.875679 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-05 09:16:23.875710 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-05 09:16:23.875718 | controller |
2025-12-05 09:16:23.875724 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-05 09:16:23.875730 | controller | Friday 05 December 2025  09:16:23 +0000 (0:00:00.046)       0:00:09.381 *******
2025-12-05 09:16:23.875740 | controller | changed: [instance]
2025-12-05 09:16:24.216267 | controller |
2025-12-05 09:16:24.216302 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-05 09:16:24.216312 | controller | Friday 05 December 2025  09:16:23 +0000 (0:00:00.181)       0:00:09.563 *******
2025-12-05 09:16:24.216324 | controller | changed: [instance]
2025-12-05 09:16:24.558695 | controller |
2025-12-05 09:16:24.558725 | controller | TASK [Get generated files status] **********************************************
2025-12-05 09:16:24.558734 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.340)       0:00:09.904 *******
2025-12-05 09:16:24.558744 | controller | ok: [instance] => (item=network-values)
2025-12-05 09:16:24.586272 | controller | ok: [instance] => (item=edpm-nodeset-values)
2025-12-05 09:16:24.586309 | controller |
2025-12-05 09:16:24.586317 | controller | TASK [Assert generated values.yaml exists] *************************************
2025-12-05 09:16:24.586324 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.342)       0:00:10.246 *******
2025-12-05 09:16:24.586335 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml) => changed=false
2025-12-05 09:16:24.586359 | controller |   ansible_loop_var: item
2025-12-05 09:16:24.586366 | controller |   item:
2025-12-05 09:16:24.586372 | controller |     ansible_loop_var: item
2025-12-05 09:16:24.586377 | controller |     changed: false
2025-12-05 09:16:24.586383 | controller |     failed: false
2025-12-05 09:16:24.586388 | controller |     invocation:
2025-12-05 09:16:24.586393 | controller |       module_args:
2025-12-05 09:16:24.586400 | controller |         checksum_algorithm: sha1
2025-12-05 09:16:24.587026 | controller |         follow: false
2025-12-05 09:16:24.587219 | controller |         get_attributes: false
2025-12-05 09:16:24.587234 | controller |         get_checksum: false
2025-12-05 09:16:24.587241 | controller |         get_md5: false
2025-12-05 09:16:24.587246 | controller |         get_mime: false
2025-12-05 09:16:24.587252 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-12-05 09:16:24.587258 | controller |     item: network-values
2025-12-05 09:16:24.587266 | controller |     stat:
2025-12-05 09:16:24.588126 | controller |       atime: 1764926180.4103942
2025-12-05 09:16:24.588141 | controller |       block_size: 4096
2025-12-05 09:16:24.588217 | controller |       blocks: 16
2025-12-05 09:16:24.588230 | controller |       ctime: 1764926180.4133942
2025-12-05 09:16:24.588236 | controller |       dev: 64513
2025-12-05 09:16:24.588241 | controller |       device_type: 0
2025-12-05 09:16:24.588253 | controller |       executable: false
2025-12-05 09:16:24.588259 | controller |       exists: true
2025-12-05 09:16:24.588264 | controller |       gid: 1000
2025-12-05 09:16:24.588269 | controller |       gr_name: zuul
2025-12-05 09:16:24.588275 | controller |       inode: 104991973
2025-12-05 09:16:24.588283 | controller |       isblk: false
2025-12-05 09:16:24.588352 | controller |       ischr: false
2025-12-05 09:16:24.588468 | controller |       isdir: false
2025-12-05 09:16:24.588599 | controller |       isfifo: false
2025-12-05 09:16:24.588717 | controller |       isgid: false
2025-12-05 09:16:24.588828 | controller |       islnk: false
2025-12-05 09:16:24.588938 | controller |       isreg: true
2025-12-05 09:16:24.589048 | controller |       issock: false
2025-12-05 09:16:24.589180 | controller |       isuid: false
2025-12-05 09:16:24.589291 | controller |       mode: '0644'
2025-12-05 09:16:24.589404 | controller |       mtime: 1764926180.269393
2025-12-05 09:16:24.589512 | controller |       nlink: 1
2025-12-05 09:16:24.589641 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-12-05 09:16:24.589750 | controller |       pw_name: zuul
2025-12-05 09:16:24.589857 | controller |       readable: true
2025-12-05 09:16:24.589964 | controller |       rgrp: true
2025-12-05 09:16:24.590077 | controller |       roth: true
2025-12-05 09:16:24.590202 | controller |       rusr: true
2025-12-05 09:16:24.590329 | controller |       size: 5726
2025-12-05 09:16:24.590470 | controller |       uid: 1000
2025-12-05 09:16:24.590631 | controller |       wgrp: false
2025-12-05 09:16:24.590769 | controller |       woth: false
2025-12-05 09:16:24.590903 | controller |       writeable: true
2025-12-05 09:16:24.591037 | controller |       wusr: true
2025-12-05 09:16:24.591180 | controller |       xgrp: false
2025-12-05 09:16:24.591334 | controller |       xoth: false
2025-12-05 09:16:24.591484 | controller |       xusr: false
2025-12-05 09:16:24.591634 | controller |   msg: All assertions passed
2025-12-05 09:16:24.591775 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml) => changed=false
2025-12-05 09:16:24.591908 | controller |   ansible_loop_var: item
2025-12-05 09:16:24.592038 | controller |   item:
2025-12-05 09:16:24.592181 | controller |     ansible_loop_var: item
2025-12-05 09:16:24.592338 | controller |     changed: false
2025-12-05 09:16:24.592473 | controller |     failed: false
2025-12-05 09:16:24.592622 | controller |     invocation:
2025-12-05 09:16:24.592754 | controller |       module_args:
2025-12-05 09:16:24.592885 | controller |         checksum_algorithm: sha1
2025-12-05 09:16:24.593014 | controller |         follow: false
2025-12-05 09:16:24.593144 | controller |         get_attributes: false
2025-12-05 09:16:24.593304 | controller |         get_checksum: false
2025-12-05 09:16:24.593442 | controller |         get_md5: false
2025-12-05 09:16:24.593588 | controller |         get_mime: false
2025-12-05 09:16:24.593727 | controller |         path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-12-05 09:16:24.593857 | controller |     item: edpm-nodeset-values
2025-12-05 09:16:24.593986 | controller |     stat:
2025-12-05 09:16:24.594118 | controller |       atime: 1764926184.178428
2025-12-05 09:16:24.594301 | controller |       block_size: 4096
2025-12-05 09:16:24.594451 | controller |       blocks: 40
2025-12-05 09:16:24.594597 | controller |       ctime: 1764926184.181428
2025-12-05 09:16:24.594729 | controller |       dev: 64513
2025-12-05 09:16:24.594858 | controller |       device_type: 0
2025-12-05 09:16:24.594988 | controller |       executable: false
2025-12-05 09:16:24.595117 | controller |       exists: true
2025-12-05 09:16:24.595269 | controller |       gid: 1000
2025-12-05 09:16:24.595406 | controller |       gr_name: zuul
2025-12-05 09:16:24.595536 | controller |       inode: 75629164
2025-12-05 09:16:24.595682 | controller |       isblk: false
2025-12-05 09:16:24.595811 | controller |       ischr: false
2025-12-05 09:16:24.595946 | controller |       isdir: false
2025-12-05 09:16:24.596082 | controller |       isfifo: false
2025-12-05 09:16:24.596237 | controller |       isgid: false
2025-12-05 09:16:24.596374 | controller |       islnk: false
2025-12-05 09:16:24.596503 | controller |       isreg: true
2025-12-05 09:16:24.596646 | controller |       issock: false
2025-12-05 09:16:24.596777 | controller |       isuid: false
2025-12-05 09:16:24.596904 | controller |       mode: '0644'
2025-12-05 09:16:24.597033 | controller |       mtime: 1764926184.0444267
2025-12-05 09:16:24.597161 | controller |       nlink: 1
2025-12-05 09:16:24.597332 | controller |       path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-12-05 09:16:24.597466 | controller |       pw_name: zuul
2025-12-05 09:16:24.597624 | controller |       readable: true
2025-12-05 09:16:24.597755 | controller |       rgrp: true
2025-12-05 09:16:24.597882 | controller |       roth: true
2025-12-05 09:16:24.598020 | controller |       rusr: true
2025-12-05 09:16:24.598152 | controller |       size: 16482
2025-12-05 09:16:24.598305 | controller |       uid: 1000
2025-12-05 09:16:24.598441 | controller |       wgrp: false
2025-12-05 09:16:24.598593 | controller |       woth: false
2025-12-05 09:16:24.598725 | controller |       writeable: true
2025-12-05 09:16:24.598852 | controller |       wusr: true
2025-12-05 09:16:24.598980 | controller |       xgrp: false
2025-12-05 09:16:24.599107 | controller |       xoth: false
2025-12-05 09:16:24.599259 | controller |       xusr: false
2025-12-05 09:16:24.599396 | controller |   msg: All assertions passed
2025-12-05 09:16:24.599521 | controller |
2025-12-05 09:16:24.599668 | controller | TASK [Ensure we have correct MAC] **********************************************
2025-12-05 09:16:24.599802 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.027)       0:00:10.273 *******
2025-12-05 09:16:24.615767 | controller | ok: [instance] => changed=false
2025-12-05 09:16:24.615962 | controller |   msg: All assertions passed
2025-12-05 09:16:24.616121 | controller |
2025-12-05 09:16:24.616322 | controller | TASK [Ensure we don't have node_1 nor node_2] **********************************
2025-12-05 09:16:24.616480 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.030)       0:00:10.304 *******
2025-12-05 09:16:24.645982 | controller | ok: [instance] => changed=false
2025-12-05 09:16:24.646200 | controller |   msg: All assertions passed
2025-12-05 09:16:24.646395 | controller |
2025-12-05 09:16:24.646542 | controller | TASK [Update cifmw_networking_env_definition] **********************************
2025-12-05 09:16:24.646695 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.030)       0:00:10.334 *******
2025-12-05 09:16:24.669380 | controller | ok: [instance]
2025-12-05 09:16:24.669565 | controller |
2025-12-05 09:16:24.669712 | controller | TASK [Regenerate network-values] ***********************************************
2025-12-05 09:16:24.669851 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.023)       0:00:10.357 *******
2025-12-05 09:16:24.690936 | controller |
2025-12-05 09:16:24.691124 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-05 09:16:24.691320 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.021)       0:00:10.379 *******
2025-12-05 09:16:24.714331 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-05 09:16:24.714508 | controller |
2025-12-05 09:16:24.714668 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-05 09:16:24.714802 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.023)       0:00:10.402 *******
2025-12-05 09:16:24.737865 | controller | ok: [instance] => changed=false
2025-12-05 09:16:24.738060 | controller |   msg: All assertions passed
2025-12-05 09:16:24.738250 | controller |
2025-12-05 09:16:24.738425 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-05 09:16:24.738613 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.023)       0:00:10.426 *******
2025-12-05 09:16:24.910351 | controller | ok: [instance]
2025-12-05 09:16:24.932315 | controller |
2025-12-05 09:16:24.932351 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-05 09:16:24.932361 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.172)       0:00:10.598 *******
2025-12-05 09:16:24.932374 | controller | ok: [instance] => changed=false
2025-12-05 09:16:24.932403 | controller |   msg: All assertions passed
2025-12-05 09:16:24.932411 | controller |
2025-12-05 09:16:24.932420 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-05 09:16:24.932532 | controller | Friday 05 December 2025  09:16:24 +0000 (0:00:00.022)       0:00:10.620 *******
2025-12-05 09:16:25.099282 | controller | ok: [instance]
2025-12-05 09:16:25.099330 | controller |
2025-12-05 09:16:25.099338 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-05 09:16:25.099347 | controller | Friday 05 December 2025  09:16:25 +0000 (0:00:00.166)       0:00:10.787 *******
2025-12-05 09:16:25.328110 | controller | ok: [instance]
2025-12-05 09:16:25.358886 | controller |
2025-12-05 09:16:25.358915 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-05 09:16:25.358932 | controller | Friday 05 December 2025  09:16:25 +0000 (0:00:00.228)       0:00:11.015 *******
2025-12-05 09:16:25.358943 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-12-05 09:16:25.381781 | controller |
2025-12-05 09:16:25.381813 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-12-05 09:16:25.381823 | controller | Friday 05 December 2025  09:16:25 +0000 (0:00:00.030)       0:00:11.046 *******
2025-12-05 09:16:25.381835 | controller | ok: [instance] => changed=false
2025-12-05 09:16:25.564738 | controller |   msg: All assertions passed
2025-12-05 09:16:25.564768 | controller |
2025-12-05 09:16:25.564777 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-05 09:16:25.564783 | controller | Friday 05 December 2025  09:16:25 +0000 (0:00:00.022)       0:00:11.069 *******
2025-12-05 09:16:25.564792 | controller | ok: [instance]
2025-12-05 09:16:26.010528 | controller |
2025-12-05 09:16:26.010569 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-05 09:16:26.010578 | controller | Friday 05 December 2025  09:16:25 +0000 (0:00:00.183)       0:00:11.252 *******
2025-12-05 09:16:26.010588 | controller | changed: [instance]
2025-12-05 09:16:26.033312 | controller |
2025-12-05 09:16:26.033348 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-05 09:16:26.033357 | controller | Friday 05 December 2025  09:16:26 +0000 (0:00:00.445)       0:00:11.698 *******
2025-12-05 09:16:26.033367 | controller | ok: [instance]
2025-12-05 09:16:26.366029 | controller |
2025-12-05 09:16:26.366061 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-05 09:16:26.366070 | controller | Friday 05 December 2025  09:16:26 +0000 (0:00:00.022)       0:00:11.721 *******
2025-12-05 09:16:26.366080 | controller | ok: [instance]
2025-12-05 09:16:26.693259 | controller |
2025-12-05 09:16:26.693291 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-05 09:16:26.693300 | controller | Friday 05 December 2025  09:16:26 +0000 (0:00:00.332)       0:00:12.053 *******
2025-12-05 09:16:26.693311 | controller | ok: [instance]
2025-12-05 09:16:26.693336 | controller |
2025-12-05 09:16:26.693531 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-05 09:16:27.026592 | controller | Friday 05 December 2025  09:16:26 +0000 (0:00:00.327)       0:00:12.381 *******
2025-12-05 09:16:27.026627 | controller | ok: [instance]
2025-12-05 09:16:27.053790 | controller |
2025-12-05 09:16:27.053814 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-05 09:16:27.053824 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.333)       0:00:12.714 *******
2025-12-05 09:16:27.053835 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-05 09:16:27.078038 | controller |
2025-12-05 09:16:27.078056 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-05 09:16:27.078064 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.027)       0:00:12.741 *******
2025-12-05 09:16:27.078073 | controller | ok: [instance] => changed=false
2025-12-05 09:16:27.255480 | controller |   msg: All assertions passed
2025-12-05 09:16:27.255508 | controller |
2025-12-05 09:16:27.255516 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-05 09:16:27.255523 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.024)       0:00:12.765 *******
2025-12-05 09:16:27.255532 | controller | ok: [instance]
2025-12-05 09:16:27.272651 | controller |
2025-12-05 09:16:27.272670 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-05 09:16:27.272683 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.177)       0:00:12.943 *******
2025-12-05 09:16:27.272692 | controller | ok: [instance]
2025-12-05 09:16:27.789268 | controller |
2025-12-05 09:16:27.789297 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-05 09:16:27.789306 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.017)       0:00:12.960 *******
2025-12-05 09:16:27.789320 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-12-05 09:16:27.789856 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-12-05 09:16:27.842260 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-12-05 09:16:27.842294 | controller |
2025-12-05 09:16:27.842302 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-05 09:16:27.842309 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.516)       0:00:13.477 *******
2025-12-05 09:16:27.842319 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-05 09:16:27.842406 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-05 09:16:27.842428 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-05 09:16:27.842438 | controller |
2025-12-05 09:16:27.842446 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-05 09:16:27.842457 | controller | Friday 05 December 2025  09:16:27 +0000 (0:00:00.052)       0:00:13.530 *******
2025-12-05 09:16:28.024885 | controller | ok: [instance]
2025-12-05 09:16:28.396459 | controller |
2025-12-05 09:16:28.396491 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-05 09:16:28.396499 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.182)       0:00:13.712 *******
2025-12-05 09:16:28.396509 | controller | changed: [instance]
2025-12-05 09:16:28.421202 | controller |
2025-12-05 09:16:28.421231 | controller | TASK [Regenerate edpm-nodeset-values] ******************************************
2025-12-05 09:16:28.421241 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.371)       0:00:14.084 *******
2025-12-05 09:16:28.421253 | controller |
2025-12-05 09:16:28.446605 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-12-05 09:16:28.446629 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.024)       0:00:14.109 *******
2025-12-05 09:16:28.446640 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-12-05 09:16:28.472269 | controller |
2025-12-05 09:16:28.472303 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-12-05 09:16:28.472312 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.025)       0:00:14.134 *******
2025-12-05 09:16:28.472322 | controller | ok: [instance] => changed=false
2025-12-05 09:16:28.472345 | controller |   msg: All assertions passed
2025-12-05 09:16:28.472703 | controller |
2025-12-05 09:16:28.648477 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-12-05 09:16:28.648509 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.025)       0:00:14.160 *******
2025-12-05 09:16:28.648522 | controller | ok: [instance]
2025-12-05 09:16:28.670777 | controller |
2025-12-05 09:16:28.670806 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-12-05 09:16:28.670816 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.175)       0:00:14.336 *******
2025-12-05 09:16:28.670828 | controller | ok: [instance] => changed=false
2025-12-05 09:16:28.843924 | controller |   msg: All assertions passed
2025-12-05 09:16:28.843955 | controller |
2025-12-05 09:16:28.843963 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-12-05 09:16:28.843969 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.022)       0:00:14.358 *******
2025-12-05 09:16:28.843979 | controller | ok: [instance]
2025-12-05 09:16:29.050206 | controller |
2025-12-05 09:16:29.050238 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-12-05 09:16:29.050247 | controller | Friday 05 December 2025  09:16:28 +0000 (0:00:00.173)       0:00:14.531 *******
2025-12-05 09:16:29.050257 | controller | ok: [instance]
2025-12-05 09:16:29.083260 | controller |
2025-12-05 09:16:29.083286 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-12-05 09:16:29.083294 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.206)       0:00:14.737 *******
2025-12-05 09:16:29.083304 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-12-05 09:16:29.106934 | controller |
2025-12-05 09:16:29.106957 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-12-05 09:16:29.106965 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.033)       0:00:14.771 *******
2025-12-05 09:16:29.106974 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-12-05 09:16:29.138598 | controller |
2025-12-05 09:16:29.138632 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-12-05 09:16:29.138642 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.023)       0:00:14.794 *******
2025-12-05 09:16:29.138657 | controller | ok: [instance] => changed=false
2025-12-05 09:16:29.138847 | controller |   msg: All assertions passed
2025-12-05 09:16:29.138998 | controller |
2025-12-05 09:16:29.139135 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-12-05 09:16:29.139304 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.031)       0:00:14.826 *******
2025-12-05 09:16:29.163500 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-12-05 09:16:29.163705 | controller |
2025-12-05 09:16:29.163893 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-12-05 09:16:29.164045 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.025)       0:00:14.851 *******
2025-12-05 09:16:29.179657 | controller | skipping: [instance]
2025-12-05 09:16:29.179848 | controller |
2025-12-05 09:16:29.180032 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-12-05 09:16:29.180219 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.016)       0:00:14.867 *******
2025-12-05 09:16:29.199680 | controller | ok: [instance]
2025-12-05 09:16:29.199836 | controller |
2025-12-05 09:16:29.199986 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-12-05 09:16:29.200126 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.020)       0:00:14.888 *******
2025-12-05 09:16:29.226074 | controller | ok: [instance] => changed=false
2025-12-05 09:16:29.226267 | controller |   msg: All assertions passed
2025-12-05 09:16:29.226407 | controller |
2025-12-05 09:16:29.226546 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-12-05 09:16:29.226696 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.026)       0:00:14.914 *******
2025-12-05 09:16:29.404138 | controller | ok: [instance]
2025-12-05 09:16:29.794115 | controller |
2025-12-05 09:16:29.794146 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-12-05 09:16:29.794155 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.177)       0:00:15.091 *******
2025-12-05 09:16:29.794165 | controller | ok: [instance]
2025-12-05 09:16:29.815884 | controller |
2025-12-05 09:16:29.815908 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-12-05 09:16:29.815916 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.389)       0:00:15.481 *******
2025-12-05 09:16:29.815926 | controller | ok: [instance]
2025-12-05 09:16:30.141459 | controller |
2025-12-05 09:16:30.141488 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-12-05 09:16:30.141496 | controller | Friday 05 December 2025  09:16:29 +0000 (0:00:00.021)       0:00:15.503 *******
2025-12-05 09:16:30.141512 | controller | ok: [instance]
2025-12-05 09:16:30.470029 | controller |
2025-12-05 09:16:30.470060 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-12-05 09:16:30.470068 | controller | Friday 05 December 2025  09:16:30 +0000 (0:00:00.325)       0:00:15.829 *******
2025-12-05 09:16:30.470078 | controller | ok: [instance]
2025-12-05 09:16:30.810652 | controller |
2025-12-05 09:16:30.810683 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-12-05 09:16:30.810691 | controller | Friday 05 December 2025  09:16:30 +0000 (0:00:00.328)       0:00:16.157 *******
2025-12-05 09:16:30.810702 | controller | ok: [instance]
2025-12-05 09:16:30.837213 | controller |
2025-12-05 09:16:30.837238 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-12-05 09:16:30.837247 | controller | Friday 05 December 2025  09:16:30 +0000 (0:00:00.340)       0:00:16.498 *******
2025-12-05 09:16:30.837257 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-12-05 09:16:30.861082 | controller |
2025-12-05 09:16:30.861110 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-12-05 09:16:30.861118 | controller | Friday 05 December 2025  09:16:30 +0000 (0:00:00.026)       0:00:16.525 *******
2025-12-05 09:16:30.861128 | controller | ok: [instance] => changed=false
2025-12-05 09:16:31.039408 | controller |   msg: All assertions passed
2025-12-05 09:16:31.039437 | controller |
2025-12-05 09:16:31.039446 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-12-05 09:16:31.039452 | controller | Friday 05 December 2025  09:16:30 +0000 (0:00:00.023)       0:00:16.548 *******
2025-12-05 09:16:31.039462 | controller | ok: [instance]
2025-12-05 09:16:31.056471 | controller |
2025-12-05 09:16:31.056496 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-12-05 09:16:31.056504 | controller | Friday 05 December 2025  09:16:31 +0000 (0:00:00.178)       0:00:16.727 *******
2025-12-05 09:16:31.056514 | controller | ok: [instance]
2025-12-05 09:16:31.533263 | controller |
2025-12-05 09:16:31.533295 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-12-05 09:16:31.533303 | controller | Friday 05 December 2025  09:16:31 +0000 (0:00:00.017)       0:00:16.744 *******
2025-12-05 09:16:31.533313 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-12-05 09:16:31.533336 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-12-05 09:16:31.533344 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-12-05 09:16:31.533677 | controller |
2025-12-05 09:16:31.579255 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-12-05 09:16:31.579281 | controller | Friday 05 December 2025  09:16:31 +0000 (0:00:00.476)       0:00:17.221 *******
2025-12-05 09:16:31.579294 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-12-05 09:16:31.579350 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-12-05 09:16:31.579391 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-12-05 09:16:31.579401 | controller |
2025-12-05 09:16:31.579409 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-12-05 09:16:31.579422 | controller | Friday 05 December 2025  09:16:31 +0000 (0:00:00.045)       0:00:17.266 *******
2025-12-05 09:16:31.757282 | controller | ok: [instance]
2025-12-05 09:16:31.757367 | controller |
2025-12-05 09:16:31.757383 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-12-05 09:16:31.757394 | controller | Friday 05 December 2025  09:16:31 +0000 (0:00:00.178)       0:00:17.445 *******
2025-12-05 09:16:32.093720 | controller | ok: [instance]
2025-12-05 09:16:32.445475 | controller |
2025-12-05 09:16:32.445509 | controller | TASK [Copy generated values to correct location] *******************************
2025-12-05 09:16:32.445518 | controller | Friday 05 December 2025  09:16:32 +0000 (0:00:00.336)       0:00:17.781 *******
2025-12-05 09:16:32.445529 | controller | changed: [instance] => (item={'key': 'network-values', 'value': 'examples/va/hci/control-plane/networking/nncp/values.yaml'})
2025-12-05 09:16:32.982294 | controller | changed: [instance] => (item={'key': 'edpm-nodeset-values', 'value': 'examples/va/hci/edpm-pre-ceph/nodeset/values.yaml'})
2025-12-05 09:16:32.982327 | controller |
2025-12-05 09:16:32.982335 | controller | TASK [Ensure kustomize is able to build] ***************************************
2025-12-05 09:16:32.982341 | controller | Friday 05 December 2025  09:16:32 +0000 (0:00:00.351)       0:00:18.133 *******
2025-12-05 09:16:32.982351 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'})
2025-12-05 09:16:32.982376 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'})
2025-12-05 09:16:32.982388 | controller |
2025-12-05 09:16:32.982394 | controller | PLAY RECAP *********************************************************************
2025-12-05 09:16:32.982399 | controller | instance                   : ok=107  changed=20   unreachable=0    failed=0    skipped=2    rescued=0    ignored=0
2025-12-05 09:16:32.982406 | controller |
2025-12-05 09:16:32.984514 | controller | Friday 05 December 2025  09:16:32 +0000 (0:00:00.536)       0:00:18.669 *******
2025-12-05 09:16:33.037347 | controller | ===============================================================================
2025-12-05 09:16:33.037375 | controller | Gathering Facts --------------------------------------------------------- 0.78s
2025-12-05 09:16:33.037383 | controller | Ensure architecture repository is building ------------------------------ 0.63s
2025-12-05 09:16:33.037389 | controller | Ensure kustomize is able to build --------------------------------------- 0.54s
2025-12-05 09:16:33.037394 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.52s
2025-12-05 09:16:33.037400 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.52s
2025-12-05 09:16:33.037405 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.49s
2025-12-05 09:16:33.037410 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.48s
2025-12-05 09:16:33.037416 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.48s
2025-12-05 09:16:33.037421 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.45s
2025-12-05 09:16:33.037426 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.39s
2025-12-05 09:16:33.037431 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.37s
2025-12-05 09:16:33.037437 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.37s
2025-12-05 09:16:33.037442 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.36s
2025-12-05 09:16:33.037447 | controller | Create nova migration keypair ------------------------------------------- 0.36s
2025-12-05 09:16:33.037452 | controller | Copy generated values to correct location ------------------------------- 0.35s
2025-12-05 09:16:33.037457 | controller | Get generated files status ---------------------------------------------- 0.34s
2025-12-05 09:16:33.037462 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.34s
2025-12-05 09:16:33.037468 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.34s
2025-12-05 09:16:33.037473 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.34s
2025-12-05 09:16:33.037478 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.34s
2025-12-05 09:16:33.037488 | controller | INFO     Running default > cleanup
2025-12-05 09:16:33.037972 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-12-05 09:16:33.038579 | controller | INFO     Writing /tmp/report.html report.
2025-12-05 09:16:33.435226 | controller | changed
2025-12-05 09:16:33.458382 | 
2025-12-05 09:16:33.458437 | PLAY RECAP
2025-12-05 09:16:33.458478 | controller | ok: 4 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-12-05 09:16:33.458500 | 
2025-12-05 09:16:33.519273 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-12-05 09:16:33.520390 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-05 09:16:34.053257 | 
2025-12-05 09:16:34.053366 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-12-05 09:16:34.074107 | 
2025-12-05 09:16:34.074178 | TASK [Filter out host if needed]
2025-12-05 09:16:34.082706 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-12-05 09:16:34.087170 | 
2025-12-05 09:16:34.087234 | TASK [Ensure file is present]
2025-12-05 09:16:34.399743 | controller | ok
2025-12-05 09:16:34.406718 | 
2025-12-05 09:16:34.406792 | TASK [Manage molecule report file]
2025-12-05 09:16:34.932289 | controller | changed
2025-12-05 09:16:34.937876 | 
2025-12-05 09:16:34.937964 | TASK [Check if we get ci-framework-data basedir]
2025-12-05 09:16:35.129574 | controller | ok
2025-12-05 09:16:35.134711 | 
2025-12-05 09:16:35.134785 | TASK [Create ci-framework-data log directory for zuul]
2025-12-05 09:16:35.447192 | controller | changed
2025-12-05 09:16:35.452317 | 
2025-12-05 09:16:35.452383 | TASK [Copy ci-framework interesting files]
2025-12-05 09:16:35.659524 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-12-05 09:16:35.979417 | controller | changed
2025-12-05 09:16:35.984854 | 
2025-12-05 09:16:35.984946 | TASK [Get SELinux listing]
2025-12-05 09:16:36.511454 | controller | changed
2025-12-05 09:16:36.517067 | 
2025-12-05 09:16:36.517134 | TASK [Generate log index]
2025-12-05 09:16:37.154759 | controller | changed
2025-12-05 09:16:37.159558 | 
2025-12-05 09:16:37.159619 | TASK [Get some env related data]
2025-12-05 09:16:37.710246 | controller | /home/zuul/.local/bin/ansible
2025-12-05 09:16:38.689375 | controller | changed
2025-12-05 09:16:38.694687 | 
2025-12-05 09:16:38.694754 | TASK [Generate list of logs to collect in home directory]
2025-12-05 09:16:38.989483 | controller | ok: All paths examined
2025-12-05 09:16:38.994822 | 
2025-12-05 09:16:38.994885 | LOOP [Copy logs from home directory]
2025-12-05 09:16:39.308128 | controller | changed:
2025-12-05 09:16:39.308252 | controller | {
2025-12-05 09:16:39.308281 | controller |   "atime": 1764926030.5576742,
2025-12-05 09:16:39.308301 | controller |   "ctime": 1764926046.1709123,
2025-12-05 09:16:39.308319 | controller |   "dev": 64513,
2025-12-05 09:16:39.308336 | controller |   "gid": 1000,
2025-12-05 09:16:39.308351 | controller |   "gr_name": "zuul",
2025-12-05 09:16:39.308368 | controller |   "inode": 4335529,
2025-12-05 09:16:39.308383 | controller |   "isblk": false,
2025-12-05 09:16:39.308398 | controller |   "ischr": false,
2025-12-05 09:16:39.308413 | controller |   "isdir": false,
2025-12-05 09:16:39.308427 | controller |   "isfifo": false,
2025-12-05 09:16:39.308442 | controller |   "isgid": false,
2025-12-05 09:16:39.308456 | controller |   "islnk": false,
2025-12-05 09:16:39.308469 | controller |   "isreg": true,
2025-12-05 09:16:39.308483 | controller |   "issock": false,
2025-12-05 09:16:39.308498 | controller |   "isuid": false,
2025-12-05 09:16:39.308513 | controller |   "mode": "0644",
2025-12-05 09:16:39.308527 | controller |   "mtime": 1764926046.1709123,
2025-12-05 09:16:39.308541 | controller |   "nlink": 1,
2025-12-05 09:16:39.308556 | controller |   "path": "/home/zuul/ansible.log",
2025-12-05 09:16:39.308571 | controller |   "pw_name": "zuul",
2025-12-05 09:16:39.308587 | controller |   "rgrp": true,
2025-12-05 09:16:39.308601 | controller |   "roth": true,
2025-12-05 09:16:39.308615 | controller |   "rusr": true,
2025-12-05 09:16:39.308630 | controller |   "size": 6749,
2025-12-05 09:16:39.308658 | controller |   "uid": 1000,
2025-12-05 09:16:39.308674 | controller |   "wgrp": false,
2025-12-05 09:16:39.308688 | controller |   "woth": false,
2025-12-05 09:16:39.308705 | controller |   "wusr": true,
2025-12-05 09:16:39.308720 | controller |   "xgrp": false,
2025-12-05 09:16:39.308734 | controller |   "xoth": false,
2025-12-05 09:16:39.308748 | controller |   "xusr": false
2025-12-05 09:16:39.308762 | controller | }
2025-12-05 09:16:39.322439 | 
2025-12-05 09:16:39.322542 | TASK [Copy crio stats log file]
2025-12-05 09:16:39.337296 | controller | skipping: Conditional result was False
2025-12-05 09:16:39.342883 | 
2025-12-05 09:16:39.342961 | TASK [Get SELinux related data]
2025-12-05 09:16:39.549312 | controller | <no matches>
2025-12-05 09:16:39.866939 | controller | ERROR
2025-12-05 09:16:39.867145 | controller | {
2025-12-05 09:16:39.867184 | controller |   "delta": "0:00:00.009219",
2025-12-05 09:16:39.867210 | controller |   "end": "2025-12-05 09:16:39.550210",
2025-12-05 09:16:39.867232 | controller |   "msg": "non-zero return code",
2025-12-05 09:16:39.867252 | controller |   "rc": 1,
2025-12-05 09:16:39.867271 | controller |   "start": "2025-12-05 09:16:39.540991"
2025-12-05 09:16:39.867296 | controller | }
2025-12-05 09:16:39.867322 | controller | ERROR: Ignoring Errors
2025-12-05 09:16:39.872451 | 
2025-12-05 09:16:39.872513 | TASK [Create system configuration directory]
2025-12-05 09:16:40.053765 | controller | changed
2025-12-05 09:16:40.058750 | 
2025-12-05 09:16:40.058814 | TASK [Get some of the system configurations]
2025-12-05 09:16:40.583134 | controller | changed
2025-12-05 09:16:40.588449 | 
2025-12-05 09:16:40.588511 | TASK [Copy generated documentation if available]
2025-12-05 09:16:40.612703 | controller | skipping: Conditional result was False
2025-12-05 09:16:40.618147 | 
2025-12-05 09:16:40.618209 | TASK [Copy generated AsciiDoc documentation if available]
2025-12-05 09:16:40.642176 | controller | skipping: Conditional result was False
2025-12-05 09:16:40.648083 | 
2025-12-05 09:16:40.648148 | TASK [Compress logs bigger than 2MB]
2025-12-05 09:16:41.173678 | controller | changed
2025-12-05 09:16:41.178873 | 
2025-12-05 09:16:41.178954 | TASK [Copy files from workspace on node]
2025-12-05 09:16:41.197237 | controller | ok
2025-12-05 09:16:41.219050 | 
2025-12-05 09:16:41.219116 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-05 09:16:41.232681 | controller | skipping: Conditional result was False
2025-12-05 09:16:41.238167 | 
2025-12-05 09:16:41.238233 | TASK [fetch-output : Set log path for single node]
2025-12-05 09:16:41.266476 | controller | ok
2025-12-05 09:16:41.272391 | 
2025-12-05 09:16:41.272456 | LOOP [fetch-output : Ensure local output dirs]
2025-12-05 09:16:41.473753 | controller -> localhost | ok: "/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/logs"
2025-12-05 09:16:41.474035 | controller -> localhost | changed: All items complete
2025-12-05 09:16:41.474068 | 
2025-12-05 09:16:41.667936 | controller -> localhost | changed: "/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/artifacts"
2025-12-05 09:16:41.843979 | controller -> localhost | changed: "/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/docs"
2025-12-05 09:16:41.852085 | 
2025-12-05 09:16:41.852180 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-05 09:16:42.406807 | controller | changed:
2025-12-05 09:16:42.407049 | controller | .d..t...... ./
2025-12-05 09:16:42.407081 | controller | >f+++++++++ README.html
2025-12-05 09:16:42.407103 | controller | >f+++++++++ ansible-execution.log
2025-12-05 09:16:42.407124 | controller | >f+++++++++ ansible.log
2025-12-05 09:16:42.407143 | controller | >f+++++++++ dmesg.log
2025-12-05 09:16:42.407162 | controller | >f+++++++++ installed-pkgs.log
2025-12-05 09:16:42.407179 | controller | >f+++++++++ python.log
2025-12-05 09:16:42.407198 | controller | >f+++++++++ registries.conf
2025-12-05 09:16:42.407215 | controller | >f+++++++++ report.html
2025-12-05 09:16:42.407234 | controller | >f+++++++++ selinux-denials.log
2025-12-05 09:16:42.407252 | controller | >f+++++++++ selinux-listing.log
2025-12-05 09:16:42.407269 | controller | cd+++++++++ ci-framework-data/
2025-12-05 09:16:42.407286 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-12-05 09:16:42.407302 | controller | >f+++++++++ ci-framework-data/artifacts/ctlplane.yaml
2025-12-05 09:16:42.407318 | controller | >f+++++++++ ci-framework-data/artifacts/dataplane.yaml
2025-12-05 09:16:42.407334 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key
2025-12-05 09:16:42.407350 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub
2025-12-05 09:16:42.407365 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-ctlplane.yaml
2025-12-05 09:16:42.407380 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-dataplane.yaml
2025-12-05 09:16:42.407395 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-12-05 09:16:42.407411 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/
2025-12-05 09:16:42.407425 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/
2025-12-05 09:16:42.407441 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-12-05 09:16:42.407457 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/
2025-12-05 09:16:42.407473 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-12-05 09:16:42.407488 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml.32781.2025-12-05@09:16:28~
2025-12-05 09:16:42.407504 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/
2025-12-05 09:16:42.407519 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/
2025-12-05 09:16:42.407534 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml
2025-12-05 09:16:42.407556 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml
2025-12-05 09:16:42.407572 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml
2025-12-05 09:16:42.407587 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml
2025-12-05 09:16:42.407602 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/
2025-12-05 09:16:42.407616 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml
2025-12-05 09:16:42.407631 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml
2025-12-05 09:16:42.407655 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml.32612.2025-12-05@09:16:25~
2025-12-05 09:16:42.407672 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml
2025-12-05 09:16:42.407688 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml
2025-12-05 09:16:42.407703 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2025-12-05 09:16:42.407718 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2025-12-05 09:16:42.407733 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2025-12-05 09:16:42.407748 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-12-05 09:16:42.407763 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-12-05 09:16:42.407778 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/
2025-12-05 09:16:42.407793 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5
2025-12-05 09:16:42.407808 | controller | cd+++++++++ ci-framework-data/logs/
2025-12-05 09:16:42.407822 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-12-05 09:16:42.407837 | controller | cd+++++++++ registries.conf.d/
2025-12-05 09:16:42.407851 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-12-05 09:16:42.407865 | controller | cd+++++++++ system-config/
2025-12-05 09:16:42.407879 | controller | cd+++++++++ system-config/libvirt/
2025-12-05 09:16:42.407894 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-12-05 09:16:42.407928 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-12-05 09:16:42.786724 | controller | changed: .d..t...... ./
2025-12-05 09:16:43.148467 | controller | changed: .d..t...... ./
2025-12-05 09:16:43.162498 | 
2025-12-05 09:16:43.162611 | TASK [Return artifact to Zuul]
2025-12-05 09:16:43.191726 | controller | ok
2025-12-05 09:16:43.211121 | 
2025-12-05 09:16:43.211182 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-12-05 09:16:43.211289 | 
2025-12-05 09:16:43.211318 | PLAY RECAP
2025-12-05 09:16:43.211359 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-12-05 09:16:43.211381 | 
2025-12-05 09:16:43.307948 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-12-05 09:16:43.308742 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-05 09:16:43.850856 | 
2025-12-05 09:16:43.851037 | PLAY [all]
2025-12-05 09:16:43.871145 | 
2025-12-05 09:16:43.871234 | TASK [include_role : fetch-output]
2025-12-05 09:16:43.899987 | controller | ok
2025-12-05 09:16:43.916543 | 
2025-12-05 09:16:43.916623 | TASK [fetch-output : Set log path for multiple nodes]
2025-12-05 09:16:43.960951 | controller | skipping: Conditional result was False
2025-12-05 09:16:43.966564 | 
2025-12-05 09:16:43.966640 | TASK [fetch-output : Set log path for single node]
2025-12-05 09:16:43.995850 | controller | ok
2025-12-05 09:16:44.000833 | 
2025-12-05 09:16:44.000919 | LOOP [fetch-output : Ensure local output dirs]
2025-12-05 09:16:44.341181 | controller -> localhost | ok: "/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/logs"
2025-12-05 09:16:44.524617 | controller -> localhost | ok: "/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/artifacts"
2025-12-05 09:16:44.712641 | controller -> localhost | ok: "/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/docs"
2025-12-05 09:16:44.721990 | 
2025-12-05 09:16:44.722104 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-12-05 09:16:45.245000 | controller | ok
2025-12-05 09:16:45.245230 | controller | ok: All items complete
2025-12-05 09:16:45.245264 | 
2025-12-05 09:16:45.611392 | controller | ok
2025-12-05 09:16:45.979476 | controller | ok
2025-12-05 09:16:45.992025 | 
2025-12-05 09:16:45.992141 | TASK [include_role : fetch-output-openshift]
2025-12-05 09:16:46.005409 | controller | skipping: Conditional result was False
2025-12-05 09:16:46.011169 | 
2025-12-05 09:16:46.011240 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-12-05 09:16:46.355316 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007508
2025-12-05 09:16:46.557988 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.010943
2025-12-05 09:16:46.589621 | 
2025-12-05 09:16:46.589740 | PLAY [all]
2025-12-05 09:16:46.603525 | 
2025-12-05 09:16:46.603599 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-12-05 09:16:47.019145 | controller | changed
2025-12-05 09:16:47.040807 | 
2025-12-05 09:16:47.040865 | PLAY RECAP
2025-12-05 09:16:47.040927 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-12-05 09:16:47.040957 | 
2025-12-05 09:16:47.128373 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-12-05 09:16:47.129193 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-12-05 09:16:47.714481 | 
2025-12-05 09:16:47.714647 | PLAY [localhost]
2025-12-05 09:16:47.732688 | 
2025-12-05 09:16:47.732764 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-12-05 09:16:48.084961 | localhost | changed
2025-12-05 09:16:48.089775 | 
2025-12-05 09:16:48.089855 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-12-05 09:16:48.119363 | localhost | ok
2025-12-05 09:16:48.127303 | 
2025-12-05 09:16:48.127375 | TASK [add-fileserver : Create SSH private key tempfile]
2025-12-05 09:16:48.460694 | localhost | changed
2025-12-05 09:16:48.466801 | 
2025-12-05 09:16:48.466875 | TASK [add-fileserver : Create SSH private key from secret]
2025-12-05 09:16:49.052496 | localhost | changed
2025-12-05 09:16:49.057632 | 
2025-12-05 09:16:49.057712 | TASK [add-fileserver : Add fileserver ssh key]
2025-12-05 09:16:49.419473 | localhost | Identity added: /var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/tmp/ansible._54ydb7s (/var/lib/zuul/builds/f682485f07f041c3a6e1f5d451191645/work/tmp/ansible._54ydb7s)
2025-12-05 09:16:49.419674 | localhost | ok: Runtime: 0:00:00.011749
2025-12-05 09:16:49.424024 | 
2025-12-05 09:16:49.424095 | TASK [add-fileserver : Remove SSH private key from disk]
2025-12-05 09:16:49.675312 | localhost | ok: Runtime: 0:00:00.004446
2025-12-05 09:16:49.679981 | 
2025-12-05 09:16:49.680048 | TASK [add-fileserver : Add fileserver to inventory]
2025-12-05 09:16:49.728343 | localhost | changed
2025-12-05 09:16:49.732382 | 
2025-12-05 09:16:49.732449 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-12-05 09:16:50.064433 | localhost | changed
2025-12-05 09:16:50.084308 | 
2025-12-05 09:16:50.084381 | PLAY [localhost]
2025-12-05 09:16:50.096496 | 
2025-12-05 09:16:50.096561 | TASK [Generate bulk log download script]
2025-12-05 09:16:50.114388 | localhost | ok
2025-12-05 09:16:50.125989 | 
2025-12-05 09:16:50.126058 | TASK [local-log-download : Check API endpoint is defined]
2025-12-05 09:16:50.153949 | localhost | ok: All assertions passed
2025-12-05 09:16:50.158457 | 
2025-12-05 09:16:50.158519 | TASK [local-log-download : Create download script]
2025-12-05 09:16:50.517483 | localhost -> localhost | changed
2025-12-05 09:16:50.526511 | 
2025-12-05 09:16:50.526581 | TASK [Register quick-download link]
2025-12-05 09:16:50.544472 | localhost | ok
2025-12-05 09:16:50.583457 | 
2025-12-05 09:16:50.583538 | PLAY [logserver.rdoproject.org]
2025-12-05 09:16:50.592929 | 
2025-12-05 09:16:50.592995 | TASK [Set zuul-log-path fact]
2025-12-05 09:16:50.609212 | logserver.rdoproject.org | ok
2025-12-05 09:16:50.618437 | 
2025-12-05 09:16:50.618504 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-12-05 09:16:50.645016 | logserver.rdoproject.org | ok
2025-12-05 09:16:50.650280 | 
2025-12-05 09:16:50.650345 | TASK [upload-logs : Create log directories]
2025-12-05 09:16:52.318151 | logserver.rdoproject.org | changed
2025-12-05 09:16:52.321354 | 
2025-12-05 09:16:52.321421 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-12-05 09:16:52.558382 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.004887
2025-12-05 09:16:52.563747 | 
2025-12-05 09:16:52.563830 | TASK [upload-logs : Upload logs to log server]
2025-12-05 09:16:54.034943 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-12-05 09:16:54.038066 | 
2025-12-05 09:16:54.038132 | LOOP [upload-logs : Compress console log and json output]
2025-12-05 09:16:54.081017 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 09:16:54.089348 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 09:16:54.095093 | 
2025-12-05 09:16:54.095160 | LOOP [upload-logs : Upload compressed console log and json output]
2025-12-05 09:16:54.139289 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 09:16:54.139522 | 
2025-12-05 09:16:54.142668 | logserver.rdoproject.org | skipping: Conditional result was False
2025-12-05 09:16:54.153428 | 
2025-12-05 09:16:54.153498 | LOOP [upload-logs : Upload console log and json output]