2025-10-08 10:04:32.972525 | Job console starting...
2025-10-08 10:04:33.436408 | Updating repositories
2025-10-08 10:04:34.152492 | Preparing job workspace
2025-10-08 10:04:43.529120 | Running Ansible setup...
2025-10-08 10:04:46.377065 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-08 10:04:46.859417 | 
2025-10-08 10:04:46.859520 | PLAY [localhost]
2025-10-08 10:04:46.867254 | 
2025-10-08 10:04:46.867319 | TASK [Gathering Facts]
2025-10-08 10:04:47.633585 | localhost | ok
2025-10-08 10:04:47.645717 | 
2025-10-08 10:04:47.645792 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-08 10:04:47.942888 | localhost -> localhost | changed
2025-10-08 10:04:47.948128 | 
2025-10-08 10:04:47.948197 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-08 10:04:48.588804 | localhost -> localhost | changed
2025-10-08 10:04:48.597571 | 
2025-10-08 10:04:48.597644 | TASK [Setup log path fact]
2025-10-08 10:04:48.614147 | localhost | ok
2025-10-08 10:04:48.626727 | 
2025-10-08 10:04:48.626861 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-08 10:04:48.644364 | localhost | ok
2025-10-08 10:04:48.651130 | 
2025-10-08 10:04:48.651195 | TASK [emit-job-header : Print job information]
2025-10-08 10:04:48.677771 | # Job Information
2025-10-08 10:04:48.677886 | Ansible Version: 2.15.12
2025-10-08 10:04:48.677937 | Job: cifmw-molecule-kustomize_deploy
2025-10-08 10:04:48.677964 | Pipeline: github-check
2025-10-08 10:04:48.677985 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-08 10:04:48.678003 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237
2025-10-08 10:04:48.678022 | Log URL (when completed): https://logserver.rdoproject.org/699/rdoproject.org/699313da52ad4a718204663e8aef4c33/
2025-10-08 10:04:48.678039 | Event ID: 920c7930-a408-11f0-96e0-244f77bacc6d
2025-10-08 10:04:48.681421 | 
2025-10-08 10:04:48.681482 | LOOP [emit-job-header : Print node information]
2025-10-08 10:04:48.760642 | localhost | ok:
2025-10-08 10:04:48.760844 | localhost | # Node Information
2025-10-08 10:04:48.760871 | localhost | Inventory Hostname: controller
2025-10-08 10:04:48.760893 | localhost | Hostname: np0005475639
2025-10-08 10:04:48.760934 | localhost | Username: zuul
2025-10-08 10:04:48.760961 | localhost | Distro: CentOS 9
2025-10-08 10:04:48.760980 | localhost | Provider: ibm-bm4-nodepool
2025-10-08 10:04:48.760997 | localhost | Region: regionOne
2025-10-08 10:04:48.761013 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-08 10:04:48.761029 | localhost | Product Name: OpenStack Compute
2025-10-08 10:04:48.761043 | localhost | Interface IP: 192.168.26.120
2025-10-08 10:04:48.782472 | 
2025-10-08 10:04:48.782545 | PLAY [all]
2025-10-08 10:04:48.788357 | 
2025-10-08 10:04:48.788415 | TASK [Gather network facts]
2025-10-08 10:04:49.122320 | controller | ok
2025-10-08 10:04:49.134640 | 
2025-10-08 10:04:49.134698 | TASK [include_role : start-zuul-console]
2025-10-08 10:04:49.152280 | controller | ok
2025-10-08 10:04:49.164097 | 
2025-10-08 10:04:49.164161 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-08 10:04:49.446619 | controller | ok
2025-10-08 10:04:49.454127 | 
2025-10-08 10:04:49.454186 | TASK [include_role : add-build-sshkey]
2025-10-08 10:04:49.471257 | controller | ok
2025-10-08 10:04:49.482407 | 
2025-10-08 10:04:49.482469 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-08 10:04:49.658084 | controller -> localhost | ok
2025-10-08 10:04:49.663401 | 
2025-10-08 10:04:49.663459 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-08 10:04:49.680874 | controller | ok
2025-10-08 10:04:49.693019 | controller | included: /var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-08 10:04:49.698423 | 
2025-10-08 10:04:49.698481 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-08 10:04:50.096314 | controller -> localhost | Generating public/private rsa key pair.
2025-10-08 10:04:50.096511 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/699313da52ad4a718204663e8aef4c33_id_rsa.
2025-10-08 10:04:50.096543 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/699313da52ad4a718204663e8aef4c33_id_rsa.pub.
2025-10-08 10:04:50.096568 | controller -> localhost | The key fingerprint is:
2025-10-08 10:04:50.096588 | controller -> localhost | SHA256:RmOtwZCQJkyTkhMwQDoI+Y0NmEuXxAWmd1tofV5+4eY zuul-build-sshkey
2025-10-08 10:04:50.096607 | controller -> localhost | The key's randomart image is:
2025-10-08 10:04:50.096626 | controller -> localhost | +---[RSA 3072]----+
2025-10-08 10:04:50.096645 | controller -> localhost | |XX===+..         |
2025-10-08 10:04:50.096663 | controller -> localhost | |@oB=o +o .       |
2025-10-08 10:04:50.096681 | controller -> localhost | |=*.O + o*... .   |
2025-10-08 10:04:50.096698 | controller -> localhost | |..+ = ooo+o . .  |
2025-10-08 10:04:50.096715 | controller -> localhost | |     .  S. . +   |
2025-10-08 10:04:50.096733 | controller -> localhost | |       .    +    |
2025-10-08 10:04:50.096751 | controller -> localhost | |             E   |
2025-10-08 10:04:50.096768 | controller -> localhost | |                 |
2025-10-08 10:04:50.096785 | controller -> localhost | |                 |
2025-10-08 10:04:50.096802 | controller -> localhost | +----[SHA256]-----+
2025-10-08 10:04:50.096845 | controller -> localhost | ok: Runtime: 0:00:00.093329
2025-10-08 10:04:50.102117 | 
2025-10-08 10:04:50.102178 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-08 10:04:50.119866 | controller | ok
2025-10-08 10:04:50.128562 | controller | included: /var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-08 10:04:50.135556 | 
2025-10-08 10:04:50.135614 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-08 10:04:50.148675 | controller | skipping: Conditional result was False
2025-10-08 10:04:50.153835 | 
2025-10-08 10:04:50.153894 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-08 10:04:50.495519 | controller | changed
2025-10-08 10:04:50.500821 | 
2025-10-08 10:04:50.500884 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-08 10:04:50.692027 | controller | ok
2025-10-08 10:04:50.696934 | 
2025-10-08 10:04:50.697006 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-08 10:04:51.253194 | controller | changed
2025-10-08 10:04:51.257810 | 
2025-10-08 10:04:51.257875 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-08 10:04:51.823083 | controller | changed
2025-10-08 10:04:51.827361 | 
2025-10-08 10:04:51.827422 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-08 10:04:51.840375 | controller | skipping: Conditional result was False
2025-10-08 10:04:51.845739 | 
2025-10-08 10:04:51.845799 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-08 10:04:52.123376 | controller -> localhost | changed
2025-10-08 10:04:52.132385 | 
2025-10-08 10:04:52.132457 | TASK [add-build-sshkey : Add back temp key]
2025-10-08 10:04:52.348824 | controller -> localhost | Identity added: /var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/699313da52ad4a718204663e8aef4c33_id_rsa (zuul-build-sshkey)
2025-10-08 10:04:52.349078 | controller -> localhost | ok: Runtime: 0:00:00.007445
2025-10-08 10:04:52.355114 | 
2025-10-08 10:04:52.355189 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-08 10:04:52.636899 | controller | ok
2025-10-08 10:04:52.641598 | 
2025-10-08 10:04:52.641691 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-08 10:04:52.666283 | controller | skipping: Conditional result was False
2025-10-08 10:04:52.675574 | 
2025-10-08 10:04:52.675647 | TASK [include_role : validate-host]
2025-10-08 10:04:52.693616 | controller | ok
2025-10-08 10:04:52.713381 | 
2025-10-08 10:04:52.713452 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-08 10:04:52.741548 | controller | ok
2025-10-08 10:04:52.746233 | 
2025-10-08 10:04:52.746298 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-08 10:04:52.942438 | controller -> localhost | ok
2025-10-08 10:04:52.948561 | 
2025-10-08 10:04:52.948626 | TASK [validate-host : Collect information about the host]
2025-10-08 10:04:53.568479 | controller | ok
2025-10-08 10:04:53.576135 | 
2025-10-08 10:04:53.576198 | TASK [validate-host : Sanitize hostname]
2025-10-08 10:04:53.644587 | controller | ok
2025-10-08 10:04:53.649902 | 
2025-10-08 10:04:53.649990 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-08 10:04:54.020166 | controller -> localhost | changed
2025-10-08 10:04:54.024749 | 
2025-10-08 10:04:54.024813 | TASK [validate-host : Collect information about zuul worker]
2025-10-08 10:04:54.337526 | controller | ok
2025-10-08 10:04:54.341689 | 
2025-10-08 10:04:54.341752 | TASK [validate-host : Write out all zuul information for each host]
2025-10-08 10:04:54.679604 | controller -> localhost | changed
2025-10-08 10:04:54.688984 | 
2025-10-08 10:04:54.689051 | TASK [include_role : prepare-workspace-openshift]
2025-10-08 10:04:54.702539 | controller | skipping: Conditional result was False
2025-10-08 10:04:54.707500 | 
2025-10-08 10:04:54.707562 | TASK [include_role : remove-zuul-sshkey]
2025-10-08 10:04:54.720628 | controller | skipping: Conditional result was False
2025-10-08 10:04:54.725235 | 
2025-10-08 10:04:54.725299 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-08 10:04:54.924508 | controller | ok: "logs"
2025-10-08 10:04:54.924752 | controller | ok: All items complete
2025-10-08 10:04:54.924783 | 
2025-10-08 10:04:55.086107 | controller | ok: "artifacts"
2025-10-08 10:04:55.244929 | controller | ok: "docs"
2025-10-08 10:04:55.254864 | 
2025-10-08 10:04:55.254978 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-08 10:04:55.449437 | controller | changed: "logs"
2025-10-08 10:04:55.616430 | controller | changed: "artifacts"
2025-10-08 10:04:55.778457 | controller | changed: "docs"
2025-10-08 10:04:55.798035 | 
2025-10-08 10:04:55.798124 | PLAY RECAP
2025-10-08 10:04:55.798172 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-08 10:04:55.798198 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-08 10:04:55.798215 | 
2025-10-08 10:04:55.874773 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-08 10:04:55.875543 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-08 10:04:56.378399 | 
2025-10-08 10:04:56.378540 | PLAY [all]
2025-10-08 10:04:56.396230 | 
2025-10-08 10:04:56.396304 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-08 10:04:56.444611 | controller | ok
2025-10-08 10:04:56.449065 | 
2025-10-08 10:04:56.449139 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-08 10:04:56.793107 | controller | changed
2025-10-08 10:04:56.798105 | 
2025-10-08 10:04:56.798175 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-08 10:04:57.609486 | controller | changed
2025-10-08 10:04:57.618694 | 
2025-10-08 10:04:57.618769 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-08 10:04:57.970393 | controller | changed:
2025-10-08 10:04:57.970607 | controller | {
2025-10-08 10:04:57.970636 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-08 10:04:57.970665 | controller | }
2025-10-08 10:04:58.177589 | controller | changed:
2025-10-08 10:04:58.177647 | controller | {
2025-10-08 10:04:58.177676 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-08 10:04:58.177698 | controller | }
2025-10-08 10:04:58.371643 | controller | changed:
2025-10-08 10:04:58.371730 | controller | {
2025-10-08 10:04:58.371757 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com"
2025-10-08 10:04:58.371777 | controller | }
2025-10-08 10:04:58.566830 | controller | changed:
2025-10-08 10:04:58.566897 | controller | {
2025-10-08 10:04:58.566959 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-08 10:04:58.566991 | controller | }
2025-10-08 10:04:58.762074 | controller | changed:
2025-10-08 10:04:58.762122 | controller | {
2025-10-08 10:04:58.762146 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-08 10:04:58.762165 | controller | }
2025-10-08 10:04:58.954973 | controller | changed:
2025-10-08 10:04:58.955032 | controller | {
2025-10-08 10:04:58.955058 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-08 10:04:58.955077 | controller | }
2025-10-08 10:04:59.151009 | controller | changed:
2025-10-08 10:04:59.151063 | controller | {
2025-10-08 10:04:59.151087 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen"
2025-10-08 10:04:59.151107 | controller | }
2025-10-08 10:04:59.345114 | controller | changed:
2025-10-08 10:04:59.345168 | controller | {
2025-10-08 10:04:59.345195 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora"
2025-10-08 10:04:59.345217 | controller | }
2025-10-08 10:04:59.541340 | controller | changed:
2025-10-08 10:04:59.541395 | controller | {
2025-10-08 10:04:59.541420 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-08 10:04:59.541439 | controller | }
2025-10-08 10:04:59.735644 | controller | changed:
2025-10-08 10:04:59.735694 | controller | {
2025-10-08 10:04:59.735718 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-08 10:04:59.735738 | controller | }
2025-10-08 10:04:59.941362 | controller | changed:
2025-10-08 10:04:59.941412 | controller | {
2025-10-08 10:04:59.941435 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-08 10:04:59.941460 | controller | }
2025-10-08 10:05:00.177567 | controller | changed:
2025-10-08 10:05:00.177652 | controller | {
2025-10-08 10:05:00.177679 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-08 10:05:00.177698 | controller | }
2025-10-08 10:05:00.364141 | controller | changed:
2025-10-08 10:05:00.364189 | controller | {
2025-10-08 10:05:00.364214 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-08 10:05:00.364232 | controller | }
2025-10-08 10:05:00.561483 | controller | changed:
2025-10-08 10:05:00.561533 | controller | {
2025-10-08 10:05:00.561557 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-08 10:05:00.561576 | controller | }
2025-10-08 10:05:00.759023 | controller | changed:
2025-10-08 10:05:00.759114 | controller | {
2025-10-08 10:05:00.759145 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-08 10:05:00.759167 | controller | }
2025-10-08 10:05:00.956890 | controller | changed:
2025-10-08 10:05:00.956980 | controller | {
2025-10-08 10:05:00.957008 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-08 10:05:00.957027 | controller | }
2025-10-08 10:05:01.150528 | controller | changed:
2025-10-08 10:05:01.150578 | controller | {
2025-10-08 10:05:01.150605 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com"
2025-10-08 10:05:01.150627 | controller | }
2025-10-08 10:05:01.362538 | controller | changed:
2025-10-08 10:05:01.362642 | controller | {
2025-10-08 10:05:01.362694 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb"
2025-10-08 10:05:01.362731 | controller | }
2025-10-08 10:05:01.554182 | controller | changed:
2025-10-08 10:05:01.554228 | controller | {
2025-10-08 10:05:01.554251 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-08 10:05:01.554268 | controller | }
2025-10-08 10:05:01.753082 | controller | changed:
2025-10-08 10:05:01.753128 | controller | {
2025-10-08 10:05:01.753152 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-08 10:05:01.753171 | controller | }
2025-10-08 10:05:01.954876 | controller | changed:
2025-10-08 10:05:01.954947 | controller | {
2025-10-08 10:05:01.954981 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-08 10:05:01.955001 | controller | }
2025-10-08 10:05:02.146671 | controller | changed:
2025-10-08 10:05:02.146721 | controller | {
2025-10-08 10:05:02.146746 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-08 10:05:02.146766 | controller | }
2025-10-08 10:05:02.352298 | controller | changed:
2025-10-08 10:05:02.352403 | controller | {
2025-10-08 10:05:02.352435 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com"
2025-10-08 10:05:02.352458 | controller | }
2025-10-08 10:05:02.547423 | controller | changed:
2025-10-08 10:05:02.547470 | controller | {
2025-10-08 10:05:02.547494 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-08 10:05:02.547512 | controller | }
2025-10-08 10:05:02.745828 | controller | changed:
2025-10-08 10:05:02.745874 | controller | {
2025-10-08 10:05:02.745897 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-08 10:05:02.745936 | controller | }
2025-10-08 10:05:02.939321 | controller | changed:
2025-10-08 10:05:02.939376 | controller | {
2025-10-08 10:05:02.939408 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-08 10:05:02.939434 | controller | }
2025-10-08 10:05:02.962773 | 
2025-10-08 10:05:02.962838 | TASK [Set timezone to UTC]
2025-10-08 10:05:03.335722 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-08 10:05:03.339842 | 
2025-10-08 10:05:03.339903 | TASK [Create nodepool directory]
2025-10-08 10:05:03.541381 | controller | changed
2025-10-08 10:05:03.546139 | 
2025-10-08 10:05:03.546205 | TASK [Create nodepool sub_nodes file]
2025-10-08 10:05:04.071125 | controller | changed
2025-10-08 10:05:04.075639 | 
2025-10-08 10:05:04.075702 | TASK [Create nodepool sub_nodes_private file]
2025-10-08 10:05:04.579843 | controller | changed
2025-10-08 10:05:04.585358 | 
2025-10-08 10:05:04.585420 | LOOP [Populate nodepool sub_nodes file]
2025-10-08 10:05:04.614133 | 
2025-10-08 10:05:04.614255 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-08 10:05:04.642330 | 
2025-10-08 10:05:04.642447 | TASK [Create nodepool primary file]
2025-10-08 10:05:04.665696 | controller | skipping: Conditional result was False
2025-10-08 10:05:04.670724 | 
2025-10-08 10:05:04.670795 | TASK [Create nodepool node_private for this node]
2025-10-08 10:05:05.186246 | controller | changed
2025-10-08 10:05:05.192397 | 
2025-10-08 10:05:05.192462 | LOOP [Copy ssh keys to nodepool directory]
2025-10-08 10:05:05.515642 | controller | ok: Item: id_rsa Runtime: 0:00:00.005365
2025-10-08 10:05:05.515892 | 
2025-10-08 10:05:05.671737 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004450
2025-10-08 10:05:05.680898 | 
2025-10-08 10:05:05.681003 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-08 10:05:06.185707 | controller | changed
2025-10-08 10:05:06.190265 | 
2025-10-08 10:05:06.190323 | TASK [Validate sudoers config after edits]
2025-10-08 10:05:06.391195 | controller | /etc/sudoers: parsed OK
2025-10-08 10:05:06.391281 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-08 10:05:06.391292 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-08 10:05:06.391299 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-08 10:05:06.714470 | controller | ok: Runtime: 0:00:00.005388
2025-10-08 10:05:06.719399 | 
2025-10-08 10:05:06.719459 | TASK [Show the environment passed in to job shell scripts]
2025-10-08 10:05:06.904720 | controller | SHELL=/bin/bash
2025-10-08 10:05:06.904767 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-08 10:05:06.904778 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-08 10:05:06.904784 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/f73256b19c90fb94359fc527fcfcb675474058ed
2025-10-08 10:05:06.904790 | controller | PWD=/home/zuul
2025-10-08 10:05:06.904795 | controller | ZUUL_PIPELINE=github-check
2025-10-08 10:05:06.904844 | controller | LOGNAME=zuul
2025-10-08 10:05:06.904856 | controller | XDG_SESSION_TYPE=tty
2025-10-08 10:05:06.904861 | controller | _=/usr/bin/env
2025-10-08 10:05:06.904867 | controller | MOTD_SHOWN=pam
2025-10-08 10:05:06.904872 | controller | HOME=/home/zuul
2025-10-08 10:05:06.904886 | controller | LANG=en_US.UTF-8
2025-10-08 10:05:06.904892 | controller | SSH_CONNECTION=192.168.26.12 50128 192.168.26.120 22
2025-10-08 10:05:06.904897 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET
2025-10-08 10:05:06.904906 | controller | ZUUL_CHANGE_IDS=3237,f73256b19c90fb94359fc527fcfcb675474058ed
2025-10-08 10:05:06.904911 | controller | WORKSPACE=/home/zuul/workspace
2025-10-08 10:05:06.904916 | controller | XDG_SESSION_CLASS=user
2025-10-08 10:05:06.904922 | controller | SELINUX_ROLE_REQUESTED=
2025-10-08 10:05:06.904927 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-08 10:05:06.904932 | controller | USER=zuul
2025-10-08 10:05:06.904938 | controller | ZUUL_VOTING=True
2025-10-08 10:05:06.904943 | controller | BUILD_TIMEOUT=1800000
2025-10-08 10:05:06.904948 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-08 10:05:06.904953 | controller | SHLVL=1
2025-10-08 10:05:06.904958 | controller | ZUUL_PATCHSET=f73256b19c90fb94359fc527fcfcb675474058ed
2025-10-08 10:05:06.904964 | controller | XDG_SESSION_ID=1
2025-10-08 10:05:06.904969 | controller | ZUUL_BRANCH=main
2025-10-08 10:05:06.904974 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-08 10:05:06.904979 | controller | SSH_CLIENT=192.168.26.12 50128 22
2025-10-08 10:05:06.904984 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-08 10:05:06.904990 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-08 10:05:06.904995 | controller | which_declare=declare -f
2025-10-08 10:05:06.905000 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-08 10:05:06.905006 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-08 10:05:06.905011 | controller | ZUUL_CHANGE=3237
2025-10-08 10:05:06.905017 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-08 10:05:06.905022 | controller | ZUUL_UUID=699313da52ad4a718204663e8aef4c33
2025-10-08 10:05:06.905027 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-08 10:05:06.905034 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-08 10:05:06.905039 | controller | }
2025-10-08 10:05:07.243296 | controller | ok: Runtime: 0:00:00.006166
2025-10-08 10:05:07.248248 | 
2025-10-08 10:05:07.248307 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-08 10:05:07.261034 | controller | skipping: Conditional result was False
2025-10-08 10:05:07.265701 | 
2025-10-08 10:05:07.265760 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-08 10:05:07.787646 | controller | skipping: Conditional result was False
2025-10-08 10:05:07.793083 | 
2025-10-08 10:05:07.793147 | TASK [Ensure legacy workspace directory]
2025-10-08 10:05:07.964841 | controller | changed
2025-10-08 10:05:07.981196 | 
2025-10-08 10:05:07.981247 | PLAY RECAP
2025-10-08 10:05:07.981302 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-08 10:05:07.981325 | 
2025-10-08 10:05:08.062600 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-08 10:05:08.063329 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-08 10:05:08.525100 | 
2025-10-08 10:05:08.525208 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-08 10:05:08.544381 | 
2025-10-08 10:05:08.544450 | TASK [Create zuul-output directory]
2025-10-08 10:05:08.836698 | controller | changed
2025-10-08 10:05:08.842492 | 
2025-10-08 10:05:08.842598 | TASK [Slurp Zuul inventory test]
2025-10-08 10:05:09.100167 | controller -> localhost | ok
2025-10-08 10:05:09.106654 | 
2025-10-08 10:05:09.107031 | TASK [Save zuul inventory]
2025-10-08 10:05:09.809171 | controller | changed
2025-10-08 10:05:09.814058 | 
2025-10-08 10:05:09.814123 | TASK [Save zuul vars without the change_message]
2025-10-08 10:05:10.340826 | controller | changed
2025-10-08 10:05:10.358764 | 
2025-10-08 10:05:10.358818 | PLAY RECAP
2025-10-08 10:05:10.358862 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-08 10:05:10.358886 | 
2025-10-08 10:05:10.430668 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-08 10:05:10.431558 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-08 10:05:10.942775 | 
2025-10-08 10:05:10.942881 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-08 10:05:10.961483 | 
2025-10-08 10:05:10.961550 | TASK [Read group_vars]
2025-10-08 10:05:10.979701 | controller | ok
2025-10-08 10:05:10.995292 | 
2025-10-08 10:05:10.995364 | TASK [cifmw_helpers : Check directory is available]
2025-10-08 10:05:11.256715 | controller | ok
2025-10-08 10:05:11.261987 | 
2025-10-08 10:05:11.262054 | TASK [cifmw_helpers : List dir in ansible user home]
2025-10-08 10:05:11.539167 | controller | var one
2025-10-08 10:05:11.539936 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars'$'\n': No such file or directory
2025-10-08 10:05:11.542234 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-08 10:05:11.543585 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied
2025-10-08 10:05:11.544783 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory
2025-10-08 10:05:11.786274 | controller | ERROR
2025-10-08 10:05:11.786479 | controller | {
2025-10-08 10:05:11.786514 | controller |   "delta": "0:00:00.009508",
2025-10-08 10:05:11.786539 | controller |   "end": "2025-10-08 10:05:11.545095",
2025-10-08 10:05:11.786562 | controller |   "msg": "non-zero return code",
2025-10-08 10:05:11.786589 | controller |   "rc": 2,
2025-10-08 10:05:11.786611 | controller |   "start": "2025-10-08 10:05:11.535587"
2025-10-08 10:05:11.786633 | controller | }
2025-10-08 10:05:11.786658 | controller | ERROR: Ignoring Errors
2025-10-08 10:05:11.792035 | 
2025-10-08 10:05:11.792098 | TASK [cifmw_helpers : List available files]
2025-10-08 10:05:12.316880 | controller | skipping: Conditional result was False
2025-10-08 10:05:12.322876 | 
2025-10-08 10:05:12.322972 | LOOP [cifmw_helpers : Read vars]
2025-10-08 10:05:12.341871 | 
2025-10-08 10:05:12.342025 | LOOP [cifmw_helpers : Call task to parse all files as fact]
2025-10-08 10:05:12.364605 | 
2025-10-08 10:05:12.364726 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-08 10:05:12.382535 | controller | ok
2025-10-08 10:05:12.422226 | 
2025-10-08 10:05:12.422311 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-08 10:05:12.446237 | controller | skipping: Conditional result was False
2025-10-08 10:05:12.451944 | 
2025-10-08 10:05:12.452014 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-08 10:05:12.722861 | controller | ok
2025-10-08 10:05:12.727825 | 
2025-10-08 10:05:12.727882 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-08 10:05:13.242966 | controller | ok
2025-10-08 10:05:13.252292 | 
2025-10-08 10:05:13.252352 | TASK [Prepare workspace]
2025-10-08 10:05:13.270023 | controller | ok
2025-10-08 10:05:13.287924 | 
2025-10-08 10:05:13.287997 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-08 10:05:13.548865 | controller | ok
2025-10-08 10:05:13.555133 | 
2025-10-08 10:05:13.555191 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-08 10:05:15.913576 | controller | Output suppressed because no_log was given
2025-10-08 10:05:15.922218 | 
2025-10-08 10:05:15.922280 | LOOP [Create zuul-output directory]
2025-10-08 10:05:16.113257 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-08 10:05:16.113548 | 
2025-10-08 10:05:16.260947 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-08 10:05:16.266977 | 
2025-10-08 10:05:16.267070 | TASK [Install required packages]
2025-10-08 10:06:04.550624 | controller | changed
2025-10-08 10:06:04.555193 | 
2025-10-08 10:06:04.555253 | TASK [Install venv]
2025-10-08 10:07:07.360287 | controller | changed
2025-10-08 10:07:07.382679 | 
2025-10-08 10:07:07.382725 | PLAY RECAP
2025-10-08 10:07:07.382770 | controller | ok: 9 changed: 5 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-08 10:07:07.382792 | 
2025-10-08 10:07:07.452254 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-08 10:07:07.453708 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-08 10:07:07.926048 | 
2025-10-08 10:07:07.926144 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-08 10:07:07.944701 | 
2025-10-08 10:07:07.944767 | TASK [Gather required facts]
2025-10-08 10:07:08.390461 | controller | ok
2025-10-08 10:07:08.395180 | 
2025-10-08 10:07:08.395249 | TASK [Load environment var if instructed to]
2025-10-08 10:07:08.419424 | controller | skipping: Conditional result was False
2025-10-08 10:07:08.424440 | 
2025-10-08 10:07:08.424500 | TASK [Run molecule]
2025-10-08 10:07:09.276274 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-08 10:07:09.340349 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-08 10:07:26.052856 | controller | WARNING  Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.053278 | controller | WARNING  Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.053676 | controller | WARNING  Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.054101 | controller | WARNING  Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.054534 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+f73256b1 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 1.0.0+f73256b1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.054942 | controller | WARNING  Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.055345 | controller | WARNING  Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.055767 | controller | WARNING  Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.056162 | controller | WARNING  Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.056566 | controller | WARNING  Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.056979 | controller | WARNING  Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.057376 | controller | WARNING  Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.057798 | controller | WARNING  Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.058220 | controller | WARNING  Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.058696 | controller | WARNING  Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-08 10:07:26.067495 | controller | INFO     Running flexible_loop > prepare
2025-10-08 10:07:26.672725 | controller |
2025-10-08 10:07:26.672796 | controller | PLAY [Prepare] *****************************************************************
2025-10-08 10:07:26.672908 | controller |
2025-10-08 10:07:26.673013 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 10:07:26.673113 | controller | Wednesday 08 October 2025  10:07:26 +0000 (0:00:00.012)       0:00:00.012 *****
2025-10-08 10:07:27.490241 | controller | ok: [instance]
2025-10-08 10:07:27.490342 | controller |
2025-10-08 10:07:27.490488 | controller | TASK [Include ci_setup role] ***************************************************
2025-10-08 10:07:27.490623 | controller | Wednesday 08 October 2025  10:07:27 +0000 (0:00:00.818)       0:00:00.830 *****
2025-10-08 10:07:27.542289 | controller |
2025-10-08 10:07:27.542407 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2025-10-08 10:07:27.542565 | controller | Wednesday 08 October 2025  10:07:27 +0000 (0:00:00.052)       0:00:00.883 *****
2025-10-08 10:07:27.586977 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2025-10-08 10:07:27.587062 | controller |
2025-10-08 10:07:27.587176 | controller | TASK [ci_setup : List packages to install] *************************************
2025-10-08 10:07:27.588139 | controller | Wednesday 08 October 2025  10:07:27 +0000 (0:00:00.044)       0:00:00.927 *****
2025-10-08 10:07:27.608516 | controller | ok: [instance] =>
2025-10-08 10:07:27.608553 | controller |   cifmw_ci_setup_packages:
2025-10-08 10:07:27.608694 | controller |   - bash-completion
2025-10-08 10:07:27.608779 | controller |   - ca-certificates
2025-10-08 10:07:27.608874 | controller |   - git-core
2025-10-08 10:07:27.608989 | controller |   - make
2025-10-08 10:07:27.609068 | controller |   - tar
2025-10-08 10:07:27.609158 | controller |   - tmux
2025-10-08 10:07:27.609251 | controller |   - python3-pip
2025-10-08 10:07:27.609338 | controller |
2025-10-08 10:07:27.609455 | controller | TASK [ci_setup : Install needed packages] **************************************
2025-10-08 10:07:27.609567 | controller | Wednesday 08 October 2025  10:07:27 +0000 (0:00:00.021)       0:00:00.949 *****
2025-10-08 10:07:31.793361 | controller | changed: [instance]
2025-10-08 10:07:31.793430 | controller |
2025-10-08 10:07:31.793552 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2025-10-08 10:07:31.793651 | controller | Wednesday 08 October 2025  10:07:31 +0000 (0:00:04.184)       0:00:05.134 *****
2025-10-08 10:07:32.062960 | controller | ok: [instance]
2025-10-08 10:07:32.063046 | controller |
2025-10-08 10:07:32.063145 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2025-10-08 10:07:32.063245 | controller | Wednesday 08 October 2025  10:07:32 +0000 (0:00:00.269)       0:00:05.403 *****
2025-10-08 10:07:32.355345 | controller | changed: [instance]
2025-10-08 10:07:32.355417 | controller |
2025-10-08 10:07:32.355572 | controller | TASK [ci_setup : Install openshift client] *************************************
2025-10-08 10:07:32.355684 | controller | Wednesday 08 October 2025  10:07:32 +0000 (0:00:00.292)       0:00:05.696 *****
2025-10-08 10:07:38.263607 | controller | changed: [instance]
2025-10-08 10:07:38.263666 | controller |
2025-10-08 10:07:38.263778 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2025-10-08 10:07:38.263880 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:05.908)       0:00:11.604 *****
2025-10-08 10:07:38.296665 | controller | skipping: [instance]
2025-10-08 10:07:38.296755 | controller |
2025-10-08 10:07:38.296863 | controller | TASK [ci_setup : Create completion file] ***************************************
2025-10-08 10:07:38.296963 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.033)       0:00:11.637 *****
2025-10-08 10:07:38.550170 | controller | changed: [instance]
2025-10-08 10:07:38.550243 | controller |
2025-10-08 10:07:38.550367 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2025-10-08 10:07:38.550483 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.253)       0:00:11.890 *****
2025-10-08 10:07:38.810974 | controller | changed: [instance]
2025-10-08 10:07:38.811062 | controller |
2025-10-08 10:07:38.811166 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2025-10-08 10:07:38.811268 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.260)       0:00:12.151 *****
2025-10-08 10:07:38.828133 | controller | skipping: [instance]
2025-10-08 10:07:38.828267 | controller |
2025-10-08 10:07:38.828414 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2025-10-08 10:07:38.828586 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.017)       0:00:12.169 *****
2025-10-08 10:07:38.847141 | controller | skipping: [instance]
2025-10-08 10:07:38.847211 | controller |
2025-10-08 10:07:38.847304 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2025-10-08 10:07:38.847398 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.018)       0:00:12.188 *****
2025-10-08 10:07:38.865712 | controller | skipping: [instance]
2025-10-08 10:07:38.865777 | controller |
2025-10-08 10:07:38.865902 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2025-10-08 10:07:38.866010 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.018)       0:00:12.206 *****
2025-10-08 10:07:38.882867 | controller | skipping: [instance]
2025-10-08 10:07:38.882958 | controller |
2025-10-08 10:07:38.883063 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2025-10-08 10:07:38.883540 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.017)       0:00:12.223 *****
2025-10-08 10:07:38.898976 | controller | skipping: [instance]
2025-10-08 10:07:38.899066 | controller |
2025-10-08 10:07:38.899168 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2025-10-08 10:07:38.899269 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.016)       0:00:12.239 *****
2025-10-08 10:07:38.919719 | controller | skipping: [instance]
2025-10-08 10:07:38.919805 | controller |
2025-10-08 10:07:38.919921 | controller | TASK [ci_setup : Manage directories] *******************************************
2025-10-08 10:07:38.920025 | controller | Wednesday 08 October 2025  10:07:38 +0000 (0:00:00.020)       0:00:12.260 *****
2025-10-08 10:07:39.854185 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2025-10-08 10:07:40.208706 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2025-10-08 10:07:40.208736 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2025-10-08 10:07:40.208744 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2025-10-08 10:07:40.208750 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2025-10-08 10:07:40.208756 | controller |
2025-10-08 10:07:40.208762 | controller | TASK [Create nova migration keypair] *******************************************
2025-10-08 10:07:40.208767 | controller | Wednesday 08 October 2025  10:07:39 +0000 (0:00:00.933)       0:00:13.193 *****
2025-10-08 10:07:40.208777 | controller | changed: [instance]
2025-10-08 10:07:40.442524 | controller |
2025-10-08 10:07:40.442555 | controller | TASK [Create user keypair] *****************************************************
2025-10-08 10:07:40.442564 | controller | Wednesday 08 October 2025  10:07:40 +0000 (0:00:00.355)       0:00:13.549 *****
2025-10-08 10:07:40.442574 | controller | changed: [instance]
2025-10-08 10:07:40.442775 | controller |
2025-10-08 10:07:40.442794 | controller | TASK [Create fake kubeconfig] **************************************************
2025-10-08 10:07:40.830504 | controller | Wednesday 08 October 2025  10:07:40 +0000 (0:00:00.234)       0:00:13.783 *****
2025-10-08 10:07:40.830536 | controller | changed: [instance]
2025-10-08 10:07:40.830558 | controller |
2025-10-08 10:07:40.830564 | controller | PLAY RECAP *********************************************************************
2025-10-08 10:07:40.830570 | controller | instance                   : ok=13   changed=9    unreachable=0    failed=0    skipped=7    rescued=0    ignored=0
2025-10-08 10:07:40.830575 | controller |
2025-10-08 10:07:40.830580 | controller | Wednesday 08 October 2025  10:07:40 +0000 (0:00:00.386)       0:00:14.169 *****
2025-10-08 10:07:40.830585 | controller | ===============================================================================
2025-10-08 10:07:40.830590 | controller | ci_setup : Install openshift client ------------------------------------- 5.91s
2025-10-08 10:07:40.830599 | controller | ci_setup : Install needed packages -------------------------------------- 4.18s
2025-10-08 10:07:40.830604 | controller | ci_setup : Manage directories ------------------------------------------- 0.93s
2025-10-08 10:07:40.830609 | controller | Gathering Facts --------------------------------------------------------- 0.82s
2025-10-08 10:07:40.830614 | controller | Create fake kubeconfig -------------------------------------------------- 0.39s
2025-10-08 10:07:40.830619 | controller | Create nova migration keypair ------------------------------------------- 0.36s
2025-10-08 10:07:40.830623 | controller | ci_setup : Ensure openshift client install path is present -------------- 0.29s
2025-10-08 10:07:40.830631 | controller | ci_setup : Gather version of openshift client --------------------------- 0.27s
2025-10-08 10:07:40.830649 | controller | ci_setup : Source completion from within .bashrc ------------------------ 0.26s
2025-10-08 10:07:40.831600 | controller | ci_setup : Create completion file --------------------------------------- 0.25s
2025-10-08 10:07:40.880405 | controller | Create user keypair ----------------------------------------------------- 0.23s
2025-10-08 10:07:40.880451 | controller | Include ci_setup role --------------------------------------------------- 0.05s
2025-10-08 10:07:40.880462 | controller | ci_setup : Gather variables for each operating system ------------------- 0.04s
2025-10-08 10:07:40.880467 | controller | ci_setup : Add the OC path to cifmw_path if needed ---------------------- 0.03s
2025-10-08 10:07:40.880472 | controller | ci_setup : List packages to install ------------------------------------- 0.02s
2025-10-08 10:07:40.880477 | controller | ci_setup : Ensure the repos are enabled in the system using yum --------- 0.02s
2025-10-08 10:07:40.880481 | controller | ci_setup : Gather the repos to be enabled ------------------------------- 0.02s
2025-10-08 10:07:40.880486 | controller | ci_setup : Enabling the required repositories. -------------------------- 0.02s
2025-10-08 10:07:40.880491 | controller | ci_setup : Get current /etc/redhat-release ------------------------------ 0.02s
2025-10-08 10:07:40.880496 | controller | ci_setup : Check rhsm status -------------------------------------------- 0.02s
2025-10-08 10:07:40.880506 | controller | INFO     Running flexible_loop > converge
2025-10-08 10:07:41.272823 | controller |
2025-10-08 10:07:41.273009 | controller | PLAY [Converge] ****************************************************************
2025-10-08 10:07:41.273136 | controller |
2025-10-08 10:07:41.273262 | controller | TASK [Gathering Facts] *********************************************************
2025-10-08 10:07:41.273388 | controller | Wednesday 08 October 2025  10:07:41 +0000 (0:00:00.015)       0:00:00.015 *****
2025-10-08 10:07:42.006997 | controller | ok: [instance]
2025-10-08 10:07:42.047344 | controller |
2025-10-08 10:07:42.047372 | controller | TASK [Load networking environment definition] **********************************
2025-10-08 10:07:42.047381 | controller | Wednesday 08 October 2025  10:07:42 +0000 (0:00:00.733)       0:00:00.749 *****
2025-10-08 10:07:42.047392 | controller | ok: [instance]
2025-10-08 10:07:42.344926 | controller |
2025-10-08 10:07:42.344956 | controller | TASK [kustomize_deploy : Ensure that architecture repo exists] *****************
2025-10-08 10:07:42.344968 | controller | Wednesday 08 October 2025  10:07:42 +0000 (0:00:00.040)       0:00:00.790 *****
2025-10-08 10:07:42.344979 | controller | ok: [instance]
2025-10-08 10:07:42.650517 | controller |
2025-10-08 10:07:42.650547 | controller | TASK [kustomize_deploy : Gather the list of scenario folders] ******************
2025-10-08 10:07:42.650555 | controller | Wednesday 08 October 2025  10:07:42 +0000 (0:00:00.297)       0:00:01.087 *****
2025-10-08 10:07:42.650566 | controller | ok: [instance]
2025-10-08 10:07:42.650583 | controller |
2025-10-08 10:07:42.650594 | controller | TASK [kustomize_deploy : Check if scenario is in the list] *********************
2025-10-08 10:07:42.650604 | controller | Wednesday 08 October 2025  10:07:42 +0000 (0:00:00.305)       0:00:01.393 *****
2025-10-08 10:07:42.672074 | controller | skipping: [instance]
2025-10-08 10:07:42.953405 | controller |
2025-10-08 10:07:42.953448 | controller | TASK [kustomize_deploy : Ensure that destination directory exists] *************
2025-10-08 10:07:42.953459 | controller | Wednesday 08 October 2025  10:07:42 +0000 (0:00:00.021)       0:00:01.414 *****
2025-10-08 10:07:42.953469 | controller | changed: [instance]
2025-10-08 10:07:43.016849 | controller |
2025-10-08 10:07:43.016884 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize based on its patches] ***
2025-10-08 10:07:43.016898 | controller | Wednesday 08 October 2025  10:07:42 +0000 (0:00:00.281)       0:00:01.696 *****
2025-10-08 10:07:43.016908 | controller | ok: [instance] => (item=cifmw_architecture_user_kustomize)
2025-10-08 10:07:43.085969 | controller |
2025-10-08 10:07:43.085990 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize_base64 based on its patches] ***
2025-10-08 10:07:43.085997 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.063)       0:00:01.759 *****
2025-10-08 10:07:43.086007 | controller | ok: [instance]
2025-10-08 10:07:43.127510 | controller |
2025-10-08 10:07:43.127533 | controller | TASK [Load architecture automation] ********************************************
2025-10-08 10:07:43.127542 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.069)       0:00:01.828 *****
2025-10-08 10:07:43.127553 | controller | ok: [instance]
2025-10-08 10:07:43.127585 | controller |
2025-10-08 10:07:43.127596 | controller | TASK [Loop the deploy] *********************************************************
2025-10-08 10:07:43.127703 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.041)       0:00:01.870 *****
2025-10-08 10:07:43.330300 | controller |
2025-10-08 10:07:43.373532 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:07:43.373556 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.202)       0:00:02.073 *****
2025-10-08 10:07:43.373566 | controller | ok: [instance] => changed=false
2025-10-08 10:07:43.373588 | controller |   msg: All assertions passed
2025-10-08 10:07:43.373594 | controller |
2025-10-08 10:07:43.373600 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:07:43.373607 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.043)       0:00:02.116 *****
2025-10-08 10:07:43.404504 | controller | skipping: [instance]
2025-10-08 10:07:43.404673 | controller |
2025-10-08 10:07:43.404694 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:07:43.429553 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.031)       0:00:02.147 *****
2025-10-08 10:07:43.429574 | controller | ok: [instance] => (item=oc -n openstack wait nncp -l osp/nncm-config-type=standard --for jsonpath='{.status.conditions[0].reason}'=SuccessfullyConfigured --timeout=5m)
2025-10-08 10:07:43.450484 | controller |
2025-10-08 10:07:43.450502 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:07:43.450509 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.024)       0:00:02.172 *****
2025-10-08 10:07:43.450518 | controller | skipping: [instance]
2025-10-08 10:07:43.450856 | controller |
2025-10-08 10:07:43.485629 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:07:43.485646 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.021)       0:00:02.193 *****
2025-10-08 10:07:43.485656 | controller | ok: [instance]
2025-10-08 10:07:43.771886 | controller |
2025-10-08 10:07:43.771920 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:07:43.771928 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.034)       0:00:02.228 *****
2025-10-08 10:07:43.771938 | controller | ok: [instance] => (item={'name': 'network-values', 'src_file': 'values.yaml'})
2025-10-08 10:07:43.830425 | controller |
2025-10-08 10:07:43.830465 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:07:43.830472 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.286)       0:00:02.514 *****
2025-10-08 10:07:43.830482 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:07:43.873253 | controller |
2025-10-08 10:07:43.873275 | controller | TASK [Executing pre_stage hooks for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:43.873282 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.058)       0:00:02.573 *****
2025-10-08 10:07:43.873291 | controller | skipping: [instance]
2025-10-08 10:07:43.948168 | controller |
2025-10-08 10:07:43.948202 | controller | TASK [Generate values.yaml for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:43.948214 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.042)       0:00:02.616 *****
2025-10-08 10:07:43.948246 | controller |
2025-10-08 10:07:44.013599 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:07:44.013635 | controller | Wednesday 08 October 2025  10:07:43 +0000 (0:00:00.074)       0:00:02.690 *****
2025-10-08 10:07:44.013648 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:07:44.060476 | controller |
2025-10-08 10:07:44.060510 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:07:44.060522 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.065)       0:00:02.756 *****
2025-10-08 10:07:44.060537 | controller | ok: [instance] => changed=false
2025-10-08 10:07:44.253119 | controller |   msg: All assertions passed
2025-10-08 10:07:44.253145 | controller |
2025-10-08 10:07:44.253152 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:07:44.253158 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.046)       0:00:02.802 *****
2025-10-08 10:07:44.253167 | controller | ok: [instance]
2025-10-08 10:07:44.301315 | controller |
2025-10-08 10:07:44.301331 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:07:44.301337 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.193)       0:00:02.995 *****
2025-10-08 10:07:44.301345 | controller | ok: [instance] => changed=false
2025-10-08 10:07:44.591531 | controller |   msg: All assertions passed
2025-10-08 10:07:44.591557 | controller |
2025-10-08 10:07:44.591564 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:07:44.591569 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.048)       0:00:03.044 *****
2025-10-08 10:07:44.591579 | controller | ok: [instance]
2025-10-08 10:07:44.864157 | controller |
2025-10-08 10:07:44.864181 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:07:44.864188 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.290)       0:00:03.334 *****
2025-10-08 10:07:44.864198 | controller | ok: [instance]
2025-10-08 10:07:44.928296 | controller |
2025-10-08 10:07:44.928330 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:07:44.928339 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.272)       0:00:03.606 *****
2025-10-08 10:07:44.928348 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 10:07:44.979005 | controller |
2025-10-08 10:07:44.979026 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 10:07:44.979035 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.063)       0:00:03.670 *****
2025-10-08 10:07:44.979046 | controller | ok: [instance] => changed=false
2025-10-08 10:07:45.187619 | controller |   msg: All assertions passed
2025-10-08 10:07:45.187645 | controller |
2025-10-08 10:07:45.187652 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:07:45.187658 | controller | Wednesday 08 October 2025  10:07:44 +0000 (0:00:00.050)       0:00:03.721 *****
2025-10-08 10:07:45.187667 | controller | changed: [instance]
2025-10-08 10:07:45.715571 | controller |
2025-10-08 10:07:45.715605 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:07:45.715613 | controller | Wednesday 08 October 2025  10:07:45 +0000 (0:00:00.208)       0:00:03.930 *****
2025-10-08 10:07:45.715624 | controller | changed: [instance]
2025-10-08 10:07:45.715647 | controller |
2025-10-08 10:07:45.715659 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:07:45.715767 | controller | Wednesday 08 October 2025  10:07:45 +0000 (0:00:00.528)       0:00:04.458 *****
2025-10-08 10:07:45.777459 | controller | ok: [instance]
2025-10-08 10:07:46.131570 | controller |
2025-10-08 10:07:46.131604 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:07:46.131612 | controller | Wednesday 08 October 2025  10:07:45 +0000 (0:00:00.061)       0:00:04.520 *****
2025-10-08 10:07:46.131622 | controller | changed: [instance]
2025-10-08 10:07:46.474301 | controller |
2025-10-08 10:07:46.474331 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:07:46.474345 | controller | Wednesday 08 October 2025  10:07:46 +0000 (0:00:00.353)       0:00:04.874 *****
2025-10-08 10:07:46.474355 | controller | changed: [instance]
2025-10-08 10:07:46.810557 | controller |
2025-10-08 10:07:46.810587 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:07:46.810594 | controller | Wednesday 08 October 2025  10:07:46 +0000 (0:00:00.343)       0:00:05.217 *****
2025-10-08 10:07:46.810604 | controller | changed: [instance]
2025-10-08 10:07:46.874540 | controller |
2025-10-08 10:07:46.874571 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:07:46.874581 | controller | Wednesday 08 October 2025  10:07:46 +0000 (0:00:00.336)       0:00:05.553 *****
2025-10-08 10:07:46.874594 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:07:46.923114 | controller |
2025-10-08 10:07:46.923147 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:07:46.923155 | controller | Wednesday 08 October 2025  10:07:46 +0000 (0:00:00.063)       0:00:05.617 *****
2025-10-08 10:07:46.923165 | controller | ok: [instance] => changed=false
2025-10-08 10:07:46.923192 | controller |   msg: All assertions passed
2025-10-08 10:07:46.923293 | controller |
2025-10-08 10:07:46.923399 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:07:46.923539 | controller | Wednesday 08 October 2025  10:07:46 +0000 (0:00:00.049)       0:00:05.666 *****
2025-10-08 10:07:47.126532 | controller | ok: [instance]
2025-10-08 10:07:47.126578 | controller |
2025-10-08 10:07:47.126587 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:07:47.126596 | controller | Wednesday 08 October 2025  10:07:47 +0000 (0:00:00.202)       0:00:05.869 *****
2025-10-08 10:07:47.174533 | controller | ok: [instance]
2025-10-08 10:07:47.174580 | controller |
2025-10-08 10:07:47.174592 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:07:47.174783 | controller | Wednesday 08 October 2025  10:07:47 +0000 (0:00:00.048)       0:00:05.917 *****
2025-10-08 10:07:47.731061 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 10:07:47.854335 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 10:07:47.854360 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 10:07:47.854369 | controller |
2025-10-08 10:07:47.854376 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:07:47.854383 | controller | Wednesday 08 October 2025  10:07:47 +0000 (0:00:00.556)       0:00:06.473 *****
2025-10-08 10:07:47.854394 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 10:07:48.054505 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:07:48.054535 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:07:48.054542 | controller |
2025-10-08 10:07:48.054548 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:07:48.054554 | controller | Wednesday 08 October 2025  10:07:47 +0000 (0:00:00.123)       0:00:06.596 *****
2025-10-08 10:07:48.054563 | controller | changed: [instance]
2025-10-08 10:07:48.054587 | controller |
2025-10-08 10:07:48.054815 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:07:48.415411 | controller | Wednesday 08 October 2025  10:07:48 +0000 (0:00:00.200)       0:00:06.797 *****
2025-10-08 10:07:48.415457 | controller | changed: [instance]
2025-10-08 10:07:48.647134 | controller |
2025-10-08 10:07:48.647162 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:48.647170 | controller | Wednesday 08 October 2025  10:07:48 +0000 (0:00:00.360)       0:00:07.158 *****
2025-10-08 10:07:48.647180 | controller | changed: [instance] => (item=network-values)
2025-10-08 10:07:48.693333 | controller |
2025-10-08 10:07:48.693356 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:07:48.693370 | controller | Wednesday 08 October 2025  10:07:48 +0000 (0:00:00.231)       0:00:07.389 *****
2025-10-08 10:07:48.693379 | controller | skipping: [instance]
2025-10-08 10:07:49.148317 | controller |
2025-10-08 10:07:49.148348 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:49.148356 | controller | Wednesday 08 October 2025  10:07:48 +0000 (0:00:00.046)       0:00:07.436 *****
2025-10-08 10:07:49.148366 | controller | changed: [instance]
2025-10-08 10:07:49.494874 | controller |
2025-10-08 10:07:49.494904 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:07:49.494911 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.454)       0:00:07.890 *****
2025-10-08 10:07:49.494921 | controller | changed: [instance]
2025-10-08 10:07:49.714592 | controller |
2025-10-08 10:07:49.714614 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:49.714621 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.346)       0:00:08.237 *****
2025-10-08 10:07:49.714630 | controller | changed: [instance]
2025-10-08 10:07:49.761630 | controller |
2025-10-08 10:07:49.761647 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:07:49.761654 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.219)       0:00:08.457 *****
2025-10-08 10:07:49.761663 | controller | skipping: [instance]
2025-10-08 10:07:49.807518 | controller |
2025-10-08 10:07:49.807554 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:49.807562 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.046)       0:00:08.504 *****
2025-10-08 10:07:49.807572 | controller | skipping: [instance]
2025-10-08 10:07:49.807596 | controller |
2025-10-08 10:07:49.807778 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:49.853547 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.046)       0:00:08.550 *****
2025-10-08 10:07:49.853580 | controller | skipping: [instance] => (item=oc -n openstack wait nncp -l osp/nncm-config-type=standard --for jsonpath='{.status.conditions[0].reason}'=SuccessfullyConfigured --timeout=5m)
2025-10-08 10:07:49.853611 | controller | skipping: [instance]
2025-10-08 10:07:49.853886 | controller |
2025-10-08 10:07:49.898413 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:07:49.898433 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.045)       0:00:08.596 *****
2025-10-08 10:07:49.898466 | controller | skipping: [instance]
2025-10-08 10:07:49.946554 | controller |
2025-10-08 10:07:49.946578 | controller | TASK [Executing post_stage hooks for examples/va/hci/control-plane/networking/nncp] ***
2025-10-08 10:07:49.946586 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.044)       0:00:08.641 *****
2025-10-08 10:07:49.946597 | controller | skipping: [instance]
2025-10-08 10:07:49.946907 | controller |
2025-10-08 10:07:49.946926 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:07:49.991886 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.048)       0:00:08.689 *****
2025-10-08 10:07:49.991905 | controller | ok: [instance] => changed=false
2025-10-08 10:07:50.026714 | controller |   msg: All assertions passed
2025-10-08 10:07:50.026746 | controller |
2025-10-08 10:07:50.026758 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:07:50.026769 | controller | Wednesday 08 October 2025  10:07:49 +0000 (0:00:00.045)       0:00:08.734 *****
2025-10-08 10:07:50.026794 | controller | skipping: [instance]
2025-10-08 10:07:50.052126 | controller |
2025-10-08 10:07:50.052150 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:07:50.052160 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.034)       0:00:08.769 *****
2025-10-08 10:07:50.052172 | controller | ok: [instance] => (item=oc -n metallb-system wait pod -l app=metallb -l component=speaker --for condition=Ready --timeout=5m)
2025-10-08 10:07:50.073236 | controller |
2025-10-08 10:07:50.073252 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:07:50.073263 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.025)       0:00:08.794 *****
2025-10-08 10:07:50.073271 | controller | skipping: [instance]
2025-10-08 10:07:50.108423 | controller |
2025-10-08 10:07:50.108463 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:07:50.108474 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.021)       0:00:08.816 *****
2025-10-08 10:07:50.108486 | controller | ok: [instance]
2025-10-08 10:07:50.312270 | controller |
2025-10-08 10:07:50.312288 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:07:50.312295 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.034)       0:00:08.851 *****
2025-10-08 10:07:50.312303 | controller | ok: [instance] => (item={'name': 'network-values', 'src_file': 'nncp/values.yaml'})
2025-10-08 10:07:50.373305 | controller |
2025-10-08 10:07:50.373330 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:07:50.373339 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.203)       0:00:09.055 *****
2025-10-08 10:07:50.373351 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:07:50.419557 | controller |
2025-10-08 10:07:50.419582 | controller | TASK [Executing pre_stage hooks for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:50.419591 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.060)       0:00:09.115 *****
2025-10-08 10:07:50.419601 | controller | skipping: [instance]
2025-10-08 10:07:50.495915 | controller |
2025-10-08 10:07:50.495933 | controller | TASK [Generate values.yaml for examples/va/hci/control-plane/networking] *******
2025-10-08 10:07:50.495940 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.046)       0:00:09.162 *****
2025-10-08 10:07:50.495948 | controller |
2025-10-08 10:07:50.555144 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:07:50.555162 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.076)       0:00:09.238 *****
2025-10-08 10:07:50.555172 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:07:50.602585 | controller |
2025-10-08 10:07:50.602626 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:07:50.602636 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.058)       0:00:09.297 *****
2025-10-08 10:07:50.602650 | controller | ok: [instance] => changed=false
2025-10-08 10:07:50.801554 | controller |   msg: All assertions passed
2025-10-08 10:07:50.801582 | controller |
2025-10-08 10:07:50.801589 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:07:50.801596 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.047)       0:00:09.344 *****
2025-10-08 10:07:50.801605 | controller | ok: [instance]
2025-10-08 10:07:50.850382 | controller |
2025-10-08 10:07:50.850400 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:07:50.850406 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.199)       0:00:09.544 *****
2025-10-08 10:07:50.850414 | controller | ok: [instance] => changed=false
2025-10-08 10:07:51.042495 | controller |   msg: All assertions passed
2025-10-08 10:07:51.042513 | controller |
2025-10-08 10:07:51.042520 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:07:51.042525 | controller | Wednesday 08 October 2025  10:07:50 +0000 (0:00:00.049)       0:00:09.593 *****
2025-10-08 10:07:51.042534 | controller | ok: [instance]
2025-10-08 10:07:51.295251 | controller |
2025-10-08 10:07:51.295271 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:07:51.295278 | controller | Wednesday 08 October 2025  10:07:51 +0000 (0:00:00.192)       0:00:09.785 *****
2025-10-08 10:07:51.295287 | controller | ok: [instance]
2025-10-08 10:07:51.354611 | controller |
2025-10-08 10:07:51.354654 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:07:51.354666 | controller | Wednesday 08 October 2025  10:07:51 +0000 (0:00:00.252)       0:00:10.038 *****
2025-10-08 10:07:51.354682 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 10:07:51.354733 | controller |
2025-10-08 10:07:51.354747 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 10:07:51.354795 | controller | Wednesday 08 October 2025  10:07:51 +0000 (0:00:00.059)       0:00:10.097 *****
2025-10-08 10:07:51.402727 | controller | ok: [instance] => changed=false
2025-10-08 10:07:51.403799 | controller |   msg: All assertions passed
2025-10-08 10:07:51.404122 | controller |
2025-10-08 10:07:51.404140 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:07:51.404155 | controller | Wednesday 08 October 2025  10:07:51 +0000 (0:00:00.047)       0:00:10.144 *****
2025-10-08 10:07:51.601062 | controller | ok: [instance]
2025-10-08 10:07:52.050458 | controller |
2025-10-08 10:07:52.050487 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:07:52.050494 | controller | Wednesday 08 October 2025  10:07:51 +0000 (0:00:00.199)       0:00:10.343 *****
2025-10-08 10:07:52.050504 | controller | ok: [instance]
2025-10-08 10:07:52.113392 | controller |
2025-10-08 10:07:52.113414 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:07:52.113423 | controller | Wednesday 08 October 2025  10:07:52 +0000 (0:00:00.449)       0:00:10.793 *****
2025-10-08 10:07:52.113433 | controller | ok: [instance]
2025-10-08 10:07:52.471939 | controller |
2025-10-08 10:07:52.471968 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:07:52.471976 | controller | Wednesday 08 October 2025  10:07:52 +0000 (0:00:00.063)       0:00:10.856 *****
2025-10-08 10:07:52.471986 | controller | ok: [instance]
2025-10-08 10:07:52.831974 | controller |
2025-10-08 10:07:52.831996 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:07:52.832002 | controller | Wednesday 08 October 2025  10:07:52 +0000 (0:00:00.358)       0:00:11.214 *****
2025-10-08 10:07:52.832011 | controller | ok: [instance]
2025-10-08 10:07:53.206050 | controller |
2025-10-08 10:07:53.206079 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:07:53.206087 | controller | Wednesday 08 October 2025  10:07:52 +0000 (0:00:00.360)       0:00:11.574 *****
2025-10-08 10:07:53.206097 | controller | changed: [instance]
2025-10-08 10:07:53.267546 | controller |
2025-10-08 10:07:53.267589 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:07:53.267600 | controller | Wednesday 08 October 2025  10:07:53 +0000 (0:00:00.373)       0:00:11.948 *****
2025-10-08 10:07:53.267614 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:07:53.267647 | controller |
2025-10-08 10:07:53.267656 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:07:53.267665 | controller | Wednesday 08 October 2025  10:07:53 +0000 (0:00:00.061)       0:00:12.010 *****
2025-10-08 10:07:53.314575 | controller | ok: [instance] => changed=false
2025-10-08 10:07:53.528815 | controller |   msg: All assertions passed
2025-10-08 10:07:53.528840 | controller |
2025-10-08 10:07:53.528859 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:07:53.528865 | controller | Wednesday 08 October 2025  10:07:53 +0000 (0:00:00.047)       0:00:12.057 *****
2025-10-08 10:07:53.528874 | controller | ok: [instance]
2025-10-08 10:07:53.574253 | controller |
2025-10-08 10:07:53.574273 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:07:53.574281 | controller | Wednesday 08 October 2025  10:07:53 +0000 (0:00:00.214)       0:00:12.271 *****
2025-10-08 10:07:53.574292 | controller | ok: [instance]
2025-10-08 10:07:54.115516 | controller |
2025-10-08 10:07:54.115549 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:07:54.115565 | controller | Wednesday 08 October 2025  10:07:53 +0000 (0:00:00.045)       0:00:12.317 *****
2025-10-08 10:07:54.115576 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 10:07:54.115595 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 10:07:54.115689 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 10:07:54.116006 | controller |
2025-10-08 10:07:54.246567 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:07:54.246622 | controller | Wednesday 08 October 2025  10:07:54 +0000 (0:00:00.541)       0:00:12.858 *****
2025-10-08 10:07:54.246645 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 10:07:54.247125 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:07:54.461398 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:07:54.461428 | controller |
2025-10-08 10:07:54.461453 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:07:54.461463 | controller | Wednesday 08 October 2025  10:07:54 +0000 (0:00:00.130)       0:00:12.989 *****
2025-10-08 10:07:54.461473 | controller | ok: [instance]
2025-10-08 10:07:54.821988 | controller |
2025-10-08 10:07:54.822015 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:07:54.822022 | controller | Wednesday 08 October 2025  10:07:54 +0000 (0:00:00.214)       0:00:13.203 *****
2025-10-08 10:07:54.822031 | controller | ok: [instance]
2025-10-08 10:07:55.048993 | controller |
2025-10-08 10:07:55.049011 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:55.049018 | controller | Wednesday 08 October 2025  10:07:54 +0000 (0:00:00.360)       0:00:13.564 *****
2025-10-08 10:07:55.049026 | controller | ok: [instance] => (item=network-values)
2025-10-08 10:07:55.094102 | controller |
2025-10-08 10:07:55.094119 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:07:55.094126 | controller | Wednesday 08 October 2025  10:07:55 +0000 (0:00:00.227)       0:00:13.791 *****
2025-10-08 10:07:55.094134 | controller | skipping: [instance]
2025-10-08 10:07:55.466844 | controller |
2025-10-08 10:07:55.466879 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:55.466887 | controller | Wednesday 08 October 2025  10:07:55 +0000 (0:00:00.045)       0:00:13.837 *****
2025-10-08 10:07:55.466903 | controller | changed: [instance]
2025-10-08 10:07:55.813007 | controller |
2025-10-08 10:07:55.813029 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:07:55.813036 | controller | Wednesday 08 October 2025  10:07:55 +0000 (0:00:00.372)       0:00:14.209 *****
2025-10-08 10:07:55.813045 | controller | changed: [instance]
2025-10-08 10:07:56.017813 | controller |
2025-10-08 10:07:56.017833 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:56.017850 | controller | Wednesday 08 October 2025  10:07:55 +0000 (0:00:00.346)       0:00:14.555 *****
2025-10-08 10:07:56.017859 | controller | changed: [instance]
2025-10-08 10:07:56.061211 | controller |
2025-10-08 10:07:56.061229 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:07:56.061237 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.204)       0:00:14.760 *****
2025-10-08 10:07:56.061245 | controller | skipping: [instance]
2025-10-08 10:07:56.105308 | controller |
2025-10-08 10:07:56.105326 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:56.105333 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.043)       0:00:14.804 *****
2025-10-08 10:07:56.105341 | controller | skipping: [instance]
2025-10-08 10:07:56.152518 | controller |
2025-10-08 10:07:56.152556 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:56.152564 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.044)       0:00:14.848 *****
2025-10-08 10:07:56.152575 | controller | skipping: [instance] => (item=oc -n metallb-system wait pod -l app=metallb -l component=speaker --for condition=Ready --timeout=5m)
2025-10-08 10:07:56.152597 | controller | skipping: [instance]
2025-10-08 10:07:56.152604 | controller |
2025-10-08 10:07:56.152611 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:07:56.152686 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.047)       0:00:14.895 *****
2025-10-08 10:07:56.197970 | controller | skipping: [instance]
2025-10-08 10:07:56.246241 | controller |
2025-10-08 10:07:56.246264 | controller | TASK [Executing post_stage hooks for examples/va/hci/control-plane/networking] ***
2025-10-08 10:07:56.246275 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.045)       0:00:14.940 *****
2025-10-08 10:07:56.246286 | controller | skipping: [instance]
2025-10-08 10:07:56.289317 | controller |
2025-10-08 10:07:56.289340 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:07:56.289351 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.048)       0:00:14.989 *****
2025-10-08 10:07:56.289362 | controller | ok: [instance] => changed=false
2025-10-08 10:07:56.321322 | controller |   msg: All assertions passed
2025-10-08 10:07:56.321344 | controller |
2025-10-08 10:07:56.321353 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:07:56.321361 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.042)       0:00:15.031 *****
2025-10-08 10:07:56.321372 | controller | skipping: [instance]
2025-10-08 10:07:56.346607 | controller |
2025-10-08 10:07:56.346656 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:07:56.346669 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.032)       0:00:15.064 *****
2025-10-08 10:07:56.346687 | controller | ok: [instance] => (item=oc -n openstack wait osctlplane controlplane --for condition=Ready --timeout=60m)
2025-10-08 10:07:56.371087 | controller |
2025-10-08 10:07:56.371115 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:07:56.371125 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.025)       0:00:15.089 *****
2025-10-08 10:07:56.371137 | controller | skipping: [instance]
2025-10-08 10:07:56.406334 | controller |
2025-10-08 10:07:56.406351 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:07:56.406357 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.024)       0:00:15.113 *****
2025-10-08 10:07:56.406365 | controller | ok: [instance]
2025-10-08 10:07:56.786654 | controller |
2025-10-08 10:07:56.786676 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:07:56.786684 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.035)       0:00:15.149 *****
2025-10-08 10:07:56.786693 | controller | ok: [instance] => (item={'name': 'service-values', 'src_file': 'service-values.yaml'})
2025-10-08 10:07:56.870552 | controller | ok: [instance] => (item={'name': 'network-values', 'src_file': 'networking/nncp/values.yaml'})
2025-10-08 10:07:56.870589 | controller |
2025-10-08 10:07:56.870599 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:07:56.870608 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.380)       0:00:15.529 *****
2025-10-08 10:07:56.870621 | controller | ok: [instance] => (item=service-values.yaml)
2025-10-08 10:07:56.916460 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:07:56.916492 | controller |
2025-10-08 10:07:56.916501 | controller | TASK [Executing pre_stage hooks for examples/va/hci/control-plane] *************
2025-10-08 10:07:56.916509 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.084)       0:00:15.613 *****
2025-10-08 10:07:56.916520 | controller | skipping: [instance]
2025-10-08 10:07:57.028072 | controller |
2025-10-08 10:07:57.028095 | controller | TASK [Generate values.yaml for examples/va/hci/control-plane] ******************
2025-10-08 10:07:57.028108 | controller | Wednesday 08 October 2025  10:07:56 +0000 (0:00:00.045)       0:00:15.659 *****
2025-10-08 10:07:57.028117 | controller |
2025-10-08 10:07:57.112171 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:07:57.112203 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.111)       0:00:15.770 *****
2025-10-08 10:07:57.112222 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:07:57.162356 | controller |
2025-10-08 10:07:57.162372 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:07:57.162379 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.083)       0:00:15.854 *****
2025-10-08 10:07:57.162392 | controller | ok: [instance] => changed=false
2025-10-08 10:07:57.359619 | controller |   msg: All assertions passed
2025-10-08 10:07:57.359645 | controller |
2025-10-08 10:07:57.359652 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:07:57.359658 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.050)       0:00:15.905 *****
2025-10-08 10:07:57.359667 | controller | ok: [instance]
2025-10-08 10:07:57.408335 | controller |
2025-10-08 10:07:57.408353 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:07:57.408361 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.197)       0:00:16.102 *****
2025-10-08 10:07:57.408371 | controller | ok: [instance] => changed=false
2025-10-08 10:07:57.599550 | controller |   msg: All assertions passed
2025-10-08 10:07:57.599581 | controller |
2025-10-08 10:07:57.599589 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:07:57.599595 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.048)       0:00:16.151 *****
2025-10-08 10:07:57.599604 | controller | ok: [instance]
2025-10-08 10:07:57.768341 | controller |
2025-10-08 10:07:57.768385 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:07:57.768395 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.191)       0:00:16.342 *****
2025-10-08 10:07:57.768409 | controller | ok: [instance]
2025-10-08 10:07:57.768433 | controller |
2025-10-08 10:07:57.768537 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:07:57.768642 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.169)       0:00:16.511 *****
2025-10-08 10:07:57.815155 | controller | skipping: [instance]
2025-10-08 10:07:57.815248 | controller |
2025-10-08 10:07:57.815349 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:07:57.815473 | controller | Wednesday 08 October 2025  10:07:57 +0000 (0:00:00.046)       0:00:16.558 *****
2025-10-08 10:07:58.015158 | controller | changed: [instance]
2025-10-08 10:07:58.015202 | controller |
2025-10-08 10:07:58.015304 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:07:58.015400 | controller | Wednesday 08 October 2025  10:07:58 +0000 (0:00:00.199)       0:00:16.758 *****
2025-10-08 10:07:58.068940 | controller | skipping: [instance]
2025-10-08 10:07:58.069035 | controller |
2025-10-08 10:07:58.069146 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:07:58.069253 | controller | Wednesday 08 October 2025  10:07:58 +0000 (0:00:00.053)       0:00:16.812 *****
2025-10-08 10:07:58.129461 | controller | ok: [instance]
2025-10-08 10:07:58.129561 | controller |
2025-10-08 10:07:58.129664 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:07:58.129772 | controller | Wednesday 08 October 2025  10:07:58 +0000 (0:00:00.060)       0:00:16.872 *****
2025-10-08 10:07:58.480410 | controller | changed: [instance]
2025-10-08 10:07:58.480499 | controller |
2025-10-08 10:07:58.480766 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:07:58.838545 | controller | Wednesday 08 October 2025  10:07:58 +0000 (0:00:00.350)       0:00:17.223 *****
2025-10-08 10:07:58.838578 | controller | changed: [instance]
2025-10-08 10:07:59.186690 | controller |
2025-10-08 10:07:59.186719 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:07:59.186727 | controller | Wednesday 08 October 2025  10:07:58 +0000 (0:00:00.357)       0:00:17.581 *****
2025-10-08 10:07:59.186737 | controller | changed: [instance]
2025-10-08 10:07:59.247918 | controller |
2025-10-08 10:07:59.247946 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:07:59.247955 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.348)       0:00:17.929 *****
2025-10-08 10:07:59.247966 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:07:59.295481 | controller |
2025-10-08 10:07:59.295500 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:07:59.295507 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.061)       0:00:17.990 *****
2025-10-08 10:07:59.295524 | controller | ok: [instance] => changed=false
2025-10-08 10:07:59.295530 | controller |   msg: All assertions passed
2025-10-08 10:07:59.295536 | controller |
2025-10-08 10:07:59.295541 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:07:59.295553 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.047)       0:00:18.038 *****
2025-10-08 10:07:59.492120 | controller | ok: [instance]
2025-10-08 10:07:59.537889 | controller |
2025-10-08 10:07:59.537915 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:07:59.537923 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.196)       0:00:18.234 *****
2025-10-08 10:07:59.537934 | controller | ok: [instance]
2025-10-08 10:07:59.908033 | controller |
2025-10-08 10:07:59.908056 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:07:59.908063 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.045)       0:00:18.280 *****
2025-10-08 10:07:59.908072 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/03_user_data_b64.yaml)
2025-10-08 10:07:59.992342 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/04_user_data.yaml)
2025-10-08 10:07:59.992368 | controller |
2025-10-08 10:07:59.992377 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:07:59.992383 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.370)       0:00:18.650 *****
2025-10-08 10:07:59.992394 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:00.199714 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:00.199736 | controller |
2025-10-08 10:08:00.199743 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:00.199748 | controller | Wednesday 08 October 2025  10:07:59 +0000 (0:00:00.084)       0:00:18.735 *****
2025-10-08 10:08:00.199757 | controller | changed: [instance]
2025-10-08 10:08:00.550080 | controller |
2025-10-08 10:08:00.550107 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:00.550114 | controller | Wednesday 08 October 2025  10:08:00 +0000 (0:00:00.207)       0:00:18.942 *****
2025-10-08 10:08:00.550123 | controller | changed: [instance]
2025-10-08 10:08:00.609522 | controller |
2025-10-08 10:08:00.609550 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:08:00.609560 | controller | Wednesday 08 October 2025  10:08:00 +0000 (0:00:00.350)       0:00:19.292 *****
2025-10-08 10:08:00.609572 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:08:00.609714 | controller |
2025-10-08 10:08:00.609732 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:08:00.657543 | controller | Wednesday 08 October 2025  10:08:00 +0000 (0:00:00.059)       0:00:19.352 *****
2025-10-08 10:08:00.657585 | controller | ok: [instance] => changed=false
2025-10-08 10:08:00.657612 | controller |   msg: All assertions passed
2025-10-08 10:08:00.657619 | controller |
2025-10-08 10:08:00.657627 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:08:00.657767 | controller | Wednesday 08 October 2025  10:08:00 +0000 (0:00:00.047)       0:00:19.400 *****
2025-10-08 10:08:00.850981 | controller | ok: [instance]
2025-10-08 10:08:00.901180 | controller |
2025-10-08 10:08:00.901198 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:08:00.901205 | controller | Wednesday 08 October 2025  10:08:00 +0000 (0:00:00.193)       0:00:19.593 *****
2025-10-08 10:08:00.901215 | controller | ok: [instance] => changed=false
2025-10-08 10:08:01.093018 | controller |   msg: All assertions passed
2025-10-08 10:08:01.093043 | controller |
2025-10-08 10:08:01.093051 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:08:01.093057 | controller | Wednesday 08 October 2025  10:08:00 +0000 (0:00:00.050)       0:00:19.643 *****
2025-10-08 10:08:01.093066 | controller | ok: [instance]
2025-10-08 10:08:01.344542 | controller |
2025-10-08 10:08:01.344577 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:08:01.344592 | controller | Wednesday 08 October 2025  10:08:01 +0000 (0:00:00.191)       0:00:19.835 *****
2025-10-08 10:08:01.344603 | controller | ok: [instance]
2025-10-08 10:08:01.401976 | controller |
2025-10-08 10:08:01.402004 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:08:01.402013 | controller | Wednesday 08 October 2025  10:08:01 +0000 (0:00:00.251)       0:00:20.087 *****
2025-10-08 10:08:01.402024 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance
2025-10-08 10:08:01.448842 | controller |
2025-10-08 10:08:01.448865 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-08 10:08:01.448874 | controller | Wednesday 08 October 2025  10:08:01 +0000 (0:00:00.057)       0:00:20.144 *****
2025-10-08 10:08:01.448885 | controller | ok: [instance] => changed=false
2025-10-08 10:08:01.643980 | controller |   msg: All assertions passed
2025-10-08 10:08:01.644008 | controller |
2025-10-08 10:08:01.644016 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:08:01.644022 | controller | Wednesday 08 October 2025  10:08:01 +0000 (0:00:00.046)       0:00:20.191 *****
2025-10-08 10:08:01.644032 | controller | ok: [instance]
2025-10-08 10:08:02.074916 | controller |
2025-10-08 10:08:02.074943 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:08:02.074951 | controller | Wednesday 08 October 2025  10:08:01 +0000 (0:00:00.195)       0:00:20.386 *****
2025-10-08 10:08:02.074960 | controller | ok: [instance]
2025-10-08 10:08:02.131427 | controller |
2025-10-08 10:08:02.131459 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:08:02.131472 | controller | Wednesday 08 October 2025  10:08:02 +0000 (0:00:00.430)       0:00:20.817 *****
2025-10-08 10:08:02.131481 | controller | ok: [instance]
2025-10-08 10:08:02.477156 | controller |
2025-10-08 10:08:02.477185 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:08:02.477193 | controller | Wednesday 08 October 2025  10:08:02 +0000 (0:00:00.056)       0:00:20.874 *****
2025-10-08 10:08:02.477202 | controller | ok: [instance]
2025-10-08 10:08:02.827953 | controller |
2025-10-08 10:08:02.827981 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:08:02.827988 | controller | Wednesday 08 October 2025  10:08:02 +0000 (0:00:00.345)       0:00:21.219 *****
2025-10-08 10:08:02.827998 | controller | ok: [instance]
2025-10-08 10:08:03.174955 | controller |
2025-10-08 10:08:03.174985 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:08:03.174993 | controller | Wednesday 08 October 2025  10:08:02 +0000 (0:00:00.350)       0:00:21.570 *****
2025-10-08 10:08:03.175004 | controller | ok: [instance]
2025-10-08 10:08:03.239557 | controller |
2025-10-08 10:08:03.239588 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:08:03.239597 | controller | Wednesday 08 October 2025  10:08:03 +0000 (0:00:00.346)       0:00:21.917 *****
2025-10-08 10:08:03.239610 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:08:03.239630 | controller |
2025-10-08 10:08:03.239640 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:08:03.239700 | controller | Wednesday 08 October 2025  10:08:03 +0000 (0:00:00.064)       0:00:21.982 *****
2025-10-08 10:08:03.327591 | controller | ok: [instance] => changed=false
2025-10-08 10:08:03.534822 | controller |   msg: All assertions passed
2025-10-08 10:08:03.534847 | controller |
2025-10-08 10:08:03.534855 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:08:03.534861 | controller | Wednesday 08 October 2025  10:08:03 +0000 (0:00:00.087)       0:00:22.070 *****
2025-10-08 10:08:03.534871 | controller | ok: [instance]
2025-10-08 10:08:03.582875 | controller |
2025-10-08 10:08:03.582898 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:08:03.582906 | controller | Wednesday 08 October 2025  10:08:03 +0000 (0:00:00.207)       0:00:22.277 *****
2025-10-08 10:08:03.582923 | controller | ok: [instance]
2025-10-08 10:08:04.144274 | controller |
2025-10-08 10:08:04.144300 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:08:04.144307 | controller | Wednesday 08 October 2025  10:08:03 +0000 (0:00:00.048)       0:00:22.325 *****
2025-10-08 10:08:04.144316 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-08 10:08:04.269091 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-08 10:08:04.269111 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-08 10:08:04.269118 | controller |
2025-10-08 10:08:04.269123 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:08:04.269128 | controller | Wednesday 08 October 2025  10:08:04 +0000 (0:00:00.561)       0:00:22.886 *****
2025-10-08 10:08:04.269137 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 10:08:04.482387 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:04.482407 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:04.482413 | controller |
2025-10-08 10:08:04.482419 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:04.482424 | controller | Wednesday 08 October 2025  10:08:04 +0000 (0:00:00.124)       0:00:23.011 *****
2025-10-08 10:08:04.482432 | controller | ok: [instance]
2025-10-08 10:08:04.845867 | controller |
2025-10-08 10:08:04.845891 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:04.845898 | controller | Wednesday 08 October 2025  10:08:04 +0000 (0:00:00.213)       0:00:23.225 *****
2025-10-08 10:08:04.845907 | controller | ok: [instance]
2025-10-08 10:08:05.284541 | controller |
2025-10-08 10:08:05.284576 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/control-plane] ***
2025-10-08 10:08:05.284584 | controller | Wednesday 08 October 2025  10:08:04 +0000 (0:00:00.363)       0:00:23.588 *****
2025-10-08 10:08:05.284595 | controller | changed: [instance] => (item=service-values)
2025-10-08 10:08:05.329795 | controller | ok: [instance] => (item=network-values)
2025-10-08 10:08:05.329834 | controller |
2025-10-08 10:08:05.329842 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:08:05.329848 | controller | Wednesday 08 October 2025  10:08:05 +0000 (0:00:00.438)       0:00:24.027 *****
2025-10-08 10:08:05.329858 | controller | skipping: [instance]
2025-10-08 10:08:05.643129 | controller |
2025-10-08 10:08:05.643158 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/control-plane] ***
2025-10-08 10:08:05.643166 | controller | Wednesday 08 October 2025  10:08:05 +0000 (0:00:00.045)       0:00:24.072 *****
2025-10-08 10:08:05.643176 | controller | changed: [instance]
2025-10-08 10:08:05.986067 | controller |
2025-10-08 10:08:05.986096 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:08:05.986104 | controller | Wednesday 08 October 2025  10:08:05 +0000 (0:00:00.312)       0:00:24.385 *****
2025-10-08 10:08:05.986118 | controller | changed: [instance]
2025-10-08 10:08:06.193903 | controller |
2025-10-08 10:08:06.193930 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/control-plane] ***
2025-10-08 10:08:06.193937 | controller | Wednesday 08 October 2025  10:08:05 +0000 (0:00:00.342)       0:00:24.728 *****
2025-10-08 10:08:06.193947 | controller | changed: [instance]
2025-10-08 10:08:06.238558 | controller |
2025-10-08 10:08:06.238579 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:08:06.238587 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.207)       0:00:24.936 *****
2025-10-08 10:08:06.238596 | controller | skipping: [instance]
2025-10-08 10:08:06.282480 | controller |
2025-10-08 10:08:06.282509 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/control-plane] ***
2025-10-08 10:08:06.282516 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.044)       0:00:24.981 *****
2025-10-08 10:08:06.282524 | controller | skipping: [instance]
2025-10-08 10:08:06.332601 | controller |
2025-10-08 10:08:06.332651 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/control-plane] ***
2025-10-08 10:08:06.332677 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.043)       0:00:25.025 *****
2025-10-08 10:08:06.332696 | controller | skipping: [instance] => (item=oc -n openstack wait osctlplane controlplane --for condition=Ready --timeout=60m)
2025-10-08 10:08:06.332707 | controller | skipping: [instance]
2025-10-08 10:08:06.332717 | controller |
2025-10-08 10:08:06.332730 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:08:06.380503 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.050)       0:00:25.075 *****
2025-10-08 10:08:06.380530 | controller | skipping: [instance]
2025-10-08 10:08:06.432166 | controller |
2025-10-08 10:08:06.432190 | controller | TASK [Executing post_stage hooks for examples/va/hci/control-plane] ************
2025-10-08 10:08:06.432200 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.047)       0:00:25.123 *****
2025-10-08 10:08:06.432210 | controller | skipping: [instance]
2025-10-08 10:08:06.476236 | controller |
2025-10-08 10:08:06.476253 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:08:06.476259 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.051)       0:00:25.174 *****
2025-10-08 10:08:06.476267 | controller | ok: [instance] => changed=false
2025-10-08 10:08:06.507480 | controller |   msg: All assertions passed
2025-10-08 10:08:06.507496 | controller |
2025-10-08 10:08:06.507503 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:08:06.507509 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.044)       0:00:25.219 *****
2025-10-08 10:08:06.507516 | controller | skipping: [instance]
2025-10-08 10:08:06.507842 | controller |
2025-10-08 10:08:06.533521 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:08:06.533546 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.031)       0:00:25.250 *****
2025-10-08 10:08:06.533559 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-08 10:08:06.555515 | controller |
2025-10-08 10:08:06.555541 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:08:06.555550 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.025)       0:00:25.276 *****
2025-10-08 10:08:06.555561 | controller | skipping: [instance]
2025-10-08 10:08:06.555592 | controller |
2025-10-08 10:08:06.555777 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:08:06.593049 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.022)       0:00:25.298 *****
2025-10-08 10:08:06.593069 | controller | ok: [instance]
2025-10-08 10:08:06.798989 | controller |
2025-10-08 10:08:06.799015 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:08:06.799023 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.037)       0:00:25.336 *****
2025-10-08 10:08:06.799033 | controller | ok: [instance] => (item={'name': 'edpm-nodeset-values', 'src_file': 'values.yaml'})
2025-10-08 10:08:06.860171 | controller |
2025-10-08 10:08:06.860188 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:08:06.860195 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.205)       0:00:25.541 *****
2025-10-08 10:08:06.860203 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:08:06.905586 | controller |
2025-10-08 10:08:06.905622 | controller | TASK [Executing pre_stage hooks for examples/va/hci/edpm-pre-ceph/nodeset] *****
2025-10-08 10:08:06.905636 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.061)       0:00:25.603 *****
2025-10-08 10:08:06.905652 | controller | skipping: [instance]
2025-10-08 10:08:06.981094 | controller |
2025-10-08 10:08:06.981118 | controller | TASK [Generate values.yaml for examples/va/hci/edpm-pre-ceph/nodeset] **********
2025-10-08 10:08:06.981126 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.045)       0:00:25.648 *****
2025-10-08 10:08:06.981136 | controller |
2025-10-08 10:08:07.041547 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:08:07.041626 | controller | Wednesday 08 October 2025  10:08:06 +0000 (0:00:00.075)       0:00:25.724 *****
2025-10-08 10:08:07.041646 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:08:07.089260 | controller |
2025-10-08 10:08:07.089280 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:08:07.089287 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.060)       0:00:25.784 *****
2025-10-08 10:08:07.089296 | controller | ok: [instance] => changed=false
2025-10-08 10:08:07.291860 | controller |   msg: All assertions passed
2025-10-08 10:08:07.291887 | controller |
2025-10-08 10:08:07.291895 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:08:07.291900 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.047)       0:00:25.832 *****
2025-10-08 10:08:07.291909 | controller | ok: [instance]
2025-10-08 10:08:07.340578 | controller |
2025-10-08 10:08:07.340617 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:08:07.340627 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.202)       0:00:26.034 *****
2025-10-08 10:08:07.340640 | controller | ok: [instance] => changed=false
2025-10-08 10:08:07.340675 | controller |   msg: All assertions passed
2025-10-08 10:08:07.340996 | controller |
2025-10-08 10:08:07.534145 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:08:07.534165 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.049)       0:00:26.083 *****
2025-10-08 10:08:07.534175 | controller | ok: [instance]
2025-10-08 10:08:07.790562 | controller |
2025-10-08 10:08:07.790604 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:08:07.790614 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.193)       0:00:26.276 *****
2025-10-08 10:08:07.790627 | controller | ok: [instance]
2025-10-08 10:08:07.790657 | controller |
2025-10-08 10:08:07.790891 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:08:07.877017 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.256)       0:00:26.533 *****
2025-10-08 10:08:07.877055 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_nodeset_values.yml for instance
2025-10-08 10:08:07.947608 | controller |
2025-10-08 10:08:07.947646 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-10-08 10:08:07.947656 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.086)       0:00:26.619 *****
2025-10-08 10:08:07.947669 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_asserts.yml for instance
2025-10-08 10:08:07.995041 | controller |
2025-10-08 10:08:07.995068 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-10-08 10:08:07.995076 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.070)       0:00:26.690 *****
2025-10-08 10:08:07.995090 | controller | ok: [instance] => changed=false
2025-10-08 10:08:08.046583 | controller |   msg: All assertions passed
2025-10-08 10:08:08.046615 | controller |
2025-10-08 10:08:08.046625 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-10-08 10:08:08.046633 | controller | Wednesday 08 October 2025  10:08:07 +0000 (0:00:00.047)       0:00:26.737 *****
2025-10-08 10:08:08.046645 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/edpm_core_facts.yml for instance
2025-10-08 10:08:08.046677 | controller |
2025-10-08 10:08:08.046899 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-10-08 10:08:08.084017 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.051)       0:00:26.789 *****
2025-10-08 10:08:08.084039 | controller | skipping: [instance]
2025-10-08 10:08:08.123166 | controller |
2025-10-08 10:08:08.123184 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-10-08 10:08:08.123191 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.037)       0:00:26.826 *****
2025-10-08 10:08:08.123200 | controller | ok: [instance]
2025-10-08 10:08:08.123352 | controller |
2025-10-08 10:08:08.123545 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-10-08 10:08:08.123701 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.039)       0:00:26.866 *****
2025-10-08 10:08:08.166077 | controller | ok: [instance] => changed=false
2025-10-08 10:08:08.166276 | controller |   msg: All assertions passed
2025-10-08 10:08:08.166464 | controller |
2025-10-08 10:08:08.166659 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:08:08.166844 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.042)       0:00:26.909 *****
2025-10-08 10:08:08.368865 | controller | changed: [instance]
2025-10-08 10:08:08.747197 | controller |
2025-10-08 10:08:08.747224 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:08:08.747231 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.202)       0:00:27.111 *****
2025-10-08 10:08:08.747240 | controller | changed: [instance]
2025-10-08 10:08:08.798884 | controller |
2025-10-08 10:08:08.798908 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:08:08.798916 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.378)       0:00:27.489 *****
2025-10-08 10:08:08.798926 | controller | ok: [instance]
2025-10-08 10:08:09.119251 | controller |
2025-10-08 10:08:09.119280 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:08:09.119288 | controller | Wednesday 08 October 2025  10:08:08 +0000 (0:00:00.051)       0:00:27.541 *****
2025-10-08 10:08:09.119299 | controller | changed: [instance]
2025-10-08 10:08:09.451010 | controller |
2025-10-08 10:08:09.451038 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:08:09.451046 | controller | Wednesday 08 October 2025  10:08:09 +0000 (0:00:00.320)       0:00:27.861 *****
2025-10-08 10:08:09.451061 | controller | changed: [instance]
2025-10-08 10:08:09.787364 | controller |
2025-10-08 10:08:09.787389 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:08:09.787396 | controller | Wednesday 08 October 2025  10:08:09 +0000 (0:00:00.331)       0:00:28.193 *****
2025-10-08 10:08:09.787405 | controller | changed: [instance]
2025-10-08 10:08:09.838548 | controller |
2025-10-08 10:08:09.838569 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:08:09.838577 | controller | Wednesday 08 October 2025  10:08:09 +0000 (0:00:00.336)       0:00:28.530 *****
2025-10-08 10:08:09.838587 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:08:09.876424 | controller |
2025-10-08 10:08:09.876459 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:08:09.876470 | controller | Wednesday 08 October 2025  10:08:09 +0000 (0:00:00.051)       0:00:28.581 *****
2025-10-08 10:08:09.876480 | controller | ok: [instance] => changed=false
2025-10-08 10:08:09.876508 | controller |   msg: All assertions passed
2025-10-08 10:08:09.876655 | controller |
2025-10-08 10:08:09.876821 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:08:10.067215 | controller | Wednesday 08 October 2025  10:08:09 +0000 (0:00:00.038)       0:00:28.619 *****
2025-10-08 10:08:10.067242 | controller | ok: [instance]
2025-10-08 10:08:10.103853 | controller |
2025-10-08 10:08:10.103871 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:08:10.103877 | controller | Wednesday 08 October 2025  10:08:10 +0000 (0:00:00.190)       0:00:28.809 *****
2025-10-08 10:08:10.103885 | controller | ok: [instance]
2025-10-08 10:08:10.634082 | controller |
2025-10-08 10:08:10.634110 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:08:10.634117 | controller | Wednesday 08 October 2025  10:08:10 +0000 (0:00:00.036)       0:00:28.846 *****
2025-10-08 10:08:10.634126 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-10-08 10:08:10.745285 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-10-08 10:08:10.745303 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-10-08 10:08:10.745314 | controller |
2025-10-08 10:08:10.745319 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:08:10.745324 | controller | Wednesday 08 October 2025  10:08:10 +0000 (0:00:00.529)       0:00:29.376 *****
2025-10-08 10:08:10.745332 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-08 10:08:10.936465 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:10.936488 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:10.936495 | controller |
2025-10-08 10:08:10.936500 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:10.936506 | controller | Wednesday 08 October 2025  10:08:10 +0000 (0:00:00.111)       0:00:29.487 *****
2025-10-08 10:08:10.936514 | controller | changed: [instance]
2025-10-08 10:08:11.268542 | controller |
2025-10-08 10:08:11.268565 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:11.268573 | controller | Wednesday 08 October 2025  10:08:10 +0000 (0:00:00.191)       0:00:29.679 *****
2025-10-08 10:08:11.268582 | controller | changed: [instance]
2025-10-08 10:08:11.485826 | controller |
2025-10-08 10:08:11.485856 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-08 10:08:11.485864 | controller | Wednesday 08 October 2025  10:08:11 +0000 (0:00:00.331)       0:00:30.011 *****
2025-10-08 10:08:11.485874 | controller | changed: [instance] => (item=edpm-nodeset-values)
2025-10-08 10:08:11.521591 | controller |
2025-10-08 10:08:11.521635 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:08:11.521647 | controller | Wednesday 08 October 2025  10:08:11 +0000 (0:00:00.217)       0:00:30.228 *****
2025-10-08 10:08:11.521663 | controller | skipping: [instance]
2025-10-08 10:08:11.521701 | controller |
2025-10-08 10:08:11.521714 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-08 10:08:11.521803 | controller | Wednesday 08 October 2025  10:08:11 +0000 (0:00:00.036)       0:00:30.264 *****
2025-10-08 10:08:11.804162 | controller | changed: [instance]
2025-10-08 10:08:12.126732 | controller |
2025-10-08 10:08:12.126762 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:08:12.126770 | controller | Wednesday 08 October 2025  10:08:11 +0000 (0:00:00.282)       0:00:30.546 *****
2025-10-08 10:08:12.126778 | controller | changed: [instance]
2025-10-08 10:08:12.317499 | controller |
2025-10-08 10:08:12.317525 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-08 10:08:12.317532 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.322)       0:00:30.869 *****
2025-10-08 10:08:12.317542 | controller | changed: [instance]
2025-10-08 10:08:12.353211 | controller |
2025-10-08 10:08:12.353233 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:08:12.353240 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.190)       0:00:31.060 *****
2025-10-08 10:08:12.353249 | controller | skipping: [instance]
2025-10-08 10:08:12.389551 | controller |
2025-10-08 10:08:12.389602 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-08 10:08:12.389614 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.035)       0:00:31.096 *****
2025-10-08 10:08:12.389628 | controller | skipping: [instance]
2025-10-08 10:08:12.389654 | controller |
2025-10-08 10:08:12.389753 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-08 10:08:12.389902 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.036)       0:00:31.132 *****
2025-10-08 10:08:12.425665 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-08 10:08:12.425782 | controller | skipping: [instance]
2025-10-08 10:08:12.425884 | controller |
2025-10-08 10:08:12.425992 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:08:12.426093 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.036)       0:00:31.168 *****
2025-10-08 10:08:12.462099 | controller | skipping: [instance]
2025-10-08 10:08:12.462187 | controller |
2025-10-08 10:08:12.462312 | controller | TASK [Executing post_stage hooks for examples/va/hci/edpm-pre-ceph/nodeset] ****
2025-10-08 10:08:12.462455 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.036)       0:00:31.205 *****
2025-10-08 10:08:12.500856 | controller | skipping: [instance]
2025-10-08 10:08:12.500959 | controller |
2025-10-08 10:08:12.501076 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:08:12.501193 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.038)       0:00:31.244 *****
2025-10-08 10:08:12.537381 | controller | ok: [instance] => changed=false
2025-10-08 10:08:12.537523 | controller |   msg: All assertions passed
2025-10-08 10:08:12.537642 | controller |
2025-10-08 10:08:12.537769 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:08:12.537911 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.036)       0:00:31.280 *****
2025-10-08 10:08:12.559867 | controller | skipping: [instance]
2025-10-08 10:08:12.559978 | controller |
2025-10-08 10:08:12.560098 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:08:12.560212 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.022)       0:00:31.303 *****
2025-10-08 10:08:12.586624 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=30m)
2025-10-08 10:08:12.586722 | controller |
2025-10-08 10:08:12.586844 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:08:12.586950 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.026)       0:00:31.329 *****
2025-10-08 10:08:12.607774 | controller | skipping: [instance]
2025-10-08 10:08:12.607867 | controller |
2025-10-08 10:08:12.607970 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:08:12.608070 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.021)       0:00:31.351 *****
2025-10-08 10:08:12.632949 | controller | ok: [instance]
2025-10-08 10:08:12.633046 | controller |
2025-10-08 10:08:12.633151 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:08:12.633255 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.025)       0:00:31.376 *****
2025-10-08 10:08:12.827071 | controller | ok: [instance] => (item={'name': 'edpm-deployment-values', 'src_file': 'values.yaml'})
2025-10-08 10:08:12.827172 | controller |
2025-10-08 10:08:12.827293 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:08:12.827401 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.193)       0:00:31.570 *****
2025-10-08 10:08:12.879503 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:08:12.879630 | controller |
2025-10-08 10:08:12.879653 | controller | TASK [Executing pre_stage hooks for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:12.879707 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.052)       0:00:31.622 *****
2025-10-08 10:08:12.916032 | controller | skipping: [instance]
2025-10-08 10:08:12.916126 | controller |
2025-10-08 10:08:12.916138 | controller | TASK [Generate values.yaml for examples/va/hci/edpm-pre-ceph/deployment] *******
2025-10-08 10:08:12.916329 | controller | Wednesday 08 October 2025  10:08:12 +0000 (0:00:00.036)       0:00:31.659 *****
2025-10-08 10:08:13.006639 | controller |
2025-10-08 10:08:13.006703 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:08:13.006845 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.090)       0:00:31.749 *****
2025-10-08 10:08:13.056665 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:08:13.056823 | controller |
2025-10-08 10:08:13.056847 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:08:13.056969 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.049)       0:00:31.799 *****
2025-10-08 10:08:13.097667 | controller | ok: [instance] => changed=false
2025-10-08 10:08:13.097768 | controller |   msg: All assertions passed
2025-10-08 10:08:13.097900 | controller |
2025-10-08 10:08:13.098021 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:08:13.098144 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.041)       0:00:31.840 *****
2025-10-08 10:08:13.283373 | controller | ok: [instance]
2025-10-08 10:08:13.283465 | controller |
2025-10-08 10:08:13.283578 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:08:13.283681 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.185)       0:00:32.026 *****
2025-10-08 10:08:13.325131 | controller | ok: [instance] => changed=false
2025-10-08 10:08:13.325216 | controller |   msg: All assertions passed
2025-10-08 10:08:13.325310 | controller |
2025-10-08 10:08:13.325403 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:08:13.325520 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.041)       0:00:32.068 *****
2025-10-08 10:08:13.505586 | controller | ok: [instance]
2025-10-08 10:08:13.505655 | controller |
2025-10-08 10:08:13.505753 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:08:13.505862 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.180)       0:00:32.248 *****
2025-10-08 10:08:13.662911 | controller | ok: [instance]
2025-10-08 10:08:13.663027 | controller |
2025-10-08 10:08:13.663180 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:08:13.663308 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.157)       0:00:32.405 *****
2025-10-08 10:08:13.701640 | controller | skipping: [instance]
2025-10-08 10:08:13.701757 | controller |
2025-10-08 10:08:13.701914 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:08:13.702037 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.038)       0:00:32.444 *****
2025-10-08 10:08:13.893407 | controller | changed: [instance]
2025-10-08 10:08:13.936115 | controller |
2025-10-08 10:08:13.936141 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:08:13.936149 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.191)       0:00:32.636 *****
2025-10-08 10:08:13.936160 | controller | skipping: [instance]
2025-10-08 10:08:13.986554 | controller |
2025-10-08 10:08:13.986592 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:08:13.986603 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.042)       0:00:32.678 *****
2025-10-08 10:08:13.986616 | controller | ok: [instance]
2025-10-08 10:08:13.986652 | controller |
2025-10-08 10:08:13.986663 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:08:13.986804 | controller | Wednesday 08 October 2025  10:08:13 +0000 (0:00:00.050)       0:00:32.729 *****
2025-10-08 10:08:14.316342 | controller | changed: [instance]
2025-10-08 10:08:14.639768 | controller |
2025-10-08 10:08:14.639810 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:08:14.639817 | controller | Wednesday 08 October 2025  10:08:14 +0000 (0:00:00.329)       0:00:33.058 *****
2025-10-08 10:08:14.639827 | controller | changed: [instance]
2025-10-08 10:08:14.980358 | controller |
2025-10-08 10:08:14.980389 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:08:14.980396 | controller | Wednesday 08 October 2025  10:08:14 +0000 (0:00:00.323)       0:00:33.382 *****
2025-10-08 10:08:14.980406 | controller | changed: [instance]
2025-10-08 10:08:15.031631 | controller |
2025-10-08 10:08:15.031665 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:08:15.031674 | controller | Wednesday 08 October 2025  10:08:14 +0000 (0:00:00.340)       0:00:33.722 *****
2025-10-08 10:08:15.031686 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:08:15.031729 | controller |
2025-10-08 10:08:15.031748 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:08:15.031760 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.051)       0:00:33.774 *****
2025-10-08 10:08:15.070410 | controller | ok: [instance] => changed=false
2025-10-08 10:08:15.256962 | controller |   msg: All assertions passed
2025-10-08 10:08:15.256993 | controller |
2025-10-08 10:08:15.257000 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:08:15.257010 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.038)       0:00:33.812 *****
2025-10-08 10:08:15.257019 | controller | ok: [instance]
2025-10-08 10:08:15.293830 | controller |
2025-10-08 10:08:15.293853 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:08:15.293860 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.186)       0:00:33.999 *****
2025-10-08 10:08:15.293869 | controller | ok: [instance]
2025-10-08 10:08:15.654243 | controller |
2025-10-08 10:08:15.654273 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:08:15.654281 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.037)       0:00:34.036 *****
2025-10-08 10:08:15.654291 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/03_user_data_b64.yaml)
2025-10-08 10:08:15.736524 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/04_user_data.yaml)
2025-10-08 10:08:15.736558 | controller |
2025-10-08 10:08:15.736568 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:08:15.736575 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.359)       0:00:34.396 *****
2025-10-08 10:08:15.736587 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:15.934319 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:15.934348 | controller |
2025-10-08 10:08:15.934355 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:15.934361 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.082)       0:00:34.479 *****
2025-10-08 10:08:15.934375 | controller | changed: [instance]
2025-10-08 10:08:16.273101 | controller |
2025-10-08 10:08:16.273130 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:16.273138 | controller | Wednesday 08 October 2025  10:08:15 +0000 (0:00:00.197)       0:00:34.677 *****
2025-10-08 10:08:16.273148 | controller | changed: [instance]
2025-10-08 10:08:16.493402 | controller |
2025-10-08 10:08:16.493428 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:16.493454 | controller | Wednesday 08 October 2025  10:08:16 +0000 (0:00:00.338)       0:00:35.015 *****
2025-10-08 10:08:16.493467 | controller | changed: [instance] => (item=edpm-deployment-values)
2025-10-08 10:08:16.528563 | controller |
2025-10-08 10:08:16.528593 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:08:16.528606 | controller | Wednesday 08 October 2025  10:08:16 +0000 (0:00:00.220)       0:00:35.236 *****
2025-10-08 10:08:16.528620 | controller | skipping: [instance]
2025-10-08 10:08:16.528657 | controller |
2025-10-08 10:08:16.528938 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:16.793165 | controller | Wednesday 08 October 2025  10:08:16 +0000 (0:00:00.035)       0:00:35.271 *****
2025-10-08 10:08:16.793195 | controller | changed: [instance]
2025-10-08 10:08:17.135886 | controller |
2025-10-08 10:08:17.135915 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:08:17.135922 | controller | Wednesday 08 October 2025  10:08:16 +0000 (0:00:00.264)       0:00:35.535 *****
2025-10-08 10:08:17.135932 | controller | changed: [instance]
2025-10-08 10:08:17.338193 | controller |
2025-10-08 10:08:17.338218 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:17.338226 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.342)       0:00:35.878 *****
2025-10-08 10:08:17.338236 | controller | changed: [instance]
2025-10-08 10:08:17.375008 | controller |
2025-10-08 10:08:17.375029 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:08:17.375037 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.202)       0:00:36.080 *****
2025-10-08 10:08:17.375048 | controller | skipping: [instance]
2025-10-08 10:08:17.412107 | controller |
2025-10-08 10:08:17.412130 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:17.412144 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.036)       0:00:36.117 *****
2025-10-08 10:08:17.412155 | controller | skipping: [instance]
2025-10-08 10:08:17.451208 | controller |
2025-10-08 10:08:17.451227 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:17.451234 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.037)       0:00:36.154 *****
2025-10-08 10:08:17.451244 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=30m)
2025-10-08 10:08:17.489534 | controller | skipping: [instance]
2025-10-08 10:08:17.489580 | controller |
2025-10-08 10:08:17.489590 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:08:17.489600 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.039)       0:00:36.194 *****
2025-10-08 10:08:17.489613 | controller | skipping: [instance]
2025-10-08 10:08:17.489636 | controller |
2025-10-08 10:08:17.489645 | controller | TASK [Executing post_stage hooks for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-08 10:08:17.489676 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.038)       0:00:36.232 *****
2025-10-08 10:08:17.531585 | controller | skipping: [instance]
2025-10-08 10:08:17.531687 | controller |
2025-10-08 10:08:17.531797 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:08:17.531921 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.042)       0:00:36.274 *****
2025-10-08 10:08:17.569474 | controller | ok: [instance] => changed=false
2025-10-08 10:08:17.593098 | controller |   msg: All assertions passed
2025-10-08 10:08:17.593116 | controller |
2025-10-08 10:08:17.593124 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:08:17.593130 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.037)       0:00:36.312 *****
2025-10-08 10:08:17.593138 | controller | skipping: [instance]
2025-10-08 10:08:17.619384 | controller |
2025-10-08 10:08:17.619405 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:08:17.619414 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.023)       0:00:36.335 *****
2025-10-08 10:08:17.619425 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-08 10:08:17.643537 | controller |
2025-10-08 10:08:17.643554 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:08:17.643561 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.026)       0:00:36.362 *****
2025-10-08 10:08:17.643570 | controller | skipping: [instance]
2025-10-08 10:08:17.670006 | controller |
2025-10-08 10:08:17.670024 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:08:17.670031 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.024)       0:00:36.386 *****
2025-10-08 10:08:17.670039 | controller | ok: [instance]
2025-10-08 10:08:18.049506 | controller |
2025-10-08 10:08:18.049539 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:08:18.049548 | controller | Wednesday 08 October 2025  10:08:17 +0000 (0:00:00.026)       0:00:36.412 *****
2025-10-08 10:08:18.049559 | controller | ok: [instance] => (item={'name': 'service-values', 'src_file': 'service-values.yaml'})
2025-10-08 10:08:18.127494 | controller | ok: [instance] => (item={'name': 'edpm-nodeset-values-post-ceph', 'src_file': 'values.yaml'})
2025-10-08 10:08:18.127517 | controller |
2025-10-08 10:08:18.127524 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:08:18.127529 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.379)       0:00:36.791 *****
2025-10-08 10:08:18.127538 | controller | ok: [instance] => (item=service-values.yaml)
2025-10-08 10:08:18.127875 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:08:18.164516 | controller |
2025-10-08 10:08:18.164543 | controller | TASK [Executing pre_stage hooks for examples/va/hci] ***************************
2025-10-08 10:08:18.164553 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.078)       0:00:36.870 *****
2025-10-08 10:08:18.164565 | controller | skipping: [instance]
2025-10-08 10:08:18.164680 | controller |
2025-10-08 10:08:18.164691 | controller | TASK [Generate values.yaml for examples/va/hci] ********************************
2025-10-08 10:08:18.164708 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.036)       0:00:36.907 *****
2025-10-08 10:08:18.298208 | controller |
2025-10-08 10:08:18.373964 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:08:18.374003 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.133)       0:00:37.040 *****
2025-10-08 10:08:18.374023 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:08:18.374199 | controller |
2025-10-08 10:08:18.374402 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:08:18.374539 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.076)       0:00:37.116 *****
2025-10-08 10:08:18.414367 | controller | ok: [instance] => changed=false
2025-10-08 10:08:18.414527 | controller |   msg: All assertions passed
2025-10-08 10:08:18.414657 | controller |
2025-10-08 10:08:18.414789 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:08:18.414930 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.040)       0:00:37.157 *****
2025-10-08 10:08:18.600716 | controller | ok: [instance]
2025-10-08 10:08:18.641494 | controller |
2025-10-08 10:08:18.641512 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:08:18.641518 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.185)       0:00:37.343 *****
2025-10-08 10:08:18.641526 | controller | ok: [instance] => changed=false
2025-10-08 10:08:18.641545 | controller |   msg: All assertions passed
2025-10-08 10:08:18.641552 | controller |
2025-10-08 10:08:18.641732 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:08:18.822916 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.041)       0:00:37.384 *****
2025-10-08 10:08:18.822947 | controller | ok: [instance]
2025-10-08 10:08:19.003667 | controller |
2025-10-08 10:08:19.003693 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:08:19.003702 | controller | Wednesday 08 October 2025  10:08:18 +0000 (0:00:00.181)       0:00:37.565 *****
2025-10-08 10:08:19.003712 | controller | ok: [instance]
2025-10-08 10:08:19.040275 | controller |
2025-10-08 10:08:19.040297 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:08:19.040304 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.180)       0:00:37.746 *****
2025-10-08 10:08:19.040313 | controller | skipping: [instance]
2025-10-08 10:08:19.233176 | controller |
2025-10-08 10:08:19.233207 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:08:19.233215 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.036)       0:00:37.783 *****
2025-10-08 10:08:19.233224 | controller | ok: [instance]
2025-10-08 10:08:19.279199 | controller |
2025-10-08 10:08:19.279222 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:08:19.279230 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.192)       0:00:37.975 *****
2025-10-08 10:08:19.279240 | controller | skipping: [instance]
2025-10-08 10:08:19.329953 | controller |
2025-10-08 10:08:19.329979 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:08:19.329986 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.046)       0:00:38.021 *****
2025-10-08 10:08:19.329994 | controller | ok: [instance]
2025-10-08 10:08:19.653345 | controller |
2025-10-08 10:08:19.653374 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:08:19.653382 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.050)       0:00:38.072 *****
2025-10-08 10:08:19.653391 | controller | ok: [instance]
2025-10-08 10:08:19.988668 | controller |
2025-10-08 10:08:19.988695 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:08:19.988702 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.323)       0:00:38.396 *****
2025-10-08 10:08:19.988711 | controller | ok: [instance]
2025-10-08 10:08:20.334503 | controller |
2025-10-08 10:08:20.334530 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:08:20.334541 | controller | Wednesday 08 October 2025  10:08:19 +0000 (0:00:00.335)       0:00:38.731 *****
2025-10-08 10:08:20.334551 | controller | changed: [instance]
2025-10-08 10:08:20.334713 | controller |
2025-10-08 10:08:20.334724 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:08:20.334732 | controller | Wednesday 08 October 2025  10:08:20 +0000 (0:00:00.345)       0:00:39.077 *****
2025-10-08 10:08:20.386523 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:08:20.386556 | controller |
2025-10-08 10:08:20.386822 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:08:20.426268 | controller | Wednesday 08 October 2025  10:08:20 +0000 (0:00:00.052)       0:00:39.129 *****
2025-10-08 10:08:20.426287 | controller | ok: [instance] => changed=false
2025-10-08 10:08:20.615542 | controller |   msg: All assertions passed
2025-10-08 10:08:20.615566 | controller |
2025-10-08 10:08:20.615574 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:08:20.615579 | controller | Wednesday 08 October 2025  10:08:20 +0000 (0:00:00.039)       0:00:39.169 *****
2025-10-08 10:08:20.615588 | controller | ok: [instance]
2025-10-08 10:08:20.615609 | controller |
2025-10-08 10:08:20.615811 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:08:20.653501 | controller | Wednesday 08 October 2025  10:08:20 +0000 (0:00:00.189)       0:00:39.358 *****
2025-10-08 10:08:20.653528 | controller | ok: [instance]
2025-10-08 10:08:20.653819 | controller |
2025-10-08 10:08:20.653833 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:08:21.014227 | controller | Wednesday 08 October 2025  10:08:20 +0000 (0:00:00.037)       0:00:39.396 *****
2025-10-08 10:08:21.014258 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/03_user_data_b64.yaml)
2025-10-08 10:08:21.092503 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/04_user_data.yaml)
2025-10-08 10:08:21.092527 | controller |
2025-10-08 10:08:21.092534 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:08:21.092539 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.360)       0:00:39.756 *****
2025-10-08 10:08:21.092548 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:21.092701 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:21.092716 | controller |
2025-10-08 10:08:21.092725 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:21.285964 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.078)       0:00:39.835 *****
2025-10-08 10:08:21.285993 | controller | ok: [instance]
2025-10-08 10:08:21.644517 | controller |
2025-10-08 10:08:21.644546 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:21.644553 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.193)       0:00:40.028 *****
2025-10-08 10:08:21.644563 | controller | changed: [instance]
2025-10-08 10:08:21.644587 | controller |
2025-10-08 10:08:21.644596 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:08:21.644659 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.358)       0:00:40.387 *****
2025-10-08 10:08:21.699273 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:08:21.739037 | controller |
2025-10-08 10:08:21.739053 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:08:21.739060 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.054)       0:00:40.442 *****
2025-10-08 10:08:21.739068 | controller | ok: [instance] => changed=false
2025-10-08 10:08:21.919877 | controller |   msg: All assertions passed
2025-10-08 10:08:21.919902 | controller |
2025-10-08 10:08:21.919909 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:08:21.919915 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.039)       0:00:40.481 *****
2025-10-08 10:08:21.919928 | controller | ok: [instance]
2025-10-08 10:08:21.960146 | controller |
2025-10-08 10:08:21.960162 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:08:21.960168 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.180)       0:00:40.662 *****
2025-10-08 10:08:21.960176 | controller | ok: [instance] => changed=false
2025-10-08 10:08:22.144975 | controller |   msg: All assertions passed
2025-10-08 10:08:22.145002 | controller |
2025-10-08 10:08:22.145009 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:08:22.145015 | controller | Wednesday 08 October 2025  10:08:21 +0000 (0:00:00.040)       0:00:40.702 *****
2025-10-08 10:08:22.145024 | controller | ok: [instance]
2025-10-08 10:08:22.307577 | controller |
2025-10-08 10:08:22.307613 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:08:22.307626 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.184)       0:00:40.887 *****
2025-10-08 10:08:22.307641 | controller | ok: [instance]
2025-10-08 10:08:22.307676 | controller |
2025-10-08 10:08:22.307689 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:08:22.307817 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.162)       0:00:41.050 *****
2025-10-08 10:08:22.345500 | controller | skipping: [instance]
2025-10-08 10:08:22.345820 | controller |
2025-10-08 10:08:22.546975 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:08:22.547000 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.038)       0:00:41.088 *****
2025-10-08 10:08:22.547011 | controller | changed: [instance]
2025-10-08 10:08:22.592487 | controller |
2025-10-08 10:08:22.592506 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:08:22.592513 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.201)       0:00:41.289 *****
2025-10-08 10:08:22.592521 | controller | skipping: [instance]
2025-10-08 10:08:22.641507 | controller |
2025-10-08 10:08:22.641529 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:08:22.641538 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.045)       0:00:41.335 *****
2025-10-08 10:08:22.641548 | controller | ok: [instance]
2025-10-08 10:08:22.641576 | controller |
2025-10-08 10:08:22.641829 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:08:22.982949 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.049)       0:00:41.384 *****
2025-10-08 10:08:22.982982 | controller | changed: [instance]
2025-10-08 10:08:23.320452 | controller |
2025-10-08 10:08:23.320484 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:08:23.320492 | controller | Wednesday 08 October 2025  10:08:22 +0000 (0:00:00.341)       0:00:41.725 *****
2025-10-08 10:08:23.320502 | controller | changed: [instance]
2025-10-08 10:08:23.647340 | controller |
2025-10-08 10:08:23.647368 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:08:23.647375 | controller | Wednesday 08 October 2025  10:08:23 +0000 (0:00:00.337)       0:00:42.063 *****
2025-10-08 10:08:23.647384 | controller | changed: [instance]
2025-10-08 10:08:23.700335 | controller |
2025-10-08 10:08:23.700358 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:08:23.700365 | controller | Wednesday 08 October 2025  10:08:23 +0000 (0:00:00.327)       0:00:42.390 *****
2025-10-08 10:08:23.700375 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:08:23.739186 | controller |
2025-10-08 10:08:23.739206 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:08:23.739214 | controller | Wednesday 08 October 2025  10:08:23 +0000 (0:00:00.053)       0:00:42.443 *****
2025-10-08 10:08:23.739225 | controller | ok: [instance] => changed=false
2025-10-08 10:08:23.931527 | controller |   msg: All assertions passed
2025-10-08 10:08:23.931559 | controller |
2025-10-08 10:08:23.931566 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:08:23.931572 | controller | Wednesday 08 October 2025  10:08:23 +0000 (0:00:00.038)       0:00:42.481 *****
2025-10-08 10:08:23.931586 | controller | ok: [instance]
2025-10-08 10:08:23.968504 | controller |
2025-10-08 10:08:23.968530 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:08:23.968538 | controller | Wednesday 08 October 2025  10:08:23 +0000 (0:00:00.192)       0:00:42.674 *****
2025-10-08 10:08:23.968548 | controller | ok: [instance]
2025-10-08 10:08:23.968573 | controller |
2025-10-08 10:08:23.968880 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:08:24.348039 | controller | Wednesday 08 October 2025  10:08:23 +0000 (0:00:00.037)       0:00:42.711 *****
2025-10-08 10:08:24.348074 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/03_user_data_b64.yaml)
2025-10-08 10:08:24.427281 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/04_user_data.yaml)
2025-10-08 10:08:24.427304 | controller |
2025-10-08 10:08:24.427313 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:08:24.427321 | controller | Wednesday 08 October 2025  10:08:24 +0000 (0:00:00.378)       0:00:43.090 *****
2025-10-08 10:08:24.427332 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:24.621240 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:24.621267 | controller |
2025-10-08 10:08:24.621274 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:24.621280 | controller | Wednesday 08 October 2025  10:08:24 +0000 (0:00:00.079)       0:00:43.169 *****
2025-10-08 10:08:24.621289 | controller | changed: [instance]
2025-10-08 10:08:24.957952 | controller |
2025-10-08 10:08:24.957981 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:24.957988 | controller | Wednesday 08 October 2025  10:08:24 +0000 (0:00:00.194)       0:00:43.363 *****
2025-10-08 10:08:24.957998 | controller | changed: [instance]
2025-10-08 10:08:25.376084 | controller |
2025-10-08 10:08:25.376112 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci] ************
2025-10-08 10:08:25.376120 | controller | Wednesday 08 October 2025  10:08:24 +0000 (0:00:00.336)       0:00:43.700 *****
2025-10-08 10:08:25.376130 | controller | changed: [instance] => (item=service-values)
2025-10-08 10:08:25.411554 | controller | changed: [instance] => (item=edpm-nodeset-values-post-ceph)
2025-10-08 10:08:25.411591 | controller |
2025-10-08 10:08:25.411601 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:08:25.411609 | controller | Wednesday 08 October 2025  10:08:25 +0000 (0:00:00.417)       0:00:44.118 *****
2025-10-08 10:08:25.411629 | controller | skipping: [instance]
2025-10-08 10:08:25.411652 | controller |
2025-10-08 10:08:25.411662 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci] *********
2025-10-08 10:08:25.778282 | controller | Wednesday 08 October 2025  10:08:25 +0000 (0:00:00.035)       0:00:44.154 *****
2025-10-08 10:08:25.778318 | controller | changed: [instance]
2025-10-08 10:08:26.102000 | controller |
2025-10-08 10:08:26.102029 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:08:26.102036 | controller | Wednesday 08 October 2025  10:08:25 +0000 (0:00:00.366)       0:00:44.520 *****
2025-10-08 10:08:26.102046 | controller | changed: [instance]
2025-10-08 10:08:26.304317 | controller |
2025-10-08 10:08:26.304348 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci] ***
2025-10-08 10:08:26.304356 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.323)       0:00:44.844 *****
2025-10-08 10:08:26.304366 | controller | changed: [instance]
2025-10-08 10:08:26.341148 | controller |
2025-10-08 10:08:26.341171 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:08:26.341178 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.202)       0:00:45.046 *****
2025-10-08 10:08:26.341187 | controller | skipping: [instance]
2025-10-08 10:08:26.376550 | controller |
2025-10-08 10:08:26.376585 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci] **********
2025-10-08 10:08:26.376605 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.037)       0:00:45.084 *****
2025-10-08 10:08:26.376623 | controller | skipping: [instance]
2025-10-08 10:08:26.376647 | controller |
2025-10-08 10:08:26.376657 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci] **************
2025-10-08 10:08:26.376756 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.035)       0:00:45.119 *****
2025-10-08 10:08:26.416544 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-08 10:08:26.416640 | controller | skipping: [instance]
2025-10-08 10:08:26.416661 | controller |
2025-10-08 10:08:26.416668 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:08:26.416677 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.039)       0:00:45.159 *****
2025-10-08 10:08:26.452987 | controller | skipping: [instance]
2025-10-08 10:08:26.495290 | controller |
2025-10-08 10:08:26.495318 | controller | TASK [Executing post_stage hooks for examples/va/hci] **************************
2025-10-08 10:08:26.495328 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.036)       0:00:45.195 *****
2025-10-08 10:08:26.495341 | controller | skipping: [instance]
2025-10-08 10:08:26.530133 | controller |
2025-10-08 10:08:26.530152 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:08:26.530160 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.042)       0:00:45.238 *****
2025-10-08 10:08:26.530168 | controller | ok: [instance] => changed=false
2025-10-08 10:08:26.552584 | controller |   msg: All assertions passed
2025-10-08 10:08:26.552622 | controller |
2025-10-08 10:08:26.552635 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:08:26.552646 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.034)       0:00:45.272 *****
2025-10-08 10:08:26.552661 | controller | skipping: [instance]
2025-10-08 10:08:26.578308 | controller |
2025-10-08 10:08:26.578333 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:08:26.578340 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.022)       0:00:45.295 *****
2025-10-08 10:08:26.578350 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=80m)
2025-10-08 10:08:26.599394 | controller |
2025-10-08 10:08:26.599416 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:08:26.599423 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.025)       0:00:45.321 *****
2025-10-08 10:08:26.599431 | controller | skipping: [instance]
2025-10-08 10:08:26.629516 | controller |
2025-10-08 10:08:26.629545 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-08 10:08:26.629554 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.021)       0:00:45.342 *****
2025-10-08 10:08:26.629565 | controller | ok: [instance]
2025-10-08 10:08:26.629709 | controller |
2025-10-08 10:08:26.629730 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-08 10:08:26.825141 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.030)       0:00:45.372 *****
2025-10-08 10:08:26.825171 | controller | ok: [instance] => (item={'name': 'edpm-deployment-values-post-ceph', 'src_file': 'values.yaml'})
2025-10-08 10:08:26.875545 | controller |
2025-10-08 10:08:26.875591 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-08 10:08:26.875602 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.195)       0:00:45.567 *****
2025-10-08 10:08:26.875615 | controller | ok: [instance] => (item=values.yaml)
2025-10-08 10:08:26.875638 | controller |
2025-10-08 10:08:26.875647 | controller | TASK [Executing pre_stage hooks for examples/va/hci/deployment] ****************
2025-10-08 10:08:26.875663 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.050)       0:00:45.618 *****
2025-10-08 10:08:26.910711 | controller | skipping: [instance]
2025-10-08 10:08:26.910807 | controller |
2025-10-08 10:08:26.910910 | controller | TASK [Generate values.yaml for examples/va/hci/deployment] *********************
2025-10-08 10:08:26.910998 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.035)       0:00:45.653 *****
2025-10-08 10:08:26.977000 | controller |
2025-10-08 10:08:26.977100 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-08 10:08:26.977198 | controller | Wednesday 08 October 2025  10:08:26 +0000 (0:00:00.066)       0:00:45.720 *****
2025-10-08 10:08:27.027403 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance
2025-10-08 10:08:27.027511 | controller |
2025-10-08 10:08:27.027617 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-08 10:08:27.027741 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.050)       0:00:45.770 *****
2025-10-08 10:08:27.067527 | controller | ok: [instance] => changed=false
2025-10-08 10:08:27.067575 | controller |   msg: All assertions passed
2025-10-08 10:08:27.067584 | controller |
2025-10-08 10:08:27.067794 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-08 10:08:27.255493 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.039)       0:00:45.810 *****
2025-10-08 10:08:27.255517 | controller | ok: [instance]
2025-10-08 10:08:27.255721 | controller |
2025-10-08 10:08:27.255758 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-08 10:08:27.298543 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.188)       0:00:45.998 *****
2025-10-08 10:08:27.298577 | controller | ok: [instance] => changed=false
2025-10-08 10:08:27.477170 | controller |   msg: All assertions passed
2025-10-08 10:08:27.477198 | controller |
2025-10-08 10:08:27.477206 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-08 10:08:27.477212 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.042)       0:00:46.041 *****
2025-10-08 10:08:27.477223 | controller | ok: [instance]
2025-10-08 10:08:27.632958 | controller |
2025-10-08 10:08:27.632982 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-08 10:08:27.632989 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.178)       0:00:46.219 *****
2025-10-08 10:08:27.632998 | controller | ok: [instance]
2025-10-08 10:08:27.670457 | controller |
2025-10-08 10:08:27.670479 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-08 10:08:27.670488 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.155)       0:00:46.375 *****
2025-10-08 10:08:27.670498 | controller | skipping: [instance]
2025-10-08 10:08:27.862533 | controller |
2025-10-08 10:08:27.862564 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-08 10:08:27.862571 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.037)       0:00:46.413 *****
2025-10-08 10:08:27.862581 | controller | changed: [instance]
2025-10-08 10:08:27.909195 | controller |
2025-10-08 10:08:27.909219 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-08 10:08:27.909227 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.191)       0:00:46.605 *****
2025-10-08 10:08:27.909237 | controller | skipping: [instance]
2025-10-08 10:08:27.960435 | controller |
2025-10-08 10:08:27.960485 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-08 10:08:27.960494 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.046)       0:00:46.652 *****
2025-10-08 10:08:27.960506 | controller | ok: [instance]
2025-10-08 10:08:28.306966 | controller |
2025-10-08 10:08:28.306983 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-08 10:08:28.306990 | controller | Wednesday 08 October 2025  10:08:27 +0000 (0:00:00.051)       0:00:46.703 *****
2025-10-08 10:08:28.306998 | controller | changed: [instance]
2025-10-08 10:08:28.648392 | controller |
2025-10-08 10:08:28.648411 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-08 10:08:28.648418 | controller | Wednesday 08 October 2025  10:08:28 +0000 (0:00:00.346)       0:00:47.049 *****
2025-10-08 10:08:28.648427 | controller | changed: [instance]
2025-10-08 10:08:28.993525 | controller |
2025-10-08 10:08:28.993557 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-08 10:08:28.993566 | controller | Wednesday 08 October 2025  10:08:28 +0000 (0:00:00.341)       0:00:47.391 *****
2025-10-08 10:08:28.993576 | controller | changed: [instance]
2025-10-08 10:08:28.993601 | controller |
2025-10-08 10:08:28.993614 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-08 10:08:28.993701 | controller | Wednesday 08 October 2025  10:08:28 +0000 (0:00:00.345)       0:00:47.736 *****
2025-10-08 10:08:29.049558 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance
2025-10-08 10:08:29.091546 | controller |
2025-10-08 10:08:29.091581 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-08 10:08:29.091593 | controller | Wednesday 08 October 2025  10:08:29 +0000 (0:00:00.055)       0:00:47.792 *****
2025-10-08 10:08:29.091604 | controller | ok: [instance] => changed=false
2025-10-08 10:08:29.091630 | controller |   msg: All assertions passed
2025-10-08 10:08:29.091636 | controller |
2025-10-08 10:08:29.091641 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-08 10:08:29.091648 | controller | Wednesday 08 October 2025  10:08:29 +0000 (0:00:00.041)       0:00:47.834 *****
2025-10-08 10:08:29.294517 | controller | ok: [instance]
2025-10-08 10:08:29.294562 | controller |
2025-10-08 10:08:29.294572 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-08 10:08:29.294720 | controller | Wednesday 08 October 2025  10:08:29 +0000 (0:00:00.203)       0:00:48.037 *****
2025-10-08 10:08:29.332550 | controller | ok: [instance]
2025-10-08 10:08:29.332581 | controller |
2025-10-08 10:08:29.332588 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-08 10:08:29.332596 | controller | Wednesday 08 October 2025  10:08:29 +0000 (0:00:00.038)       0:00:48.075 *****
2025-10-08 10:08:29.756579 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/03_user_data_b64.yaml)
2025-10-08 10:08:29.756627 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/04_user_data.yaml)
2025-10-08 10:08:29.756637 | controller |
2025-10-08 10:08:29.756907 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-08 10:08:29.837154 | controller | Wednesday 08 October 2025  10:08:29 +0000 (0:00:00.423)       0:00:48.499 *****
2025-10-08 10:08:29.837176 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-08 10:08:30.038887 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-08 10:08:30.038907 | controller |
2025-10-08 10:08:30.038915 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-08 10:08:30.038921 | controller | Wednesday 08 October 2025  10:08:29 +0000 (0:00:00.080)       0:00:48.579 *****
2025-10-08 10:08:30.038930 | controller | changed: [instance]
2025-10-08 10:08:30.398950 | controller |
2025-10-08 10:08:30.398985 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-08 10:08:30.398995 | controller | Wednesday 08 October 2025  10:08:30 +0000 (0:00:00.201)       0:00:48.781 *****
2025-10-08 10:08:30.399007 | controller | changed: [instance]
2025-10-08 10:08:30.622707 | controller |
2025-10-08 10:08:30.622725 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/deployment] ***
2025-10-08 10:08:30.622744 | controller | Wednesday 08 October 2025  10:08:30 +0000 (0:00:00.359)       0:00:49.141 *****
2025-10-08 10:08:30.622753 | controller | changed: [instance] => (item=edpm-deployment-values-post-ceph)
2025-10-08 10:08:30.662127 | controller |
2025-10-08 10:08:30.662151 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-08 10:08:30.662161 | controller | Wednesday 08 October 2025  10:08:30 +0000 (0:00:00.224)       0:00:49.365 *****
2025-10-08 10:08:30.662173 | controller | skipping: [instance]
2025-10-08 10:08:30.940285 | controller |
2025-10-08 10:08:30.940313 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/deployment] ***
2025-10-08 10:08:30.940321 | controller | Wednesday 08 October 2025  10:08:30 +0000 (0:00:00.039)       0:00:49.404 *****
2025-10-08 10:08:30.940330 | controller | changed: [instance]
2025-10-08 10:08:31.268115 | controller |
2025-10-08 10:08:31.268134 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-08 10:08:31.268141 | controller | Wednesday 08 October 2025  10:08:30 +0000 (0:00:00.277)       0:00:49.682 *****
2025-10-08 10:08:31.268154 | controller | changed: [instance]
2025-10-08 10:08:31.466047 | controller |
2025-10-08 10:08:31.466066 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/deployment] ***
2025-10-08 10:08:31.466074 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.328)       0:00:50.011 *****
2025-10-08 10:08:31.466082 | controller | changed: [instance]
2025-10-08 10:08:31.502942 | controller |
2025-10-08 10:08:31.502959 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-08 10:08:31.502966 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.197)       0:00:50.208 *****
2025-10-08 10:08:31.502974 | controller | skipping: [instance]
2025-10-08 10:08:31.540328 | controller |
2025-10-08 10:08:31.540346 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/deployment] ***
2025-10-08 10:08:31.540353 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.036)       0:00:50.245 *****
2025-10-08 10:08:31.540361 | controller | skipping: [instance]
2025-10-08 10:08:31.580251 | controller |
2025-10-08 10:08:31.580269 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/deployment] ***
2025-10-08 10:08:31.580276 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.037)       0:00:50.283 *****
2025-10-08 10:08:31.580285 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=80m)
2025-10-08 10:08:31.617210 | controller | skipping: [instance]
2025-10-08 10:08:31.617226 | controller |
2025-10-08 10:08:31.617233 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-08 10:08:31.617238 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.039)       0:00:50.323 *****
2025-10-08 10:08:31.617246 | controller | skipping: [instance]
2025-10-08 10:08:31.657954 | controller |
2025-10-08 10:08:31.657971 | controller | TASK [Executing post_stage hooks for examples/va/hci/deployment] ***************
2025-10-08 10:08:31.657981 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.037)       0:00:50.360 *****
2025-10-08 10:08:31.657989 | controller | skipping: [instance]
2025-10-08 10:08:31.828501 | controller |
2025-10-08 10:08:31.828534 | controller | TASK [Run loop deployment again] ***********************************************
2025-10-08 10:08:31.828547 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.040)       0:00:50.400 *****
2025-10-08 10:08:31.828562 | controller |
2025-10-08 10:08:31.862574 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-08 10:08:31.862612 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.170)       0:00:50.571 *****
2025-10-08 10:08:31.862632 | controller | ok: [instance] => changed=false
2025-10-08 10:08:31.862661 | controller |   msg: All assertions passed
2025-10-08 10:08:31.862669 | controller |
2025-10-08 10:08:31.862677 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-08 10:08:31.862883 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.034)       0:00:50.605 *****
2025-10-08 10:08:31.886384 | controller | failed: [instance] (item=sudo cat /etc/passwd) => changed=false
2025-10-08 10:08:31.887117 | controller |   ansible_loop_var: item
2025-10-08 10:08:31.888799 | controller |   assertion: item is match(_pattern)
2025-10-08 10:08:31.888816 | controller |   evaluated_to: false
2025-10-08 10:08:31.888823 | controller |   item: sudo cat /etc/passwd
2025-10-08 10:08:31.888828 | controller |   msg: 'The following custom condition is invalid: sudo cat /etc/passwd'
2025-10-08 10:08:31.888836 | controller | failed: [instance] (item=oc rsh exec blah) => changed=false
2025-10-08 10:08:31.889065 | controller |   ansible_loop_var: item
2025-10-08 10:08:31.889311 | controller |   assertion: item is match(_pattern)
2025-10-08 10:08:31.889639 | controller |   evaluated_to: false
2025-10-08 10:08:31.889914 | controller |   item: oc rsh exec blah
2025-10-08 10:08:31.890156 | controller |   msg: 'The following custom condition is invalid: oc rsh exec blah'
2025-10-08 10:08:31.892267 | controller | failed: [instance] (item=kubectl rsh exec bar) => changed=false
2025-10-08 10:08:31.892591 | controller |   ansible_loop_var: item
2025-10-08 10:08:31.892869 | controller |   assertion: item is match(_pattern)
2025-10-08 10:08:31.893019 | controller |   evaluated_to: false
2025-10-08 10:08:31.893140 | controller |   item: kubectl rsh exec bar
2025-10-08 10:08:31.893263 | controller |   msg: 'The following custom condition is invalid: kubectl rsh exec bar'
2025-10-08 10:08:31.900246 | controller | ...ignoring
2025-10-08 10:08:31.900413 | controller |
2025-10-08 10:08:31.900596 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-08 10:08:31.900766 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.038)       0:00:50.643 *****
2025-10-08 10:08:31.924481 | controller | ok: [instance] => (item=oc -n openstack wait nncp -l osp/nncm-config-type=standard --for jsonpath='{.status.conditions[0].reason}'=SuccessfullyConfigured --timeout=5m)
2025-10-08 10:08:31.924798 | controller |
2025-10-08 10:08:31.925051 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-08 10:08:31.925175 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.024)       0:00:50.667 *****
2025-10-08 10:08:31.940044 | controller | fatal: [instance]: FAILED! => changed=false
2025-10-08 10:08:31.940204 | controller |   msg: Review and correct the faulty wait_conditions listed above.
2025-10-08 10:08:31.961949 | controller |
2025-10-08 10:08:31.962246 | controller | TASK [Clear expected errors] ***************************************************
2025-10-08 10:08:31.962556 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.022)       0:00:50.689 *****
2025-10-08 10:08:31.962815 | controller |
2025-10-08 10:08:31.963045 | controller | TASK [Ensure a successful end] *************************************************
2025-10-08 10:08:31.963174 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.009)       0:00:50.698 *****
2025-10-08 10:08:31.963296 | controller |
2025-10-08 10:08:31.963429 | controller | PLAY RECAP *********************************************************************
2025-10-08 10:08:31.963616 | controller | instance                   : ok=261  changed=69   unreachable=0    failed=0    skipped=75   rescued=1    ignored=1
2025-10-08 10:08:31.963755 | controller |
2025-10-08 10:08:31.963888 | controller | Wednesday 08 October 2025  10:08:31 +0000 (0:00:00.005)       0:00:50.704 *****
2025-10-08 10:08:31.964013 | controller | ===============================================================================
2025-10-08 10:08:31.964132 | controller | Gathering Facts --------------------------------------------------------- 0.73s
2025-10-08 10:08:31.964255 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.56s
2025-10-08 10:08:31.964374 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.56s
2025-10-08 10:08:31.964511 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.54s
2025-10-08 10:08:31.964635 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.53s
2025-10-08 10:08:31.964763 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.53s
2025-10-08 10:08:31.964886 | controller | kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking/nncp --- 0.45s
2025-10-08 10:08:31.965003 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.45s
2025-10-08 10:08:31.965123 | controller | kustomize_deploy : Copy generated values for examples/va/hci/control-plane --- 0.44s
2025-10-08 10:08:31.965239 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.43s
2025-10-08 10:08:31.965375 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.42s
2025-10-08 10:08:31.965516 | controller | kustomize_deploy : Copy generated values for examples/va/hci ------------ 0.42s
2025-10-08 10:08:31.965645 | controller | kustomize_deploy : Ensure source files exists --------------------------- 0.38s
2025-10-08 10:08:31.965777 | controller | kustomize_deploy : Ensure source files exists --------------------------- 0.38s
2025-10-08 10:08:31.965896 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.38s
2025-10-08 10:08:31.966015 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.38s
2025-10-08 10:08:31.966135 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.37s
2025-10-08 10:08:31.966255 | controller | kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking --- 0.37s
2025-10-08 10:08:31.966371 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.37s
2025-10-08 10:08:31.966517 | controller | kustomize_deploy : Build kustomized content for examples/va/hci --------- 0.37s
2025-10-08 10:08:32.036403 | controller | INFO     Running flexible_loop > cleanup
2025-10-08 10:08:32.036843 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-08 10:08:32.037367 | controller | INFO     Writing /tmp/report.html report.
2025-10-08 10:08:32.538518 | controller | changed
2025-10-08 10:08:32.562763 | 
2025-10-08 10:08:32.562810 | PLAY RECAP
2025-10-08 10:08:32.562847 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-08 10:08:32.562868 | 
2025-10-08 10:08:32.627857 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-08 10:08:32.628670 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-08 10:08:33.102953 | 
2025-10-08 10:08:33.103055 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-08 10:08:33.121512 | 
2025-10-08 10:08:33.121577 | TASK [Filter out host if needed]
2025-10-08 10:08:33.129273 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-08 10:08:33.133354 | 
2025-10-08 10:08:33.133414 | TASK [Ensure file is present]
2025-10-08 10:08:33.404571 | controller | ok
2025-10-08 10:08:33.410832 | 
2025-10-08 10:08:33.410894 | TASK [Manage molecule report file]
2025-10-08 10:08:33.934205 | controller | changed
2025-10-08 10:08:33.939267 | 
2025-10-08 10:08:33.939329 | TASK [Check if we get ci-framework-data basedir]
2025-10-08 10:08:34.100301 | controller | ok
2025-10-08 10:08:34.105074 | 
2025-10-08 10:08:34.105133 | TASK [Create ci-framework-data log directory for zuul]
2025-10-08 10:08:34.376282 | controller | changed
2025-10-08 10:08:34.380949 | 
2025-10-08 10:08:34.381011 | TASK [Copy ci-framework interesting files]
2025-10-08 10:08:34.570039 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-08 10:08:34.902559 | controller | changed
2025-10-08 10:08:34.907938 | 
2025-10-08 10:08:34.908007 | TASK [Get SELinux listing]
2025-10-08 10:08:35.432726 | controller | changed
2025-10-08 10:08:35.438088 | 
2025-10-08 10:08:35.438151 | TASK [Generate log index]
2025-10-08 10:08:36.024270 | controller | changed
2025-10-08 10:08:36.028671 | 
2025-10-08 10:08:36.028731 | TASK [Get some env related data]
2025-10-08 10:08:36.530534 | controller | /home/zuul/.local/bin/ansible
2025-10-08 10:08:37.070748 | controller | changed
2025-10-08 10:08:37.075471 | 
2025-10-08 10:08:37.075544 | TASK [Generate list of logs to collect in home directory]
2025-10-08 10:08:37.346559 | controller | ok: All paths examined
2025-10-08 10:08:37.351122 | 
2025-10-08 10:08:37.351182 | LOOP [Copy logs from home directory]
2025-10-08 10:08:37.619129 | controller | changed:
2025-10-08 10:08:37.619255 | controller | {
2025-10-08 10:08:37.619362 | controller |   "atime": 1759918011.1071985,
2025-10-08 10:08:37.619391 | controller |   "ctime": 1759918026.9496887,
2025-10-08 10:08:37.619410 | controller |   "dev": 64513,
2025-10-08 10:08:37.619426 | controller |   "gid": 1000,
2025-10-08 10:08:37.619440 | controller |   "gr_name": "zuul",
2025-10-08 10:08:37.619455 | controller |   "inode": 4349059,
2025-10-08 10:08:37.619478 | controller |   "isblk": false,
2025-10-08 10:08:37.619491 | controller |   "ischr": false,
2025-10-08 10:08:37.619516 | controller |   "isdir": false,
2025-10-08 10:08:37.619531 | controller |   "isfifo": false,
2025-10-08 10:08:37.619546 | controller |   "isgid": false,
2025-10-08 10:08:37.619561 | controller |   "islnk": false,
2025-10-08 10:08:37.619574 | controller |   "isreg": true,
2025-10-08 10:08:37.619587 | controller |   "issock": false,
2025-10-08 10:08:37.619600 | controller |   "isuid": false,
2025-10-08 10:08:37.619613 | controller |   "mode": "0644",
2025-10-08 10:08:37.619625 | controller |   "mtime": 1759918026.9496887,
2025-10-08 10:08:37.619639 | controller |   "nlink": 1,
2025-10-08 10:08:37.619652 | controller |   "path": "/home/zuul/ansible.log",
2025-10-08 10:08:37.619666 | controller |   "pw_name": "zuul",
2025-10-08 10:08:37.619684 | controller |   "rgrp": true,
2025-10-08 10:08:37.619698 | controller |   "roth": true,
2025-10-08 10:08:37.619711 | controller |   "rusr": true,
2025-10-08 10:08:37.619725 | controller |   "size": 6749,
2025-10-08 10:08:37.619737 | controller |   "uid": 1000,
2025-10-08 10:08:37.619750 | controller |   "wgrp": false,
2025-10-08 10:08:37.619763 | controller |   "woth": false,
2025-10-08 10:08:37.619778 | controller |   "wusr": true,
2025-10-08 10:08:37.619791 | controller |   "xgrp": false,
2025-10-08 10:08:37.619804 | controller |   "xoth": false,
2025-10-08 10:08:37.619817 | controller |   "xusr": false
2025-10-08 10:08:37.619829 | controller | }
2025-10-08 10:08:37.653942 | 
2025-10-08 10:08:37.654028 | TASK [Copy crio stats log file]
2025-10-08 10:08:37.667556 | controller | skipping: Conditional result was False
2025-10-08 10:08:37.672806 | 
2025-10-08 10:08:37.672867 | TASK [Get SELinux related data]
2025-10-08 10:08:37.860576 | controller | <no matches>
2025-10-08 10:08:38.197009 | controller | ERROR
2025-10-08 10:08:38.197198 | controller | {
2025-10-08 10:08:38.197237 | controller |   "delta": "0:00:00.008665",
2025-10-08 10:08:38.197263 | controller |   "end": "2025-10-08 10:08:37.861450",
2025-10-08 10:08:38.197284 | controller |   "msg": "non-zero return code",
2025-10-08 10:08:38.197304 | controller |   "rc": 1,
2025-10-08 10:08:38.197322 | controller |   "start": "2025-10-08 10:08:37.852785"
2025-10-08 10:08:38.197339 | controller | }
2025-10-08 10:08:38.197364 | controller | ERROR: Ignoring Errors
2025-10-08 10:08:38.202016 | 
2025-10-08 10:08:38.202079 | TASK [Create system configuration directory]
2025-10-08 10:08:38.372557 | controller | changed
2025-10-08 10:08:38.376889 | 
2025-10-08 10:08:38.376968 | TASK [Get some of the system configurations]
2025-10-08 10:08:38.901187 | controller | changed
2025-10-08 10:08:38.905812 | 
2025-10-08 10:08:38.905871 | TASK [Copy generated documentation if available]
2025-10-08 10:08:38.919158 | controller | skipping: Conditional result was False
2025-10-08 10:08:38.924236 | 
2025-10-08 10:08:38.924297 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-08 10:08:38.937571 | controller | skipping: Conditional result was False
2025-10-08 10:08:38.943070 | 
2025-10-08 10:08:38.943134 | TASK [Compress logs bigger than 2MB]
2025-10-08 10:08:39.468852 | controller | changed
2025-10-08 10:08:39.473995 | 
2025-10-08 10:08:39.474052 | TASK [Copy files from workspace on node]
2025-10-08 10:08:39.491874 | controller | ok
2025-10-08 10:08:39.512160 | 
2025-10-08 10:08:39.512227 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-08 10:08:39.525787 | controller | skipping: Conditional result was False
2025-10-08 10:08:39.531095 | 
2025-10-08 10:08:39.531157 | TASK [fetch-output : Set log path for single node]
2025-10-08 10:08:39.558838 | controller | ok
2025-10-08 10:08:39.563261 | 
2025-10-08 10:08:39.563321 | LOOP [fetch-output : Ensure local output dirs]
2025-10-08 10:08:39.753730 | controller -> localhost | ok: "/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/logs"
2025-10-08 10:08:39.753968 | controller -> localhost | changed: All items complete
2025-10-08 10:08:39.753997 | 
2025-10-08 10:08:39.916001 | controller -> localhost | changed: "/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/artifacts"
2025-10-08 10:08:40.076587 | controller -> localhost | changed: "/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/docs"
2025-10-08 10:08:40.090159 | 
2025-10-08 10:08:40.090254 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-08 10:08:40.594996 | controller | changed:
2025-10-08 10:08:40.595191 | controller | .d..t...... ./
2025-10-08 10:08:40.595219 | controller | >f+++++++++ README.html
2025-10-08 10:08:40.595240 | controller | >f+++++++++ ansible-execution.log
2025-10-08 10:08:40.595261 | controller | >f+++++++++ ansible.log
2025-10-08 10:08:40.595278 | controller | >f+++++++++ dmesg.log
2025-10-08 10:08:40.595295 | controller | >f+++++++++ installed-pkgs.log
2025-10-08 10:08:40.595319 | controller | >f+++++++++ python.log
2025-10-08 10:08:40.595340 | controller | >f+++++++++ registries.conf
2025-10-08 10:08:40.595356 | controller | >f+++++++++ report.html
2025-10-08 10:08:40.595373 | controller | >f+++++++++ selinux-denials.log
2025-10-08 10:08:40.595388 | controller | >f+++++++++ selinux-listing.log
2025-10-08 10:08:40.595404 | controller | cd+++++++++ ci-framework-data/
2025-10-08 10:08:40.595419 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-08 10:08:40.595434 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key
2025-10-08 10:08:40.595449 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub
2025-10-08 10:08:40.595464 | controller | >f+++++++++ ci-framework-data/artifacts/user_key
2025-10-08 10:08:40.595478 | controller | >f+++++++++ ci-framework-data/artifacts/user_key.pub
2025-10-08 10:08:40.595492 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-08 10:08:40.595516 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/
2025-10-08 10:08:40.595532 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values-post-ceph/
2025-10-08 10:08:40.595546 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values-post-ceph/values.yaml
2025-10-08 10:08:40.595560 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values/
2025-10-08 10:08:40.595575 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values/values.yaml
2025-10-08 10:08:40.595589 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values-post-ceph/
2025-10-08 10:08:40.595603 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values-post-ceph/values.yaml
2025-10-08 10:08:40.595616 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/
2025-10-08 10:08:40.595630 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-08 10:08:40.595644 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/
2025-10-08 10:08:40.595657 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-08 10:08:40.595671 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/service-values/
2025-10-08 10:08:40.595684 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/service-values/values.yaml
2025-10-08 10:08:40.595698 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/service-values/values.yaml.28984.2025-10-08@10:08:21~
2025-10-08 10:08:40.595711 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/
2025-10-08 10:08:40.595725 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/
2025-10-08 10:08:40.595738 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/01_original.yaml
2025-10-08 10:08:40.595751 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/03_user_data_b64.yaml
2025-10-08 10:08:40.595764 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/04_user_data.yaml
2025-10-08 10:08:40.595778 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/
2025-10-08 10:08:40.595791 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/01_original.yaml
2025-10-08 10:08:40.595804 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/03_user_data_b64.yaml
2025-10-08 10:08:40.595817 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/04_user_data.yaml
2025-10-08 10:08:40.595833 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/
2025-10-08 10:08:40.595847 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/01_original.yaml
2025-10-08 10:08:40.595863 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/03_user_data_b64.yaml
2025-10-08 10:08:40.595877 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/04_user_data.yaml
2025-10-08 10:08:40.595892 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/
2025-10-08 10:08:40.595920 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml
2025-10-08 10:08:40.595945 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml
2025-10-08 10:08:40.595963 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml
2025-10-08 10:08:40.595979 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml
2025-10-08 10:08:40.595993 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/
2025-10-08 10:08:40.596007 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml
2025-10-08 10:08:40.596021 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml.27240.2025-10-08@10:07:53~
2025-10-08 10:08:40.596035 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml
2025-10-08 10:08:40.596049 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml
2025-10-08 10:08:40.596064 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml
2025-10-08 10:08:40.596078 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/
2025-10-08 10:08:40.596092 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/01_original.yaml
2025-10-08 10:08:40.596105 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/01_original.yaml.28893.2025-10-08@10:08:20~
2025-10-08 10:08:40.596118 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/03_user_data_b64.yaml
2025-10-08 10:08:40.596132 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/04_user_data.yaml
2025-10-08 10:08:40.596145 | controller | cd+++++++++ ci-framework-data/artifacts/kustomize_deploy/
2025-10-08 10:08:40.596158 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/control-plane.yaml
2025-10-08 10:08:40.596171 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/deployment-post-ceph.yaml
2025-10-08 10:08:40.596186 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/deployment-pre-ceph.yaml
2025-10-08 10:08:40.596200 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/network.yaml
2025-10-08 10:08:40.596214 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nncp.yaml
2025-10-08 10:08:40.596228 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nodeset-post-ceph.yaml
2025-10-08 10:08:40.596241 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nodeset-pre-ceph.yaml
2025-10-08 10:08:40.596255 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2025-10-08 10:08:40.596269 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2025-10-08 10:08:40.596283 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2025-10-08 10:08:40.596296 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-08 10:08:40.596309 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-08 10:08:40.596327 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-08 10:08:40.596341 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-08 10:08:40.596354 | controller | cd+++++++++ registries.conf.d/
2025-10-08 10:08:40.596368 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-08 10:08:40.596381 | controller | cd+++++++++ system-config/
2025-10-08 10:08:40.596394 | controller | cd+++++++++ system-config/libvirt/
2025-10-08 10:08:40.596407 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-08 10:08:40.596420 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-08 10:08:40.948872 | controller | changed: .d..t...... ./
2025-10-08 10:08:41.296061 | controller | changed: .d..t...... ./
2025-10-08 10:08:41.309796 | 
2025-10-08 10:08:41.309874 | TASK [Return artifact to Zuul]
2025-10-08 10:08:41.338254 | controller | ok
2025-10-08 10:08:41.355983 | 
2025-10-08 10:08:41.356035 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-08 10:08:41.356123 | 
2025-10-08 10:08:41.356148 | PLAY RECAP
2025-10-08 10:08:41.356182 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-08 10:08:41.356201 | 
2025-10-08 10:08:41.428767 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-08 10:08:41.429501 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-08 10:08:41.921560 | 
2025-10-08 10:08:41.921675 | PLAY [all]
2025-10-08 10:08:41.939706 | 
2025-10-08 10:08:41.939780 | TASK [include_role : fetch-output]
2025-10-08 10:08:41.968695 | controller | ok
2025-10-08 10:08:41.984969 | 
2025-10-08 10:08:41.985048 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-08 10:08:42.029145 | controller | skipping: Conditional result was False
2025-10-08 10:08:42.034682 | 
2025-10-08 10:08:42.034750 | TASK [fetch-output : Set log path for single node]
2025-10-08 10:08:42.063123 | controller | ok
2025-10-08 10:08:42.067875 | 
2025-10-08 10:08:42.067961 | LOOP [fetch-output : Ensure local output dirs]
2025-10-08 10:08:42.376159 | controller -> localhost | ok: "/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/logs"
2025-10-08 10:08:42.561986 | controller -> localhost | ok: "/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/artifacts"
2025-10-08 10:08:42.738722 | controller -> localhost | ok: "/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/docs"
2025-10-08 10:08:42.746848 | 
2025-10-08 10:08:42.746932 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-08 10:08:43.221780 | controller | ok
2025-10-08 10:08:43.222023 | controller | ok: All items complete
2025-10-08 10:08:43.222055 | 
2025-10-08 10:08:43.572598 | controller | ok
2025-10-08 10:08:43.937787 | controller | ok
2025-10-08 10:08:43.957279 | 
2025-10-08 10:08:43.957392 | TASK [include_role : fetch-output-openshift]
2025-10-08 10:08:43.971324 | controller | skipping: Conditional result was False
2025-10-08 10:08:43.976999 | 
2025-10-08 10:08:43.977068 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-08 10:08:44.312193 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006519
2025-10-08 10:08:44.491530 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007116
2025-10-08 10:08:44.520725 | 
2025-10-08 10:08:44.520798 | PLAY [all]
2025-10-08 10:08:44.533223 | 
2025-10-08 10:08:44.533285 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-08 10:08:44.896943 | controller | changed
2025-10-08 10:08:44.917471 | 
2025-10-08 10:08:44.917537 | PLAY RECAP
2025-10-08 10:08:44.917582 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-08 10:08:44.917604 | 
2025-10-08 10:08:44.989970 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-08 10:08:44.990918 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-08 10:08:45.489022 | 
2025-10-08 10:08:45.489124 | PLAY [localhost]
2025-10-08 10:08:45.505059 | 
2025-10-08 10:08:45.505129 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-08 10:08:45.796376 | localhost | changed
2025-10-08 10:08:45.800761 | 
2025-10-08 10:08:45.800840 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-08 10:08:45.818424 | localhost | ok
2025-10-08 10:08:45.826125 | 
2025-10-08 10:08:45.826196 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-08 10:08:46.097030 | localhost | changed
2025-10-08 10:08:46.102222 | 
2025-10-08 10:08:46.102286 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-08 10:08:46.597337 | localhost | changed
2025-10-08 10:08:46.601715 | 
2025-10-08 10:08:46.601777 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-08 10:08:46.903034 | localhost | Identity added: /var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/tmp/ansible.3j7ij7cs (/var/lib/zuul/builds/699313da52ad4a718204663e8aef4c33/work/tmp/ansible.3j7ij7cs)
2025-10-08 10:08:46.903263 | localhost | ok: Runtime: 0:00:00.005934
2025-10-08 10:08:46.907258 | 
2025-10-08 10:08:46.907329 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-08 10:08:47.107219 | localhost | ok: Runtime: 0:00:00.004190
2025-10-08 10:08:47.111603 | 
2025-10-08 10:08:47.111669 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-08 10:08:47.159098 | localhost | changed
2025-10-08 10:08:47.163757 | 
2025-10-08 10:08:47.163818 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-08 10:08:47.454401 | localhost | changed
2025-10-08 10:08:47.472243 | 
2025-10-08 10:08:47.472296 | PLAY [localhost]
2025-10-08 10:08:47.482431 | 
2025-10-08 10:08:47.482489 | TASK [Generate bulk log download script]
2025-10-08 10:08:47.500742 | localhost | ok
2025-10-08 10:08:47.510987 | 
2025-10-08 10:08:47.511048 | TASK [local-log-download : Check API endpoint is defined]
2025-10-08 10:08:47.538290 | localhost | ok: All assertions passed
2025-10-08 10:08:47.542584 | 
2025-10-08 10:08:47.542652 | TASK [local-log-download : Create download script]
2025-10-08 10:08:47.870407 | localhost -> localhost | changed
2025-10-08 10:08:47.878542 | 
2025-10-08 10:08:47.878604 | TASK [Register quick-download link]
2025-10-08 10:08:47.895652 | localhost | ok
2025-10-08 10:08:47.929682 | 
2025-10-08 10:08:47.929747 | PLAY [logserver.rdoproject.org]
2025-10-08 10:08:47.938313 | 
2025-10-08 10:08:47.938369 | TASK [Set zuul-log-path fact]
2025-10-08 10:08:47.954197 | logserver.rdoproject.org | ok
2025-10-08 10:08:47.962388 | 
2025-10-08 10:08:47.962449 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-08 10:08:47.988661 | logserver.rdoproject.org | ok
2025-10-08 10:08:47.993403 | 
2025-10-08 10:08:47.993462 | TASK [upload-logs : Create log directories]
2025-10-08 10:08:50.860594 | logserver.rdoproject.org | changed
2025-10-08 10:08:50.863382 | 
2025-10-08 10:08:50.863443 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-08 10:08:51.070388 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005064
2025-10-08 10:08:51.075030 | 
2025-10-08 10:08:51.075093 | TASK [upload-logs : Upload logs to log server]
2025-10-08 10:08:53.483979 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-08 10:08:53.486818 | 
2025-10-08 10:08:53.486882 | LOOP [upload-logs : Compress console log and json output]
2025-10-08 10:08:53.527101 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 10:08:53.534929 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 10:08:53.544003 | 
2025-10-08 10:08:53.544068 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-08 10:08:53.577460 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 10:08:53.577637 | 
2025-10-08 10:08:53.580212 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-08 10:08:53.591203 | 
2025-10-08 10:08:53.591269 | LOOP [upload-logs : Upload console log and json output]