2025-10-03 14:35:42.760458 | Job console starting...
2025-10-03 14:35:43.081664 | Updating repositories
2025-10-03 14:35:43.889314 | Preparing job workspace
2025-10-03 14:35:54.490270 | Running Ansible setup...
2025-10-03 14:35:58.932218 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-03 14:35:59.499409 | 
2025-10-03 14:35:59.499546 | PLAY [localhost]
2025-10-03 14:35:59.509201 | 
2025-10-03 14:35:59.509277 | TASK [Gathering Facts]
2025-10-03 14:36:00.461407 | localhost | ok
2025-10-03 14:36:00.487405 | 
2025-10-03 14:36:00.487556 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-03 14:36:01.197480 | localhost -> localhost | changed
2025-10-03 14:36:01.202794 | 
2025-10-03 14:36:01.202870 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-03 14:36:02.574128 | localhost -> localhost | changed
2025-10-03 14:36:02.582527 | 
2025-10-03 14:36:02.582593 | TASK [Setup log path fact]
2025-10-03 14:36:02.599569 | localhost | ok
2025-10-03 14:36:02.611344 | 
2025-10-03 14:36:02.611419 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-03 14:36:02.649332 | localhost | ok
2025-10-03 14:36:02.656879 | 
2025-10-03 14:36:02.656961 | TASK [emit-job-header : Print job information]
2025-10-03 14:36:02.683346 | # Job Information
2025-10-03 14:36:02.683466 | Ansible Version: 2.15.12
2025-10-03 14:36:02.683497 | Job: cifmw-molecule-kustomize_deploy
2025-10-03 14:36:02.683519 | Pipeline: github-check
2025-10-03 14:36:02.683539 | Executor: ibm-bm4-ze.softwarefactory-project.io
2025-10-03 14:36:02.683558 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3366
2025-10-03 14:36:02.683577 | Log URL (when completed): https://logserver.rdoproject.org/aff/rdoproject.org/affbb926f8674dca811f8db0291e25b3/
2025-10-03 14:36:02.683596 | Event ID: 2534be40-a065-11f0-8cb8-613a1bcbea70
2025-10-03 14:36:02.687631 | 
2025-10-03 14:36:02.687696 | LOOP [emit-job-header : Print node information]
2025-10-03 14:36:02.793835 | localhost | ok:
2025-10-03 14:36:02.794017 | localhost | # Node Information
2025-10-03 14:36:02.794052 | localhost | Inventory Hostname: controller
2025-10-03 14:36:02.794078 | localhost | Hostname: np0005469747
2025-10-03 14:36:02.794100 | localhost | Username: zuul
2025-10-03 14:36:02.794123 | localhost | Distro: CentOS 9
2025-10-03 14:36:02.794143 | localhost | Provider: ibm-bm4-nodepool
2025-10-03 14:36:02.794161 | localhost | Region: regionOne
2025-10-03 14:36:02.794180 | localhost | Label: cloud-centos-9-stream-tripleo-ibm
2025-10-03 14:36:02.794199 | localhost | Product Name: OpenStack Compute
2025-10-03 14:36:02.794217 | localhost | Interface IP: 192.168.26.103
2025-10-03 14:36:02.842926 | 
2025-10-03 14:36:02.843020 | PLAY [all]
2025-10-03 14:36:02.857785 | 
2025-10-03 14:36:02.857870 | TASK [Gather network facts]
2025-10-03 14:36:03.237217 | controller | ok
2025-10-03 14:36:03.256822 | 
2025-10-03 14:36:03.256946 | TASK [include_role : start-zuul-console]
2025-10-03 14:36:03.279904 | controller | ok
2025-10-03 14:36:03.292817 | 
2025-10-03 14:36:03.292922 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-03 14:36:03.644281 | controller | ok
2025-10-03 14:36:03.654556 | 
2025-10-03 14:36:03.654788 | TASK [include_role : add-build-sshkey]
2025-10-03 14:36:03.673368 | controller | ok
2025-10-03 14:36:03.688392 | 
2025-10-03 14:36:03.688480 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-03 14:36:03.905142 | controller -> localhost | ok
2025-10-03 14:36:03.910951 | 
2025-10-03 14:36:03.911054 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-03 14:36:03.940129 | controller | ok
2025-10-03 14:36:03.957734 | controller | included: /var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-03 14:36:03.963887 | 
2025-10-03 14:36:03.963980 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-03 14:36:04.729639 | controller -> localhost | Generating public/private rsa key pair.
2025-10-03 14:36:04.729837 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/affbb926f8674dca811f8db0291e25b3_id_rsa.
2025-10-03 14:36:04.729873 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/affbb926f8674dca811f8db0291e25b3_id_rsa.pub.
2025-10-03 14:36:04.729898 | controller -> localhost | The key fingerprint is:
2025-10-03 14:36:04.729941 | controller -> localhost | SHA256:iVF3xgLjMidq97tglI9PRB0a2EOWTCqAlX5K38Wttfc zuul-build-sshkey
2025-10-03 14:36:04.729968 | controller -> localhost | The key's randomart image is:
2025-10-03 14:36:04.729989 | controller -> localhost | +---[RSA 3072]----+
2025-10-03 14:36:04.730008 | controller -> localhost | | oo.   *Ooo.o    |
2025-10-03 14:36:04.730029 | controller -> localhost | |. ..  .==*.+.    |
2025-10-03 14:36:04.730047 | controller -> localhost | | .  . *.=o..     |
2025-10-03 14:36:04.730066 | controller -> localhost | |  o .o Xo.o      |
2025-10-03 14:36:04.730085 | controller -> localhost | | . +o.=.So .     |
2025-10-03 14:36:04.730102 | controller -> localhost | |  ...o.=. . .    |
2025-10-03 14:36:04.730120 | controller -> localhost | |      + +  . .   |
2025-10-03 14:36:04.730140 | controller -> localhost | |     . + .    E  |
2025-10-03 14:36:04.730159 | controller -> localhost | |        +.       |
2025-10-03 14:36:04.730176 | controller -> localhost | +----[SHA256]-----+
2025-10-03 14:36:04.730220 | controller -> localhost | ok: Runtime: 0:00:00.255323
2025-10-03 14:36:04.736674 | 
2025-10-03 14:36:04.736751 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-03 14:36:04.778659 | controller | ok
2025-10-03 14:36:04.795605 | controller | included: /var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-03 14:36:04.814994 | 
2025-10-03 14:36:04.815085 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-03 14:36:04.858995 | controller | skipping: Conditional result was False
2025-10-03 14:36:04.865074 | 
2025-10-03 14:36:04.865146 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-03 14:36:05.413767 | controller | changed
2025-10-03 14:36:05.419972 | 
2025-10-03 14:36:05.420041 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-03 14:36:05.640150 | controller | ok
2025-10-03 14:36:05.644972 | 
2025-10-03 14:36:05.645037 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-03 14:36:06.394749 | controller | changed
2025-10-03 14:36:06.399758 | 
2025-10-03 14:36:06.399828 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-03 14:36:07.103207 | controller | changed
2025-10-03 14:36:07.110476 | 
2025-10-03 14:36:07.110559 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-03 14:36:07.140737 | controller | skipping: Conditional result was False
2025-10-03 14:36:07.146719 | 
2025-10-03 14:36:07.146814 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-03 14:36:07.801424 | controller -> localhost | changed
2025-10-03 14:36:07.812065 | 
2025-10-03 14:36:07.812154 | TASK [add-build-sshkey : Add back temp key]
2025-10-03 14:36:08.253405 | controller -> localhost | Identity added: /var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/affbb926f8674dca811f8db0291e25b3_id_rsa (zuul-build-sshkey)
2025-10-03 14:36:08.253666 | controller -> localhost | ok: Runtime: 0:00:00.007476
2025-10-03 14:36:08.264655 | 
2025-10-03 14:36:08.264730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-03 14:36:08.692610 | controller | ok
2025-10-03 14:36:08.698192 | 
2025-10-03 14:36:08.698272 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-03 14:36:08.761577 | controller | skipping: Conditional result was False
2025-10-03 14:36:08.775632 | 
2025-10-03 14:36:08.775711 | TASK [include_role : validate-host]
2025-10-03 14:36:08.819788 | controller | ok
2025-10-03 14:36:08.851628 | 
2025-10-03 14:36:08.851711 | TASK [validate-host : Define zuul_info_dir fact]
2025-10-03 14:36:08.880797 | controller | ok
2025-10-03 14:36:08.889477 | 
2025-10-03 14:36:08.889568 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2025-10-03 14:36:09.397570 | controller -> localhost | ok
2025-10-03 14:36:09.404886 | 
2025-10-03 14:36:09.404987 | TASK [validate-host : Collect information about the host]
2025-10-03 14:36:10.039768 | controller | ok
2025-10-03 14:36:10.050993 | 
2025-10-03 14:36:10.051162 | TASK [validate-host : Sanitize hostname]
2025-10-03 14:36:10.099751 | controller | ok
2025-10-03 14:36:10.105422 | 
2025-10-03 14:36:10.105492 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2025-10-03 14:36:10.891651 | controller -> localhost | changed
2025-10-03 14:36:10.898843 | 
2025-10-03 14:36:10.898961 | TASK [validate-host : Collect information about zuul worker]
2025-10-03 14:36:11.412651 | controller | ok
2025-10-03 14:36:11.417509 | 
2025-10-03 14:36:11.417586 | TASK [validate-host : Write out all zuul information for each host]
2025-10-03 14:36:12.054996 | controller -> localhost | changed
2025-10-03 14:36:12.065822 | 
2025-10-03 14:36:12.065941 | TASK [include_role : prepare-workspace-openshift]
2025-10-03 14:36:12.080464 | controller | skipping: Conditional result was False
2025-10-03 14:36:12.086888 | 
2025-10-03 14:36:12.086998 | TASK [include_role : remove-zuul-sshkey]
2025-10-03 14:36:12.112127 | controller | skipping: Conditional result was False
2025-10-03 14:36:12.118123 | 
2025-10-03 14:36:12.118197 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-03 14:36:12.325369 | controller | ok: "logs"
2025-10-03 14:36:12.325572 | controller | ok: All items complete
2025-10-03 14:36:12.325603 | 
2025-10-03 14:36:12.500081 | controller | ok: "artifacts"
2025-10-03 14:36:12.666922 | controller | ok: "docs"
2025-10-03 14:36:12.680307 | 
2025-10-03 14:36:12.680388 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-03 14:36:12.909845 | controller | changed: "logs"
2025-10-03 14:36:13.080242 | controller | changed: "artifacts"
2025-10-03 14:36:13.262667 | controller | changed: "docs"
2025-10-03 14:36:13.291051 | 
2025-10-03 14:36:13.291139 | PLAY RECAP
2025-10-03 14:36:13.291188 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-03 14:36:13.291218 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-03 14:36:13.291238 | 
2025-10-03 14:36:13.380497 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master]
2025-10-03 14:36:13.381303 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-03 14:36:14.054158 | 
2025-10-03 14:36:14.054288 | PLAY [all]
2025-10-03 14:36:14.074759 | 
2025-10-03 14:36:14.074883 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-03 14:36:14.137255 | controller | ok
2025-10-03 14:36:14.142959 | 
2025-10-03 14:36:14.143083 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-03 14:36:14.571633 | controller | changed
2025-10-03 14:36:14.577241 | 
2025-10-03 14:36:14.577330 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-03 14:36:15.695639 | controller | changed
2025-10-03 14:36:15.709222 | 
2025-10-03 14:36:15.709326 | LOOP [add-authorized-keys : Enable access via build key on all nodes]
2025-10-03 14:36:16.117857 | controller | changed:
2025-10-03 14:36:16.118069 | controller | {
2025-10-03 14:36:16.118110 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com"
2025-10-03 14:36:16.118164 | controller | }
2025-10-03 14:36:16.325504 | controller | changed:
2025-10-03 14:36:16.325587 | controller | {
2025-10-03 14:36:16.325615 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com"
2025-10-03 14:36:16.325637 | controller | }
2025-10-03 14:36:16.544507 | controller | changed:
2025-10-03 14:36:16.544597 | controller | {
2025-10-03 14:36:16.544625 | 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-03 14:36:16.544647 | controller | }
2025-10-03 14:36:16.752310 | controller | changed:
2025-10-03 14:36:16.752389 | controller | {
2025-10-03 14:36:16.752417 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com"
2025-10-03 14:36:16.752438 | controller | }
2025-10-03 14:36:16.977833 | controller | changed:
2025-10-03 14:36:16.977939 | controller | {
2025-10-03 14:36:16.977971 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com"
2025-10-03 14:36:16.977993 | controller | }
2025-10-03 14:36:17.189011 | controller | changed:
2025-10-03 14:36:17.189123 | controller | {
2025-10-03 14:36:17.189158 | controller |   "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com"
2025-10-03 14:36:17.189186 | controller | }
2025-10-03 14:36:17.409424 | controller | changed:
2025-10-03 14:36:17.409521 | controller | {
2025-10-03 14:36:17.409550 | 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-03 14:36:17.409571 | controller | }
2025-10-03 14:36:17.623180 | controller | changed:
2025-10-03 14:36:17.623278 | controller | {
2025-10-03 14:36:17.623309 | 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-03 14:36:17.623330 | controller | }
2025-10-03 14:36:17.838427 | controller | changed:
2025-10-03 14:36:17.838520 | controller | {
2025-10-03 14:36:17.838549 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner"
2025-10-03 14:36:17.838569 | controller | }
2025-10-03 14:36:18.045486 | controller | changed:
2025-10-03 14:36:18.045575 | controller | {
2025-10-03 14:36:18.045758 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com"
2025-10-03 14:36:18.045793 | controller | }
2025-10-03 14:36:18.313588 | controller | changed:
2025-10-03 14:36:18.313670 | controller | {
2025-10-03 14:36:18.313698 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com"
2025-10-03 14:36:18.313719 | controller | }
2025-10-03 14:36:18.479646 | controller | changed:
2025-10-03 14:36:18.479744 | controller | {
2025-10-03 14:36:18.479773 | controller |   "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com"
2025-10-03 14:36:18.479795 | controller | }
2025-10-03 14:36:18.691878 | controller | changed:
2025-10-03 14:36:18.692029 | controller | {
2025-10-03 14:36:18.692063 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith"
2025-10-03 14:36:18.692105 | controller | }
2025-10-03 14:36:18.905803 | controller | changed:
2025-10-03 14:36:18.905875 | controller | {
2025-10-03 14:36:18.905903 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel"
2025-10-03 14:36:18.905961 | controller | }
2025-10-03 14:36:19.111302 | controller | changed:
2025-10-03 14:36:19.111390 | controller | {
2025-10-03 14:36:19.111418 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux"
2025-10-03 14:36:19.111440 | controller | }
2025-10-03 14:36:19.317829 | controller | changed:
2025-10-03 14:36:19.317974 | controller | {
2025-10-03 14:36:19.318013 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr"
2025-10-03 14:36:19.318037 | controller | }
2025-10-03 14:36:19.528013 | controller | changed:
2025-10-03 14:36:19.528105 | controller | {
2025-10-03 14:36:19.528136 | 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-03 14:36:19.528164 | controller | }
2025-10-03 14:36:19.742290 | controller | changed:
2025-10-03 14:36:19.742368 | controller | {
2025-10-03 14:36:19.742396 | 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-03 14:36:19.742425 | controller | }
2025-10-03 14:36:19.950078 | controller | changed:
2025-10-03 14:36:19.950166 | controller | {
2025-10-03 14:36:19.950192 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9"
2025-10-03 14:36:19.950214 | controller | }
2025-10-03 14:36:20.163900 | controller | changed:
2025-10-03 14:36:20.164030 | controller | {
2025-10-03 14:36:20.164070 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora"
2025-10-03 14:36:20.164092 | controller | }
2025-10-03 14:36:20.371492 | controller | changed:
2025-10-03 14:36:20.371582 | controller | {
2025-10-03 14:36:20.371612 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac"
2025-10-03 14:36:20.371633 | controller | }
2025-10-03 14:36:20.584626 | controller | changed:
2025-10-03 14:36:20.584707 | controller | {
2025-10-03 14:36:20.584759 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop"
2025-10-03 14:36:20.584782 | controller | }
2025-10-03 14:36:20.803059 | controller | changed:
2025-10-03 14:36:20.803155 | controller | {
2025-10-03 14:36:20.803182 | 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-03 14:36:20.803205 | controller | }
2025-10-03 14:36:21.014202 | controller | changed:
2025-10-03 14:36:21.014298 | controller | {
2025-10-03 14:36:21.014328 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com"
2025-10-03 14:36:21.014349 | controller | }
2025-10-03 14:36:21.223852 | controller | changed:
2025-10-03 14:36:21.223951 | controller | {
2025-10-03 14:36:21.223982 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com"
2025-10-03 14:36:21.224004 | controller | }
2025-10-03 14:36:21.423971 | controller | changed:
2025-10-03 14:36:21.424061 | controller | {
2025-10-03 14:36:21.424087 | controller |   "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono"
2025-10-03 14:36:21.424108 | controller | }
2025-10-03 14:36:21.441935 | 
2025-10-03 14:36:21.442055 | TASK [Set timezone to UTC]
2025-10-03 14:36:21.828321 | controller | changed: executed `/bin/timedatectl set-timezone UTC`
2025-10-03 14:36:21.835135 | 
2025-10-03 14:36:21.835227 | TASK [Create nodepool directory]
2025-10-03 14:36:22.037821 | controller | changed
2025-10-03 14:36:22.044012 | 
2025-10-03 14:36:22.044112 | TASK [Create nodepool sub_nodes file]
2025-10-03 14:36:22.541479 | controller | changed
2025-10-03 14:36:22.546752 | 
2025-10-03 14:36:22.546823 | TASK [Create nodepool sub_nodes_private file]
2025-10-03 14:36:23.066291 | controller | changed
2025-10-03 14:36:23.072272 | 
2025-10-03 14:36:23.072334 | LOOP [Populate nodepool sub_nodes file]
2025-10-03 14:36:23.106935 | 
2025-10-03 14:36:23.107203 | LOOP [Populate nodepool sub_nodes_private file]
2025-10-03 14:36:23.138564 | 
2025-10-03 14:36:23.138707 | TASK [Create nodepool primary file]
2025-10-03 14:36:23.161899 | controller | skipping: Conditional result was False
2025-10-03 14:36:23.167042 | 
2025-10-03 14:36:23.167120 | TASK [Create nodepool node_private for this node]
2025-10-03 14:36:23.713074 | controller | changed
2025-10-03 14:36:23.720303 | 
2025-10-03 14:36:23.720382 | LOOP [Copy ssh keys to nodepool directory]
2025-10-03 14:36:24.045774 | controller | ok: Item: id_rsa Runtime: 0:00:00.005564
2025-10-03 14:36:24.046057 | 
2025-10-03 14:36:24.225152 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.005316
2025-10-03 14:36:24.233787 | 
2025-10-03 14:36:24.233876 | TASK [Add sudoers role for zuul-sudo-grep.sh]
2025-10-03 14:36:24.870053 | controller | changed
2025-10-03 14:36:24.875660 | 
2025-10-03 14:36:24.875753 | TASK [Validate sudoers config after edits]
2025-10-03 14:36:25.143770 | controller | /etc/sudoers: parsed OK
2025-10-03 14:36:25.143851 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK
2025-10-03 14:36:25.143874 | controller | /etc/sudoers.d/zuul: parsed OK
2025-10-03 14:36:25.143937 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK
2025-10-03 14:36:25.438587 | controller | ok: Runtime: 0:00:00.007961
2025-10-03 14:36:25.445625 | 
2025-10-03 14:36:25.445701 | TASK [Show the environment passed in to job shell scripts]
2025-10-03 14:36:25.647923 | controller | SHELL=/bin/bash
2025-10-03 14:36:25.647967 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework
2025-10-03 14:36:25.647977 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework
2025-10-03 14:36:25.647983 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/66/3366/b916ef9cc83cd6f61cb4c8a27bbc55fc27d7eaae
2025-10-03 14:36:25.647989 | controller | PWD=/home/zuul
2025-10-03 14:36:25.647994 | controller | ZUUL_PIPELINE=github-check
2025-10-03 14:36:25.648000 | controller | LOGNAME=zuul
2025-10-03 14:36:25.648005 | controller | XDG_SESSION_TYPE=tty
2025-10-03 14:36:25.648010 | controller | _=/usr/bin/env
2025-10-03 14:36:25.648016 | controller | MOTD_SHOWN=pam
2025-10-03 14:36:25.648021 | controller | HOME=/home/zuul
2025-10-03 14:36:25.648026 | controller | LANG=en_US.UTF-8
2025-10-03 14:36:25.648070 | controller | SSH_CONNECTION=192.168.26.12 37872 192.168.26.103 22
2025-10-03 14:36:25.648078 | 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-03 14:36:25.648086 | controller | ZUUL_CHANGE_IDS=3366,b916ef9cc83cd6f61cb4c8a27bbc55fc27d7eaae
2025-10-03 14:36:25.648092 | controller | WORKSPACE=/home/zuul/workspace
2025-10-03 14:36:25.648097 | controller | XDG_SESSION_CLASS=user
2025-10-03 14:36:25.648115 | controller | SELINUX_ROLE_REQUESTED=
2025-10-03 14:36:25.648123 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s
2025-10-03 14:36:25.648129 | controller | USER=zuul
2025-10-03 14:36:25.648134 | controller | ZUUL_VOTING=True
2025-10-03 14:36:25.648139 | controller | BUILD_TIMEOUT=1800000
2025-10-03 14:36:25.648144 | controller | SELINUX_USE_CURRENT_RANGE=
2025-10-03 14:36:25.648150 | controller | SHLVL=1
2025-10-03 14:36:25.648155 | controller | ZUUL_PATCHSET=b916ef9cc83cd6f61cb4c8a27bbc55fc27d7eaae
2025-10-03 14:36:25.648160 | controller | XDG_SESSION_ID=1
2025-10-03 14:36:25.648165 | controller | ZUUL_BRANCH=main
2025-10-03 14:36:25.648171 | controller | XDG_RUNTIME_DIR=/run/user/1000
2025-10-03 14:36:25.648176 | controller | SSH_CLIENT=192.168.26.12 37872 22
2025-10-03 14:36:25.648181 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/
2025-10-03 14:36:25.648186 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima:
2025-10-03 14:36:25.648192 | controller | which_declare=declare -f
2025-10-03 14:36:25.648197 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-03 14:36:25.648202 | controller | SELINUX_LEVEL_REQUESTED=
2025-10-03 14:36:25.648207 | controller | ZUUL_CHANGE=3366
2025-10-03 14:36:25.648213 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus
2025-10-03 14:36:25.648218 | controller | ZUUL_UUID=affbb926f8674dca811f8db0291e25b3
2025-10-03 14:36:25.648223 | controller | BASH_FUNC_which%%=() {  ( alias;
2025-10-03 14:36:25.648230 | controller |  eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@
2025-10-03 14:36:25.648236 | controller | }
2025-10-03 14:36:25.975949 | controller | ok: Runtime: 0:00:00.005707
2025-10-03 14:36:25.982051 | 
2025-10-03 14:36:25.982217 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars]
2025-10-03 14:36:25.995801 | controller | skipping: Conditional result was False
2025-10-03 14:36:26.002806 | 
2025-10-03 14:36:26.002900 | TASK [Symlink /home/zuul-worker/workspace]
2025-10-03 14:36:26.530536 | controller | skipping: Conditional result was False
2025-10-03 14:36:26.537219 | 
2025-10-03 14:36:26.537294 | TASK [Ensure legacy workspace directory]
2025-10-03 14:36:26.737994 | controller | changed
2025-10-03 14:36:26.762887 | 
2025-10-03 14:36:26.762974 | PLAY RECAP
2025-10-03 14:36:26.763022 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2025-10-03 14:36:26.763046 | 
2025-10-03 14:36:26.851712 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master]
2025-10-03 14:36:26.852467 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-03 14:36:27.458007 | 
2025-10-03 14:36:27.458101 | PLAY [Run ci/playbooks/dump_zuul_data.yml]
2025-10-03 14:36:27.497291 | 
2025-10-03 14:36:27.497374 | TASK [Create zuul-output directory]
2025-10-03 14:36:27.834849 | controller | changed
2025-10-03 14:36:27.839864 | 
2025-10-03 14:36:27.839981 | TASK [Slurp Zuul inventory test]
2025-10-03 14:36:28.325790 | controller -> localhost | ok
2025-10-03 14:36:28.339852 | 
2025-10-03 14:36:28.339993 | TASK [Save zuul inventory]
2025-10-03 14:36:29.442848 | controller | changed
2025-10-03 14:36:29.467924 | 
2025-10-03 14:36:29.468037 | TASK [Save zuul vars without the change_message]
2025-10-03 14:36:30.241400 | controller | changed
2025-10-03 14:36:30.284973 | 
2025-10-03 14:36:30.285070 | PLAY RECAP
2025-10-03 14:36:30.285122 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-03 14:36:30.285147 | 
2025-10-03 14:36:30.534118 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main]
2025-10-03 14:36:30.534902 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-03 14:36:31.411755 | 
2025-10-03 14:36:31.411894 | PLAY [Run ci/playbooks/molecule-prepare.yml]
2025-10-03 14:36:31.434482 | 
2025-10-03 14:36:31.434566 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh]
2025-10-03 14:36:31.464280 | controller | ok
2025-10-03 14:36:31.483863 | 
2025-10-03 14:36:31.483981 | TASK [mirror-info-fork : Set mirror_fqdn if not defined]
2025-10-03 14:36:31.507606 | controller | skipping: Conditional result was False
2025-10-03 14:36:31.523491 | 
2025-10-03 14:36:31.523572 | TASK [mirror-info-fork : Create /etc/ci]
2025-10-03 14:36:31.849208 | controller | ok
2025-10-03 14:36:31.855705 | 
2025-10-03 14:36:31.855796 | TASK [mirror-info-fork : Install ci_mirror script]
2025-10-03 14:36:32.515165 | controller | ok
2025-10-03 14:36:32.535639 | 
2025-10-03 14:36:32.535710 | TASK [Prepare workspace]
2025-10-03 14:36:32.574394 | controller | ok
2025-10-03 14:36:32.594550 | 
2025-10-03 14:36:32.594629 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-03 14:36:32.896649 | controller | ok
2025-10-03 14:36:32.903127 | 
2025-10-03 14:36:32.903193 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-03 14:36:35.612304 | controller | Output suppressed because no_log was given
2025-10-03 14:36:35.621852 | 
2025-10-03 14:36:35.621983 | LOOP [Create zuul-output directory]
2025-10-03 14:36:35.812337 | controller | changed: "/home/zuul/ci-framework-data/logs"
2025-10-03 14:36:35.970157 | controller | ok: "/home/zuul/zuul-output/logs"
2025-10-03 14:36:35.979037 | 
2025-10-03 14:36:35.979134 | TASK [Install required packages]
2025-10-03 14:37:30.540419 | controller | changed
2025-10-03 14:37:30.545997 | 
2025-10-03 14:37:30.546066 | TASK [Install venv]
2025-10-03 14:38:34.395960 | controller | changed
2025-10-03 14:38:34.427408 | 
2025-10-03 14:38:34.427505 | PLAY RECAP
2025-10-03 14:38:34.427555 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2025-10-03 14:38:34.427580 | 
2025-10-03 14:38:34.505905 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main]
2025-10-03 14:38:34.510498 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-03 14:38:35.148428 | 
2025-10-03 14:38:35.148528 | PLAY [Run ci/playbooks/molecule-test.yml]
2025-10-03 14:38:35.170020 | 
2025-10-03 14:38:35.170104 | TASK [Gather required facts]
2025-10-03 14:38:35.687648 | controller | ok
2025-10-03 14:38:35.693118 | 
2025-10-03 14:38:35.693197 | TASK [Load environment var if instructed to]
2025-10-03 14:38:35.716548 | controller | skipping: Conditional result was False
2025-10-03 14:38:35.721778 | 
2025-10-03 14:38:35.721847 | TASK [Check if group_vars dir exists]
2025-10-03 14:38:36.054626 | controller | ok
2025-10-03 14:38:36.061084 | 
2025-10-03 14:38:36.061162 | TASK [Create group_vars dir if does not exist]
2025-10-03 14:38:36.074924 | controller | skipping: Conditional result was False
2025-10-03 14:38:36.081012 | 
2025-10-03 14:38:36.081083 | TASK [Run molecule]
2025-10-03 14:38:37.029405 | controller | INFO     Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml
2025-10-03 14:38:37.098434 | controller | INFO     Performing prerun with role_name_check=0...
2025-10-03 14:38:53.523716 | 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-03 14:38:53.524380 | 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-03 14:38:53.524874 | 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-03 14:38:53.525334 | 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-03 14:38:53.525827 | controller | WARNING  Another version of 'cifmw.general' 1.0.0+ebae8754 was found installed in /home/zuul/.cache/ansible-compat/addcb0/collections/ansible_collections, only the first one will be used, 1.0.0+ebae8754 (/home/zuul/.ansible/collections/ansible_collections).
2025-10-03 14:38:53.526460 | 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-03 14:38:53.526921 | 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-03 14:38:53.527378 | 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-03 14:38:53.527843 | 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-03 14:38:53.528314 | 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-03 14:38:53.528738 | 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-03 14:38:53.529179 | 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-03 14:38:53.529609 | 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-03 14:38:53.530063 | 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-03 14:38:53.530516 | 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-03 14:38:53.539971 | controller | INFO     Running flexible_loop > prepare
2025-10-03 14:38:54.188641 | controller |
2025-10-03 14:38:54.188763 | controller | PLAY [Prepare] *****************************************************************
2025-10-03 14:38:54.188883 | controller |
2025-10-03 14:38:54.189007 | controller | TASK [Gathering Facts] *********************************************************
2025-10-03 14:38:54.189143 | controller | Friday 03 October 2025  14:38:54 +0000 (0:00:00.013)       0:00:00.013 ********
2025-10-03 14:38:55.023483 | controller | ok: [instance]
2025-10-03 14:38:55.023573 | controller |
2025-10-03 14:38:55.023712 | controller | TASK [Include ci_setup role] ***************************************************
2025-10-03 14:38:55.023824 | controller | Friday 03 October 2025  14:38:55 +0000 (0:00:00.835)       0:00:00.849 ********
2025-10-03 14:38:55.084441 | controller |
2025-10-03 14:38:55.084545 | controller | TASK [ci_setup : Gather variables for each operating system] *******************
2025-10-03 14:38:55.084680 | controller | Friday 03 October 2025  14:38:55 +0000 (0:00:00.061)       0:00:00.910 ********
2025-10-03 14:38:55.130870 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml)
2025-10-03 14:38:55.130977 | controller |
2025-10-03 14:38:55.131092 | controller | TASK [ci_setup : List packages to install] *************************************
2025-10-03 14:38:55.131224 | controller | Friday 03 October 2025  14:38:55 +0000 (0:00:00.046)       0:00:00.956 ********
2025-10-03 14:38:55.152258 | controller | ok: [instance] =>
2025-10-03 14:38:55.152350 | controller |   cifmw_ci_setup_packages:
2025-10-03 14:38:55.152451 | controller |   - bash-completion
2025-10-03 14:38:55.152547 | controller |   - ca-certificates
2025-10-03 14:38:55.152655 | controller |   - git-core
2025-10-03 14:38:55.152752 | controller |   - make
2025-10-03 14:38:55.152850 | controller |   - tar
2025-10-03 14:38:55.152940 | controller |   - tmux
2025-10-03 14:38:55.153038 | controller |   - python3-pip
2025-10-03 14:38:55.153147 | controller |
2025-10-03 14:38:55.153246 | controller | TASK [ci_setup : Install needed packages] **************************************
2025-10-03 14:38:55.153347 | controller | Friday 03 October 2025  14:38:55 +0000 (0:00:00.021)       0:00:00.978 ********
2025-10-03 14:38:58.880237 | controller | changed: [instance]
2025-10-03 14:38:58.880311 | controller |
2025-10-03 14:38:58.880423 | controller | TASK [ci_setup : Gather version of openshift client] ***************************
2025-10-03 14:38:58.880528 | controller | Friday 03 October 2025  14:38:58 +0000 (0:00:03.727)       0:00:04.706 ********
2025-10-03 14:38:59.167587 | controller | ok: [instance]
2025-10-03 14:38:59.167673 | controller |
2025-10-03 14:38:59.167782 | controller | TASK [ci_setup : Ensure openshift client install path is present] **************
2025-10-03 14:38:59.167884 | controller | Friday 03 October 2025  14:38:59 +0000 (0:00:00.287)       0:00:04.993 ********
2025-10-03 14:38:59.475824 | controller | changed: [instance]
2025-10-03 14:38:59.475887 | controller |
2025-10-03 14:38:59.475993 | controller | TASK [ci_setup : Install openshift client] *************************************
2025-10-03 14:38:59.476111 | controller | Friday 03 October 2025  14:38:59 +0000 (0:00:00.308)       0:00:05.301 ********
2025-10-03 14:39:05.356543 | controller | changed: [instance]
2025-10-03 14:39:05.356597 | controller |
2025-10-03 14:39:05.356707 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] **********************
2025-10-03 14:39:05.356823 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:05.880)       0:00:11.182 ********
2025-10-03 14:39:05.390019 | controller | skipping: [instance]
2025-10-03 14:39:05.390120 | controller |
2025-10-03 14:39:05.390235 | controller | TASK [ci_setup : Create completion file] ***************************************
2025-10-03 14:39:05.390333 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.033)       0:00:11.216 ********
2025-10-03 14:39:05.645791 | controller | changed: [instance]
2025-10-03 14:39:05.645867 | controller |
2025-10-03 14:39:05.645976 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************
2025-10-03 14:39:05.646085 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.255)       0:00:11.471 ********
2025-10-03 14:39:05.917507 | controller | changed: [instance]
2025-10-03 14:39:05.917600 | controller |
2025-10-03 14:39:05.917739 | controller | TASK [ci_setup : Check rhsm status] ********************************************
2025-10-03 14:39:05.917848 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.271)       0:00:11.743 ********
2025-10-03 14:39:05.934877 | controller | skipping: [instance]
2025-10-03 14:39:05.934980 | controller |
2025-10-03 14:39:05.935132 | controller | TASK [ci_setup : Gather the repos to be enabled] *******************************
2025-10-03 14:39:05.935265 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.017)       0:00:11.761 ********
2025-10-03 14:39:05.952003 | controller | skipping: [instance]
2025-10-03 14:39:05.952124 | controller |
2025-10-03 14:39:05.952272 | controller | TASK [ci_setup : Enabling the required repositories.] **************************
2025-10-03 14:39:05.952397 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.016)       0:00:11.778 ********
2025-10-03 14:39:05.969604 | controller | skipping: [instance]
2025-10-03 14:39:05.969725 | controller |
2025-10-03 14:39:05.969855 | controller | TASK [ci_setup : Get current /etc/redhat-release] ******************************
2025-10-03 14:39:05.969981 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.017)       0:00:11.795 ********
2025-10-03 14:39:05.987316 | controller | skipping: [instance]
2025-10-03 14:39:05.987416 | controller |
2025-10-03 14:39:05.987538 | controller | TASK [ci_setup : Print current /etc/redhat-release] ****************************
2025-10-03 14:39:05.988074 | controller | Friday 03 October 2025  14:39:05 +0000 (0:00:00.017)       0:00:11.813 ********
2025-10-03 14:39:06.004408 | controller | skipping: [instance]
2025-10-03 14:39:06.004509 | controller |
2025-10-03 14:39:06.004625 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] *********
2025-10-03 14:39:06.004745 | controller | Friday 03 October 2025  14:39:06 +0000 (0:00:00.016)       0:00:11.830 ********
2025-10-03 14:39:06.026408 | controller | skipping: [instance]
2025-10-03 14:39:06.026488 | controller |
2025-10-03 14:39:06.026596 | controller | TASK [ci_setup : Manage directories] *******************************************
2025-10-03 14:39:06.026722 | controller | Friday 03 October 2025  14:39:06 +0000 (0:00:00.022)       0:00:11.852 ********
2025-10-03 14:39:06.971404 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr)
2025-10-03 14:39:06.972148 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs)
2025-10-03 14:39:07.345940 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/tmp)
2025-10-03 14:39:07.345972 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes)
2025-10-03 14:39:07.345980 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters)
2025-10-03 14:39:07.345986 | controller |
2025-10-03 14:39:07.345992 | controller | TASK [Create nova migration keypair] *******************************************
2025-10-03 14:39:07.345997 | controller | Friday 03 October 2025  14:39:06 +0000 (0:00:00.944)       0:00:12.797 ********
2025-10-03 14:39:07.346007 | controller | changed: [instance]
2025-10-03 14:39:07.603710 | controller |
2025-10-03 14:39:07.603747 | controller | TASK [Create user keypair] *****************************************************
2025-10-03 14:39:07.603756 | controller | Friday 03 October 2025  14:39:07 +0000 (0:00:00.374)       0:00:13.171 ********
2025-10-03 14:39:07.603766 | controller | changed: [instance]
2025-10-03 14:39:08.052767 | controller |
2025-10-03 14:39:08.052799 | controller | TASK [Create fake kubeconfig] **************************************************
2025-10-03 14:39:08.052811 | controller | Friday 03 October 2025  14:39:07 +0000 (0:00:00.257)       0:00:13.429 ********
2025-10-03 14:39:08.052821 | controller | changed: [instance]
2025-10-03 14:39:08.109771 | controller |
2025-10-03 14:39:08.109804 | controller | PLAY RECAP *********************************************************************
2025-10-03 14:39:08.109813 | controller | instance                   : ok=13   changed=9    unreachable=0    failed=0    skipped=7    rescued=0    ignored=0
2025-10-03 14:39:08.109819 | controller |
2025-10-03 14:39:08.109824 | controller | Friday 03 October 2025  14:39:08 +0000 (0:00:00.446)       0:00:13.875 ********
2025-10-03 14:39:08.109830 | controller | ===============================================================================
2025-10-03 14:39:08.109835 | controller | ci_setup : Install openshift client ------------------------------------- 5.88s
2025-10-03 14:39:08.109847 | controller | ci_setup : Install needed packages -------------------------------------- 3.73s
2025-10-03 14:39:08.109852 | controller | ci_setup : Manage directories ------------------------------------------- 0.94s
2025-10-03 14:39:08.109857 | controller | Gathering Facts --------------------------------------------------------- 0.84s
2025-10-03 14:39:08.109863 | controller | Create fake kubeconfig -------------------------------------------------- 0.45s
2025-10-03 14:39:08.109868 | controller | Create nova migration keypair ------------------------------------------- 0.37s
2025-10-03 14:39:08.109873 | controller | ci_setup : Ensure openshift client install path is present -------------- 0.31s
2025-10-03 14:39:08.109879 | controller | ci_setup : Gather version of openshift client --------------------------- 0.29s
2025-10-03 14:39:08.109884 | controller | ci_setup : Source completion from within .bashrc ------------------------ 0.27s
2025-10-03 14:39:08.109889 | controller | Create user keypair ----------------------------------------------------- 0.26s
2025-10-03 14:39:08.109894 | controller | ci_setup : Create completion file --------------------------------------- 0.26s
2025-10-03 14:39:08.109900 | controller | Include ci_setup role --------------------------------------------------- 0.06s
2025-10-03 14:39:08.109905 | controller | ci_setup : Gather variables for each operating system ------------------- 0.05s
2025-10-03 14:39:08.109910 | controller | ci_setup : Add the OC path to cifmw_path if needed ---------------------- 0.03s
2025-10-03 14:39:08.109915 | controller | ci_setup : Ensure the repos are enabled in the system using yum --------- 0.02s
2025-10-03 14:39:08.109921 | controller | ci_setup : List packages to install ------------------------------------- 0.02s
2025-10-03 14:39:08.109926 | controller | ci_setup : Get current /etc/redhat-release ------------------------------ 0.02s
2025-10-03 14:39:08.109931 | controller | ci_setup : Enabling the required repositories. -------------------------- 0.02s
2025-10-03 14:39:08.109936 | controller | ci_setup : Check rhsm status -------------------------------------------- 0.02s
2025-10-03 14:39:08.109941 | controller | ci_setup : Gather the repos to be enabled ------------------------------- 0.02s
2025-10-03 14:39:08.109952 | controller | INFO     Running flexible_loop > converge
2025-10-03 14:39:08.552360 | controller |
2025-10-03 14:39:08.552561 | controller | PLAY [Converge] ****************************************************************
2025-10-03 14:39:08.552722 | controller |
2025-10-03 14:39:08.552866 | controller | TASK [Gathering Facts] *********************************************************
2025-10-03 14:39:08.553007 | controller | Friday 03 October 2025  14:39:08 +0000 (0:00:00.019)       0:00:00.019 ********
2025-10-03 14:39:09.313883 | controller | ok: [instance]
2025-10-03 14:39:09.356189 | controller |
2025-10-03 14:39:09.356226 | controller | TASK [Load networking environment definition] **********************************
2025-10-03 14:39:09.356237 | controller | Friday 03 October 2025  14:39:09 +0000 (0:00:00.761)       0:00:00.781 ********
2025-10-03 14:39:09.356250 | controller | ok: [instance]
2025-10-03 14:39:09.356298 | controller |
2025-10-03 14:39:09.356313 | controller | TASK [kustomize_deploy : Ensure that architecture repo exists] *****************
2025-10-03 14:39:09.356328 | controller | Friday 03 October 2025  14:39:09 +0000 (0:00:00.042)       0:00:00.823 ********
2025-10-03 14:39:09.676176 | controller | ok: [instance]
2025-10-03 14:39:09.676558 | controller |
2025-10-03 14:39:10.007207 | controller | TASK [kustomize_deploy : Gather the list of scenario folders] ******************
2025-10-03 14:39:10.007237 | controller | Friday 03 October 2025  14:39:09 +0000 (0:00:00.320)       0:00:01.143 ********
2025-10-03 14:39:10.007249 | controller | ok: [instance]
2025-10-03 14:39:10.007268 | controller |
2025-10-03 14:39:10.007470 | controller | TASK [kustomize_deploy : Check if scenario is in the list] *********************
2025-10-03 14:39:10.030622 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.330)       0:00:01.474 ********
2025-10-03 14:39:10.030666 | controller | skipping: [instance]
2025-10-03 14:39:10.319802 | controller |
2025-10-03 14:39:10.319831 | controller | TASK [kustomize_deploy : Ensure that destination directory exists] *************
2025-10-03 14:39:10.319839 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.023)       0:00:01.498 ********
2025-10-03 14:39:10.319849 | controller | changed: [instance]
2025-10-03 14:39:10.384195 | controller |
2025-10-03 14:39:10.384226 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize based on its patches] ***
2025-10-03 14:39:10.384244 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.289)       0:00:01.787 ********
2025-10-03 14:39:10.384257 | controller | ok: [instance] => (item=cifmw_architecture_user_kustomize)
2025-10-03 14:39:10.384286 | controller |
2025-10-03 14:39:10.384510 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize_base64 based on its patches] ***
2025-10-03 14:39:10.453224 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.064)       0:00:01.851 ********
2025-10-03 14:39:10.453257 | controller | ok: [instance]
2025-10-03 14:39:10.496212 | controller |
2025-10-03 14:39:10.496237 | controller | TASK [Load architecture automation] ********************************************
2025-10-03 14:39:10.496245 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.068)       0:00:01.920 ********
2025-10-03 14:39:10.496254 | controller | ok: [instance]
2025-10-03 14:39:10.713015 | controller |
2025-10-03 14:39:10.713049 | controller | TASK [Loop the deploy] *********************************************************
2025-10-03 14:39:10.713059 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.043)       0:00:01.963 ********
2025-10-03 14:39:10.713071 | controller |
2025-10-03 14:39:10.758733 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:10.758762 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.216)       0:00:02.180 ********
2025-10-03 14:39:10.758774 | controller | ok: [instance] => changed=false
2025-10-03 14:39:10.792023 | controller |   msg: All assertions passed
2025-10-03 14:39:10.792048 | controller |
2025-10-03 14:39:10.792055 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:10.792061 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.045)       0:00:02.226 ********
2025-10-03 14:39:10.792071 | controller | skipping: [instance]
2025-10-03 14:39:10.820031 | controller |
2025-10-03 14:39:10.820056 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:10.820065 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.033)       0:00:02.259 ********
2025-10-03 14:39:10.820077 | 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-03 14:39:10.841844 | controller |
2025-10-03 14:39:10.841869 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:10.841877 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.027)       0:00:02.287 ********
2025-10-03 14:39:10.841886 | controller | skipping: [instance]
2025-10-03 14:39:10.881085 | controller |
2025-10-03 14:39:10.881128 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:10.881138 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.021)       0:00:02.309 ********
2025-10-03 14:39:10.881148 | controller | ok: [instance]
2025-10-03 14:39:11.180646 | controller |
2025-10-03 14:39:11.180677 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:11.180685 | controller | Friday 03 October 2025  14:39:10 +0000 (0:00:00.039)       0:00:02.348 ********
2025-10-03 14:39:11.180695 | controller | ok: [instance] => (item={'name': 'network-values', 'src_file': 'values.yaml'})
2025-10-03 14:39:11.246149 | controller |
2025-10-03 14:39:11.246174 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:11.246183 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.299)       0:00:02.648 ********
2025-10-03 14:39:11.246194 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:11.294837 | controller |
2025-10-03 14:39:11.294857 | controller | TASK [Executing pre_stage hooks for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:11.294865 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.065)       0:00:02.713 ********
2025-10-03 14:39:11.294874 | controller | skipping: [instance]
2025-10-03 14:39:11.380003 | controller |
2025-10-03 14:39:11.380033 | controller | TASK [Generate values.yaml for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:11.380041 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.048)       0:00:02.762 ********
2025-10-03 14:39:11.380062 | controller |
2025-10-03 14:39:11.446175 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:11.446203 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.085)       0:00:02.847 ********
2025-10-03 14:39:11.446216 | 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-03 14:39:11.446611 | controller |
2025-10-03 14:39:11.497750 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:11.497769 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.066)       0:00:02.913 ********
2025-10-03 14:39:11.497779 | controller | ok: [instance] => changed=false
2025-10-03 14:39:11.715134 | controller |   msg: All assertions passed
2025-10-03 14:39:11.715165 | controller |
2025-10-03 14:39:11.715177 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:11.715184 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.051)       0:00:02.965 ********
2025-10-03 14:39:11.715194 | controller | ok: [instance]
2025-10-03 14:39:11.767841 | controller |
2025-10-03 14:39:11.767870 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:11.767878 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.217)       0:00:03.182 ********
2025-10-03 14:39:11.767888 | controller | ok: [instance] => changed=false
2025-10-03 14:39:12.078017 | controller |   msg: All assertions passed
2025-10-03 14:39:12.078048 | controller |
2025-10-03 14:39:12.078056 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:12.078062 | controller | Friday 03 October 2025  14:39:11 +0000 (0:00:00.052)       0:00:03.235 ********
2025-10-03 14:39:12.078072 | controller | ok: [instance]
2025-10-03 14:39:12.364899 | controller |
2025-10-03 14:39:12.364929 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:12.364938 | controller | Friday 03 October 2025  14:39:12 +0000 (0:00:00.310)       0:00:03.545 ********
2025-10-03 14:39:12.364948 | controller | ok: [instance]
2025-10-03 14:39:12.426237 | controller |
2025-10-03 14:39:12.426277 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:12.426287 | controller | Friday 03 October 2025  14:39:12 +0000 (0:00:00.286)       0:00:03.832 ********
2025-10-03 14:39:12.426300 | 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-03 14:39:12.426328 | controller |
2025-10-03 14:39:12.426338 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-03 14:39:12.426421 | controller | Friday 03 October 2025  14:39:12 +0000 (0:00:00.061)       0:00:03.893 ********
2025-10-03 14:39:12.475243 | controller | ok: [instance] => changed=false
2025-10-03 14:39:12.475295 | controller |   msg: All assertions passed
2025-10-03 14:39:12.475305 | controller |
2025-10-03 14:39:12.475315 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:12.475344 | controller | Friday 03 October 2025  14:39:12 +0000 (0:00:00.049)       0:00:03.942 ********
2025-10-03 14:39:12.692074 | controller | changed: [instance]
2025-10-03 14:39:13.243195 | controller |
2025-10-03 14:39:13.243226 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:13.243234 | controller | Friday 03 October 2025  14:39:12 +0000 (0:00:00.216)       0:00:04.159 ********
2025-10-03 14:39:13.243245 | controller | changed: [instance]
2025-10-03 14:39:13.305903 | controller |
2025-10-03 14:39:13.305936 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:13.305944 | controller | Friday 03 October 2025  14:39:13 +0000 (0:00:00.551)       0:00:04.710 ********
2025-10-03 14:39:13.305954 | controller | ok: [instance]
2025-10-03 14:39:13.676316 | controller |
2025-10-03 14:39:13.676349 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:13.676357 | controller | Friday 03 October 2025  14:39:13 +0000 (0:00:00.062)       0:00:04.773 ********
2025-10-03 14:39:13.676367 | controller | changed: [instance]
2025-10-03 14:39:14.047231 | controller |
2025-10-03 14:39:14.047270 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:14.047288 | controller | Friday 03 October 2025  14:39:13 +0000 (0:00:00.370)       0:00:05.143 ********
2025-10-03 14:39:14.047300 | controller | changed: [instance]
2025-10-03 14:39:14.047324 | controller |
2025-10-03 14:39:14.047478 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:14.047512 | controller | Friday 03 October 2025  14:39:14 +0000 (0:00:00.371)       0:00:05.514 ********
2025-10-03 14:39:14.423176 | controller | changed: [instance]
2025-10-03 14:39:14.488213 | controller |
2025-10-03 14:39:14.488265 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:14.488273 | controller | Friday 03 October 2025  14:39:14 +0000 (0:00:00.375)       0:00:05.890 ********
2025-10-03 14:39:14.488285 | 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-03 14:39:14.539056 | controller |
2025-10-03 14:39:14.539088 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:14.539096 | controller | Friday 03 October 2025  14:39:14 +0000 (0:00:00.065)       0:00:05.955 ********
2025-10-03 14:39:14.539130 | controller | ok: [instance] => changed=false
2025-10-03 14:39:14.759186 | controller |   msg: All assertions passed
2025-10-03 14:39:14.759219 | controller |
2025-10-03 14:39:14.759227 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:14.759233 | controller | Friday 03 October 2025  14:39:14 +0000 (0:00:00.050)       0:00:06.006 ********
2025-10-03 14:39:14.759244 | controller | ok: [instance]
2025-10-03 14:39:14.808299 | controller |
2025-10-03 14:39:14.808332 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:14.808340 | controller | Friday 03 October 2025  14:39:14 +0000 (0:00:00.220)       0:00:06.226 ********
2025-10-03 14:39:14.808350 | controller | ok: [instance]
2025-10-03 14:39:15.388782 | controller |
2025-10-03 14:39:15.388815 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:15.388823 | controller | Friday 03 October 2025  14:39:14 +0000 (0:00:00.048)       0:00:06.275 ********
2025-10-03 14:39:15.388832 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-03 14:39:15.522521 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-03 14:39:15.522555 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-03 14:39:15.522563 | controller |
2025-10-03 14:39:15.522570 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:15.522575 | controller | Friday 03 October 2025  14:39:15 +0000 (0:00:00.580)       0:00:06.855 ********
2025-10-03 14:39:15.522586 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-03 14:39:15.742331 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:15.742363 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:15.742371 | controller |
2025-10-03 14:39:15.742378 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:15.742384 | controller | Friday 03 October 2025  14:39:15 +0000 (0:00:00.133)       0:00:06.989 ********
2025-10-03 14:39:15.742393 | controller | changed: [instance]
2025-10-03 14:39:16.115743 | controller |
2025-10-03 14:39:16.115772 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:16.115780 | controller | Friday 03 October 2025  14:39:15 +0000 (0:00:00.219)       0:00:07.209 ********
2025-10-03 14:39:16.115790 | controller | changed: [instance]
2025-10-03 14:39:16.359191 | controller |
2025-10-03 14:39:16.359222 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:16.359230 | controller | Friday 03 October 2025  14:39:16 +0000 (0:00:00.373)       0:00:07.583 ********
2025-10-03 14:39:16.359241 | controller | changed: [instance] => (item=network-values)
2025-10-03 14:39:16.407046 | controller |
2025-10-03 14:39:16.407078 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:39:16.407096 | controller | Friday 03 October 2025  14:39:16 +0000 (0:00:00.243)       0:00:07.826 ********
2025-10-03 14:39:16.407129 | controller | skipping: [instance]
2025-10-03 14:39:16.875144 | controller |
2025-10-03 14:39:16.875175 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:16.875183 | controller | Friday 03 October 2025  14:39:16 +0000 (0:00:00.047)       0:00:07.874 ********
2025-10-03 14:39:16.875193 | controller | changed: [instance]
2025-10-03 14:39:17.235619 | controller |
2025-10-03 14:39:17.235663 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:39:17.235672 | controller | Friday 03 October 2025  14:39:16 +0000 (0:00:00.468)       0:00:08.342 ********
2025-10-03 14:39:17.235683 | controller | changed: [instance]
2025-10-03 14:39:17.455615 | controller |
2025-10-03 14:39:17.455655 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:17.455664 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.360)       0:00:08.702 ********
2025-10-03 14:39:17.455675 | controller | changed: [instance]
2025-10-03 14:39:17.501214 | controller |
2025-10-03 14:39:17.501251 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:39:17.501262 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.220)       0:00:08.923 ********
2025-10-03 14:39:17.501275 | controller | skipping: [instance]
2025-10-03 14:39:17.501311 | controller |
2025-10-03 14:39:17.501322 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:17.501405 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.045)       0:00:08.968 ********
2025-10-03 14:39:17.546866 | controller | skipping: [instance]
2025-10-03 14:39:17.592953 | controller |
2025-10-03 14:39:17.592980 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:17.592989 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.045)       0:00:09.014 ********
2025-10-03 14:39:17.593001 | 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-03 14:39:17.637537 | controller | skipping: [instance]
2025-10-03 14:39:17.637558 | controller |
2025-10-03 14:39:17.637565 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:39:17.637571 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.045)       0:00:09.060 ********
2025-10-03 14:39:17.637580 | controller | skipping: [instance]
2025-10-03 14:39:17.692053 | controller |
2025-10-03 14:39:17.692079 | controller | TASK [Executing post_stage hooks for examples/va/hci/control-plane/networking/nncp] ***
2025-10-03 14:39:17.692087 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.044)       0:00:09.105 ********
2025-10-03 14:39:17.692097 | controller | skipping: [instance]
2025-10-03 14:39:17.737222 | controller |
2025-10-03 14:39:17.737246 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:17.737253 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.054)       0:00:09.159 ********
2025-10-03 14:39:17.737263 | controller | ok: [instance] => changed=false
2025-10-03 14:39:17.769049 | controller |   msg: All assertions passed
2025-10-03 14:39:17.769073 | controller |
2025-10-03 14:39:17.769081 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:17.769087 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.045)       0:00:09.204 ********
2025-10-03 14:39:17.769117 | controller | skipping: [instance]
2025-10-03 14:39:17.794893 | controller |
2025-10-03 14:39:17.794916 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:17.794923 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.032)       0:00:09.236 ********
2025-10-03 14:39:17.794933 | controller | ok: [instance] => (item=oc -n metallb-system wait pod -l app=metallb -l component=speaker --for condition=Ready --timeout=5m)
2025-10-03 14:39:17.815024 | controller |
2025-10-03 14:39:17.815211 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:17.815225 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.025)       0:00:09.262 ********
2025-10-03 14:39:17.815235 | controller | skipping: [instance]
2025-10-03 14:39:17.850242 | controller |
2025-10-03 14:39:17.850280 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:17.850290 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.020)       0:00:09.282 ********
2025-10-03 14:39:17.850302 | controller | ok: [instance]
2025-10-03 14:39:18.065797 | controller |
2025-10-03 14:39:18.065825 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:18.065833 | controller | Friday 03 October 2025  14:39:17 +0000 (0:00:00.035)       0:00:09.317 ********
2025-10-03 14:39:18.065843 | controller | ok: [instance] => (item={'name': 'network-values', 'src_file': 'nncp/values.yaml'})
2025-10-03 14:39:18.129195 | controller |
2025-10-03 14:39:18.129229 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:18.129238 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.215)       0:00:09.533 ********
2025-10-03 14:39:18.129247 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:18.129272 | controller |
2025-10-03 14:39:18.129579 | controller | TASK [Executing pre_stage hooks for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:18.176175 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.063)       0:00:09.596 ********
2025-10-03 14:39:18.176210 | controller | skipping: [instance]
2025-10-03 14:39:18.176268 | controller |
2025-10-03 14:39:18.176283 | controller | TASK [Generate values.yaml for examples/va/hci/control-plane/networking] *******
2025-10-03 14:39:18.176293 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.046)       0:00:09.643 ********
2025-10-03 14:39:18.258729 | controller |
2025-10-03 14:39:18.322842 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:18.322875 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.082)       0:00:09.726 ********
2025-10-03 14:39:18.322886 | 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-03 14:39:18.374212 | controller |
2025-10-03 14:39:18.374245 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:18.374253 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.063)       0:00:09.790 ********
2025-10-03 14:39:18.374263 | controller | ok: [instance] => changed=false
2025-10-03 14:39:18.583590 | controller |   msg: All assertions passed
2025-10-03 14:39:18.583633 | controller |
2025-10-03 14:39:18.583642 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:18.583659 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.051)       0:00:09.841 ********
2025-10-03 14:39:18.583671 | controller | ok: [instance]
2025-10-03 14:39:18.637185 | controller |
2025-10-03 14:39:18.637211 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:18.637219 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.209)       0:00:10.051 ********
2025-10-03 14:39:18.637229 | controller | ok: [instance] => changed=false
2025-10-03 14:39:18.841944 | controller |   msg: All assertions passed
2025-10-03 14:39:18.841977 | controller |
2025-10-03 14:39:18.841985 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:18.841992 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.053)       0:00:10.104 ********
2025-10-03 14:39:18.842002 | controller | ok: [instance]
2025-10-03 14:39:19.123315 | controller |
2025-10-03 14:39:19.123348 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:19.123356 | controller | Friday 03 October 2025  14:39:18 +0000 (0:00:00.204)       0:00:10.309 ********
2025-10-03 14:39:19.123366 | controller | ok: [instance]
2025-10-03 14:39:19.186251 | controller |
2025-10-03 14:39:19.186285 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:19.186293 | controller | Friday 03 October 2025  14:39:19 +0000 (0:00:00.281)       0:00:10.590 ********
2025-10-03 14:39:19.186304 | 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-03 14:39:19.186318 | controller |
2025-10-03 14:39:19.186324 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-03 14:39:19.186331 | controller | Friday 03 October 2025  14:39:19 +0000 (0:00:00.062)       0:00:10.653 ********
2025-10-03 14:39:19.272241 | controller | ok: [instance] => changed=false
2025-10-03 14:39:19.272367 | controller |   msg: All assertions passed
2025-10-03 14:39:19.272399 | controller |
2025-10-03 14:39:19.272407 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:19.272429 | controller | Friday 03 October 2025  14:39:19 +0000 (0:00:00.086)       0:00:10.739 ********
2025-10-03 14:39:19.488846 | controller | ok: [instance]
2025-10-03 14:39:19.964152 | controller |
2025-10-03 14:39:19.964190 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:19.964197 | controller | Friday 03 October 2025  14:39:19 +0000 (0:00:00.216)       0:00:10.956 ********
2025-10-03 14:39:19.964207 | controller | ok: [instance]
2025-10-03 14:39:20.026014 | controller |
2025-10-03 14:39:20.026042 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:20.026050 | controller | Friday 03 October 2025  14:39:19 +0000 (0:00:00.475)       0:00:11.431 ********
2025-10-03 14:39:20.026059 | controller | ok: [instance]
2025-10-03 14:39:20.392211 | controller |
2025-10-03 14:39:20.392243 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:20.392251 | controller | Friday 03 October 2025  14:39:20 +0000 (0:00:00.061)       0:00:11.493 ********
2025-10-03 14:39:20.392261 | controller | ok: [instance]
2025-10-03 14:39:20.392460 | controller |
2025-10-03 14:39:20.392495 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:20.763749 | controller | Friday 03 October 2025  14:39:20 +0000 (0:00:00.366)       0:00:11.859 ********
2025-10-03 14:39:20.763783 | controller | ok: [instance]
2025-10-03 14:39:21.160171 | controller |
2025-10-03 14:39:21.160202 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:21.160210 | controller | Friday 03 October 2025  14:39:20 +0000 (0:00:00.371)       0:00:12.231 ********
2025-10-03 14:39:21.160220 | controller | changed: [instance]
2025-10-03 14:39:21.160376 | controller |
2025-10-03 14:39:21.160389 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:21.160397 | controller | Friday 03 October 2025  14:39:21 +0000 (0:00:00.396)       0:00:12.627 ********
2025-10-03 14:39:21.230252 | 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-03 14:39:21.230303 | controller |
2025-10-03 14:39:21.230314 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:21.230458 | controller | Friday 03 October 2025  14:39:21 +0000 (0:00:00.069)       0:00:12.697 ********
2025-10-03 14:39:21.283246 | controller | ok: [instance] => changed=false
2025-10-03 14:39:21.283943 | controller |   msg: All assertions passed
2025-10-03 14:39:21.283975 | controller |
2025-10-03 14:39:21.495494 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:21.495524 | controller | Friday 03 October 2025  14:39:21 +0000 (0:00:00.053)       0:00:12.750 ********
2025-10-03 14:39:21.495536 | controller | ok: [instance]
2025-10-03 14:39:21.544824 | controller |
2025-10-03 14:39:21.544849 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:21.544858 | controller | Friday 03 October 2025  14:39:21 +0000 (0:00:00.212)       0:00:12.962 ********
2025-10-03 14:39:21.544869 | controller | ok: [instance]
2025-10-03 14:39:22.129998 | controller |
2025-10-03 14:39:22.130030 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:22.130038 | controller | Friday 03 October 2025  14:39:21 +0000 (0:00:00.049)       0:00:13.012 ********
2025-10-03 14:39:22.130048 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-03 14:39:22.264960 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-03 14:39:22.265000 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-03 14:39:22.265008 | controller |
2025-10-03 14:39:22.265014 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:22.265020 | controller | Friday 03 October 2025  14:39:22 +0000 (0:00:00.584)       0:00:13.597 ********
2025-10-03 14:39:22.265030 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-03 14:39:22.480447 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:22.480477 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:22.480485 | controller |
2025-10-03 14:39:22.480491 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:22.480497 | controller | Friday 03 October 2025  14:39:22 +0000 (0:00:00.134)       0:00:13.732 ********
2025-10-03 14:39:22.480507 | controller | ok: [instance]
2025-10-03 14:39:22.857586 | controller |
2025-10-03 14:39:22.857616 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:22.857624 | controller | Friday 03 October 2025  14:39:22 +0000 (0:00:00.215)       0:00:13.947 ********
2025-10-03 14:39:22.857634 | controller | ok: [instance]
2025-10-03 14:39:23.091849 | controller |
2025-10-03 14:39:23.091877 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:23.091885 | controller | Friday 03 October 2025  14:39:22 +0000 (0:00:00.377)       0:00:14.325 ********
2025-10-03 14:39:23.091895 | controller | ok: [instance] => (item=network-values)
2025-10-03 14:39:23.140074 | controller |
2025-10-03 14:39:23.140126 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:39:23.140138 | controller | Friday 03 October 2025  14:39:23 +0000 (0:00:00.234)       0:00:14.559 ********
2025-10-03 14:39:23.140150 | controller | skipping: [instance]
2025-10-03 14:39:23.523603 | controller |
2025-10-03 14:39:23.523632 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:23.523640 | controller | Friday 03 October 2025  14:39:23 +0000 (0:00:00.048)       0:00:14.607 ********
2025-10-03 14:39:23.523666 | controller | changed: [instance]
2025-10-03 14:39:23.891198 | controller |
2025-10-03 14:39:23.891229 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:39:23.891237 | controller | Friday 03 October 2025  14:39:23 +0000 (0:00:00.383)       0:00:14.991 ********
2025-10-03 14:39:23.891247 | controller | changed: [instance]
2025-10-03 14:39:23.891270 | controller |
2025-10-03 14:39:23.891276 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:23.891284 | controller | Friday 03 October 2025  14:39:23 +0000 (0:00:00.367)       0:00:15.358 ********
2025-10-03 14:39:24.121534 | controller | changed: [instance]
2025-10-03 14:39:24.121600 | controller |
2025-10-03 14:39:24.121870 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:39:24.169207 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.230)       0:00:15.589 ********
2025-10-03 14:39:24.169248 | controller | skipping: [instance]
2025-10-03 14:39:24.169279 | controller |
2025-10-03 14:39:24.169562 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:24.217147 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.047)       0:00:15.636 ********
2025-10-03 14:39:24.217181 | controller | skipping: [instance]
2025-10-03 14:39:24.266421 | controller |
2025-10-03 14:39:24.266450 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:24.266457 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.047)       0:00:15.684 ********
2025-10-03 14:39:24.266467 | controller | skipping: [instance] => (item=oc -n metallb-system wait pod -l app=metallb -l component=speaker --for condition=Ready --timeout=5m)
2025-10-03 14:39:24.312468 | controller | skipping: [instance]
2025-10-03 14:39:24.312496 | controller |
2025-10-03 14:39:24.312503 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:39:24.312509 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.049)       0:00:15.733 ********
2025-10-03 14:39:24.312524 | controller | skipping: [instance]
2025-10-03 14:39:24.362188 | controller |
2025-10-03 14:39:24.362215 | controller | TASK [Executing post_stage hooks for examples/va/hci/control-plane/networking] ***
2025-10-03 14:39:24.362223 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.046)       0:00:15.779 ********
2025-10-03 14:39:24.362233 | controller | skipping: [instance]
2025-10-03 14:39:24.362256 | controller |
2025-10-03 14:39:24.362495 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:24.407220 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.050)       0:00:15.829 ********
2025-10-03 14:39:24.407249 | controller | ok: [instance] => changed=false
2025-10-03 14:39:24.440423 | controller |   msg: All assertions passed
2025-10-03 14:39:24.440448 | controller |
2025-10-03 14:39:24.440456 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:24.440462 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.044)       0:00:15.874 ********
2025-10-03 14:39:24.440473 | controller | skipping: [instance]
2025-10-03 14:39:24.469600 | controller |
2025-10-03 14:39:24.469628 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:24.469636 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.033)       0:00:15.907 ********
2025-10-03 14:39:24.469646 | controller | ok: [instance] => (item=oc -n openstack wait osctlplane controlplane --for condition=Ready --timeout=60m)
2025-10-03 14:39:24.490211 | controller |
2025-10-03 14:39:24.490250 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:24.490260 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.029)       0:00:15.937 ********
2025-10-03 14:39:24.490272 | controller | skipping: [instance]
2025-10-03 14:39:24.490302 | controller |
2025-10-03 14:39:24.490475 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:24.527741 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.021)       0:00:15.958 ********
2025-10-03 14:39:24.527777 | controller | ok: [instance]
2025-10-03 14:39:24.938549 | controller |
2025-10-03 14:39:24.938579 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:24.938587 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.037)       0:00:15.995 ********
2025-10-03 14:39:24.938598 | controller | ok: [instance] => (item={'name': 'service-values', 'src_file': 'service-values.yaml'})
2025-10-03 14:39:25.031198 | controller | ok: [instance] => (item={'name': 'network-values', 'src_file': 'networking/nncp/values.yaml'})
2025-10-03 14:39:25.031234 | controller |
2025-10-03 14:39:25.031241 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:25.031247 | controller | Friday 03 October 2025  14:39:24 +0000 (0:00:00.410)       0:00:16.405 ********
2025-10-03 14:39:25.031257 | controller | ok: [instance] => (item=service-values.yaml)
2025-10-03 14:39:25.100853 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:25.100884 | controller |
2025-10-03 14:39:25.100892 | controller | TASK [Executing pre_stage hooks for examples/va/hci/control-plane] *************
2025-10-03 14:39:25.100898 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.092)       0:00:16.498 ********
2025-10-03 14:39:25.100908 | controller | skipping: [instance]
2025-10-03 14:39:25.241248 | controller |
2025-10-03 14:39:25.241287 | controller | TASK [Generate values.yaml for examples/va/hci/control-plane] ******************
2025-10-03 14:39:25.241304 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.069)       0:00:16.568 ********
2025-10-03 14:39:25.241317 | controller |
2025-10-03 14:39:25.241348 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:25.241358 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.140)       0:00:16.708 ********
2025-10-03 14:39:25.306243 | 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-03 14:39:25.359864 | controller |
2025-10-03 14:39:25.359897 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:25.359905 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.064)       0:00:16.773 ********
2025-10-03 14:39:25.359919 | controller | ok: [instance] => changed=false
2025-10-03 14:39:25.570390 | controller |   msg: All assertions passed
2025-10-03 14:39:25.570420 | controller |
2025-10-03 14:39:25.570428 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:25.570434 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.053)       0:00:16.827 ********
2025-10-03 14:39:25.570444 | controller | ok: [instance]
2025-10-03 14:39:25.623204 | controller |
2025-10-03 14:39:25.623236 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:25.623244 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.210)       0:00:17.037 ********
2025-10-03 14:39:25.623254 | controller | ok: [instance] => changed=false
2025-10-03 14:39:25.829524 | controller |   msg: All assertions passed
2025-10-03 14:39:25.829555 | controller |
2025-10-03 14:39:25.829564 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:25.829570 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.052)       0:00:17.090 ********
2025-10-03 14:39:25.829580 | controller | ok: [instance]
2025-10-03 14:39:26.005405 | controller |
2025-10-03 14:39:26.005438 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:26.005446 | controller | Friday 03 October 2025  14:39:25 +0000 (0:00:00.206)       0:00:17.296 ********
2025-10-03 14:39:26.005457 | controller | ok: [instance]
2025-10-03 14:39:26.057226 | controller |
2025-10-03 14:39:26.057262 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:26.057272 | controller | Friday 03 October 2025  14:39:26 +0000 (0:00:00.175)       0:00:17.472 ********
2025-10-03 14:39:26.057284 | controller | skipping: [instance]
2025-10-03 14:39:26.057378 | controller |
2025-10-03 14:39:26.057408 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:26.057421 | controller | Friday 03 October 2025  14:39:26 +0000 (0:00:00.051)       0:00:17.524 ********
2025-10-03 14:39:26.275409 | controller | changed: [instance]
2025-10-03 14:39:26.332962 | controller |
2025-10-03 14:39:26.332991 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:26.332999 | controller | Friday 03 October 2025  14:39:26 +0000 (0:00:00.218)       0:00:17.742 ********
2025-10-03 14:39:26.333009 | controller | skipping: [instance]
2025-10-03 14:39:26.395235 | controller |
2025-10-03 14:39:26.395269 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:26.395279 | controller | Friday 03 October 2025  14:39:26 +0000 (0:00:00.057)       0:00:17.800 ********
2025-10-03 14:39:26.395291 | controller | ok: [instance]
2025-10-03 14:39:26.748254 | controller |
2025-10-03 14:39:26.748284 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:26.748291 | controller | Friday 03 October 2025  14:39:26 +0000 (0:00:00.062)       0:00:17.862 ********
2025-10-03 14:39:26.748301 | controller | changed: [instance]
2025-10-03 14:39:27.104510 | controller |
2025-10-03 14:39:27.104538 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:27.104546 | controller | Friday 03 October 2025  14:39:26 +0000 (0:00:00.353)       0:00:18.215 ********
2025-10-03 14:39:27.104556 | controller | changed: [instance]
2025-10-03 14:39:27.468511 | controller |
2025-10-03 14:39:27.468540 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:27.468548 | controller | Friday 03 October 2025  14:39:27 +0000 (0:00:00.356)       0:00:18.571 ********
2025-10-03 14:39:27.468558 | controller | changed: [instance]
2025-10-03 14:39:27.533191 | controller |
2025-10-03 14:39:27.533259 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:27.533268 | controller | Friday 03 October 2025  14:39:27 +0000 (0:00:00.363)       0:00:18.935 ********
2025-10-03 14:39:27.533281 | 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-03 14:39:27.585400 | controller |
2025-10-03 14:39:27.585431 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:27.585439 | controller | Friday 03 October 2025  14:39:27 +0000 (0:00:00.064)       0:00:19.000 ********
2025-10-03 14:39:27.585457 | controller | ok: [instance] => changed=false
2025-10-03 14:39:27.805623 | controller |   msg: All assertions passed
2025-10-03 14:39:27.805653 | controller |
2025-10-03 14:39:27.805673 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:27.805686 | controller | Friday 03 October 2025  14:39:27 +0000 (0:00:00.052)       0:00:19.052 ********
2025-10-03 14:39:27.805696 | controller | ok: [instance]
2025-10-03 14:39:27.855864 | controller |
2025-10-03 14:39:27.855892 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:27.855900 | controller | Friday 03 October 2025  14:39:27 +0000 (0:00:00.220)       0:00:19.272 ********
2025-10-03 14:39:27.855910 | controller | ok: [instance]
2025-10-03 14:39:28.266600 | controller |
2025-10-03 14:39:28.266630 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:28.266638 | controller | Friday 03 October 2025  14:39:27 +0000 (0:00:00.050)       0:00:19.323 ********
2025-10-03 14:39:28.266648 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/03_user_data_b64.yaml)
2025-10-03 14:39:28.359135 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/04_user_data.yaml)
2025-10-03 14:39:28.359166 | controller |
2025-10-03 14:39:28.359175 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:28.359181 | controller | Friday 03 October 2025  14:39:28 +0000 (0:00:00.410)       0:00:19.733 ********
2025-10-03 14:39:28.359190 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:28.580198 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:28.580237 | controller |
2025-10-03 14:39:28.580245 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:28.580252 | controller | Friday 03 October 2025  14:39:28 +0000 (0:00:00.092)       0:00:19.826 ********
2025-10-03 14:39:28.580263 | controller | changed: [instance]
2025-10-03 14:39:28.957228 | controller |
2025-10-03 14:39:28.957260 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:28.957268 | controller | Friday 03 October 2025  14:39:28 +0000 (0:00:00.221)       0:00:20.047 ********
2025-10-03 14:39:28.957278 | controller | changed: [instance]
2025-10-03 14:39:29.021796 | controller |
2025-10-03 14:39:29.021831 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:29.021839 | controller | Friday 03 October 2025  14:39:28 +0000 (0:00:00.376)       0:00:20.424 ********
2025-10-03 14:39:29.021849 | 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-03 14:39:29.073191 | controller |
2025-10-03 14:39:29.073222 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:29.073230 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.064)       0:00:20.489 ********
2025-10-03 14:39:29.073239 | controller | ok: [instance] => changed=false
2025-10-03 14:39:29.073519 | controller |   msg: All assertions passed
2025-10-03 14:39:29.073531 | controller |
2025-10-03 14:39:29.073540 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:29.284994 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.051)       0:00:20.540 ********
2025-10-03 14:39:29.285031 | controller | ok: [instance]
2025-10-03 14:39:29.338814 | controller |
2025-10-03 14:39:29.338848 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:29.338856 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.211)       0:00:20.752 ********
2025-10-03 14:39:29.338866 | controller | ok: [instance] => changed=false
2025-10-03 14:39:29.559182 | controller |   msg: All assertions passed
2025-10-03 14:39:29.559215 | controller |
2025-10-03 14:39:29.559231 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:29.559237 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.053)       0:00:20.805 ********
2025-10-03 14:39:29.559248 | controller | ok: [instance]
2025-10-03 14:39:29.559267 | controller |
2025-10-03 14:39:29.559520 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:29.845644 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.220)       0:00:21.026 ********
2025-10-03 14:39:29.845694 | controller | ok: [instance]
2025-10-03 14:39:29.908868 | controller |
2025-10-03 14:39:29.908893 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:29.908901 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.286)       0:00:21.312 ********
2025-10-03 14:39:29.908911 | 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-03 14:39:29.960517 | controller |
2025-10-03 14:39:29.960546 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] **************
2025-10-03 14:39:29.960553 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.063)       0:00:21.376 ********
2025-10-03 14:39:29.960564 | controller | ok: [instance] => changed=false
2025-10-03 14:39:30.176986 | controller |   msg: All assertions passed
2025-10-03 14:39:30.177017 | controller |
2025-10-03 14:39:30.177025 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:30.177031 | controller | Friday 03 October 2025  14:39:29 +0000 (0:00:00.051)       0:00:21.427 ********
2025-10-03 14:39:30.177040 | controller | ok: [instance]
2025-10-03 14:39:30.676778 | controller |
2025-10-03 14:39:30.676806 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:30.676814 | controller | Friday 03 October 2025  14:39:30 +0000 (0:00:00.216)       0:00:21.644 ********
2025-10-03 14:39:30.676825 | controller | ok: [instance]
2025-10-03 14:39:30.740170 | controller |
2025-10-03 14:39:30.740194 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:30.740209 | controller | Friday 03 October 2025  14:39:30 +0000 (0:00:00.499)       0:00:22.144 ********
2025-10-03 14:39:30.740221 | controller | ok: [instance]
2025-10-03 14:39:30.740628 | controller |
2025-10-03 14:39:31.105173 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:31.105201 | controller | Friday 03 October 2025  14:39:30 +0000 (0:00:00.063)       0:00:22.208 ********
2025-10-03 14:39:31.105213 | controller | ok: [instance]
2025-10-03 14:39:31.105580 | controller |
2025-10-03 14:39:31.476186 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:31.476215 | controller | Friday 03 October 2025  14:39:31 +0000 (0:00:00.364)       0:00:22.572 ********
2025-10-03 14:39:31.476226 | controller | ok: [instance]
2025-10-03 14:39:31.842716 | controller |
2025-10-03 14:39:31.842745 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:31.842753 | controller | Friday 03 October 2025  14:39:31 +0000 (0:00:00.370)       0:00:22.943 ********
2025-10-03 14:39:31.842763 | controller | ok: [instance]
2025-10-03 14:39:31.905649 | controller |
2025-10-03 14:39:31.905689 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:31.905697 | controller | Friday 03 October 2025  14:39:31 +0000 (0:00:00.366)       0:00:23.310 ********
2025-10-03 14:39:31.905708 | 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-03 14:39:31.953959 | controller |
2025-10-03 14:39:31.953981 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:31.953989 | controller | Friday 03 October 2025  14:39:31 +0000 (0:00:00.063)       0:00:23.373 ********
2025-10-03 14:39:31.953999 | controller | ok: [instance] => changed=false
2025-10-03 14:39:32.157792 | controller |   msg: All assertions passed
2025-10-03 14:39:32.157822 | controller |
2025-10-03 14:39:32.157830 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:32.157837 | controller | Friday 03 October 2025  14:39:31 +0000 (0:00:00.048)       0:00:23.421 ********
2025-10-03 14:39:32.157847 | controller | ok: [instance]
2025-10-03 14:39:32.204182 | controller |
2025-10-03 14:39:32.204213 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:32.204223 | controller | Friday 03 October 2025  14:39:32 +0000 (0:00:00.203)       0:00:23.625 ********
2025-10-03 14:39:32.204242 | controller | ok: [instance]
2025-10-03 14:39:32.204272 | controller |
2025-10-03 14:39:32.204480 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:32.762569 | controller | Friday 03 October 2025  14:39:32 +0000 (0:00:00.046)       0:00:23.672 ********
2025-10-03 14:39:32.762606 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml)
2025-10-03 14:39:32.894017 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml)
2025-10-03 14:39:32.894047 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml)
2025-10-03 14:39:32.894054 | controller |
2025-10-03 14:39:32.894060 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:32.894066 | controller | Friday 03 October 2025  14:39:32 +0000 (0:00:00.557)       0:00:24.229 ********
2025-10-03 14:39:32.894076 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-03 14:39:33.104173 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:33.104203 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:33.104211 | controller |
2025-10-03 14:39:33.104217 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:33.104223 | controller | Friday 03 October 2025  14:39:32 +0000 (0:00:00.131)       0:00:24.361 ********
2025-10-03 14:39:33.104233 | controller | ok: [instance]
2025-10-03 14:39:33.479985 | controller |
2025-10-03 14:39:33.480014 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:33.480022 | controller | Friday 03 October 2025  14:39:33 +0000 (0:00:00.210)       0:00:24.571 ********
2025-10-03 14:39:33.480032 | controller | ok: [instance]
2025-10-03 14:39:33.947725 | controller |
2025-10-03 14:39:33.947754 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/control-plane] ***
2025-10-03 14:39:33.947762 | controller | Friday 03 October 2025  14:39:33 +0000 (0:00:00.375)       0:00:24.947 ********
2025-10-03 14:39:33.947772 | controller | changed: [instance] => (item=service-values)
2025-10-03 14:39:33.994182 | controller | ok: [instance] => (item=network-values)
2025-10-03 14:39:33.994213 | controller |
2025-10-03 14:39:33.994221 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:39:33.994228 | controller | Friday 03 October 2025  14:39:33 +0000 (0:00:00.467)       0:00:25.415 ********
2025-10-03 14:39:33.994238 | controller | skipping: [instance]
2025-10-03 14:39:33.994262 | controller |
2025-10-03 14:39:33.994529 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/control-plane] ***
2025-10-03 14:39:34.315757 | controller | Friday 03 October 2025  14:39:33 +0000 (0:00:00.046)       0:00:25.462 ********
2025-10-03 14:39:34.315792 | controller | changed: [instance]
2025-10-03 14:39:34.685068 | controller |
2025-10-03 14:39:34.685099 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:39:34.685126 | controller | Friday 03 October 2025  14:39:34 +0000 (0:00:00.321)       0:00:25.783 ********
2025-10-03 14:39:34.685142 | controller | changed: [instance]
2025-10-03 14:39:34.909921 | controller |
2025-10-03 14:39:34.909955 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/control-plane] ***
2025-10-03 14:39:34.909963 | controller | Friday 03 October 2025  14:39:34 +0000 (0:00:00.369)       0:00:26.152 ********
2025-10-03 14:39:34.909973 | controller | changed: [instance]
2025-10-03 14:39:34.959553 | controller |
2025-10-03 14:39:34.959586 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:39:34.959594 | controller | Friday 03 October 2025  14:39:34 +0000 (0:00:00.224)       0:00:26.377 ********
2025-10-03 14:39:34.959604 | controller | skipping: [instance]
2025-10-03 14:39:35.009230 | controller |
2025-10-03 14:39:35.009258 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/control-plane] ***
2025-10-03 14:39:35.009266 | controller | Friday 03 October 2025  14:39:34 +0000 (0:00:00.049)       0:00:26.427 ********
2025-10-03 14:39:35.009276 | controller | skipping: [instance]
2025-10-03 14:39:35.060262 | controller |
2025-10-03 14:39:35.060305 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/control-plane] ***
2025-10-03 14:39:35.060335 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.049)       0:00:26.476 ********
2025-10-03 14:39:35.060347 | controller | skipping: [instance] => (item=oc -n openstack wait osctlplane controlplane --for condition=Ready --timeout=60m)
2025-10-03 14:39:35.060367 | controller | skipping: [instance]
2025-10-03 14:39:35.060373 | controller |
2025-10-03 14:39:35.060381 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:39:35.107564 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.050)       0:00:26.527 ********
2025-10-03 14:39:35.107602 | controller | skipping: [instance]
2025-10-03 14:39:35.162041 | controller |
2025-10-03 14:39:35.162069 | controller | TASK [Executing post_stage hooks for examples/va/hci/control-plane] ************
2025-10-03 14:39:35.162077 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.047)       0:00:26.575 ********
2025-10-03 14:39:35.162087 | controller | skipping: [instance]
2025-10-03 14:39:35.208774 | controller |
2025-10-03 14:39:35.208800 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:35.208809 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.054)       0:00:26.629 ********
2025-10-03 14:39:35.208820 | controller | ok: [instance] => changed=false
2025-10-03 14:39:35.242467 | controller |   msg: All assertions passed
2025-10-03 14:39:35.242491 | controller |
2025-10-03 14:39:35.242499 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:35.242507 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.046)       0:00:26.676 ********
2025-10-03 14:39:35.242517 | controller | skipping: [instance]
2025-10-03 14:39:35.242700 | controller |
2025-10-03 14:39:35.242891 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:35.243045 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.034)       0:00:26.710 ********
2025-10-03 14:39:35.270889 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-03 14:39:35.271088 | controller |
2025-10-03 14:39:35.271270 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:35.271415 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.028)       0:00:26.738 ********
2025-10-03 14:39:35.294250 | controller | skipping: [instance]
2025-10-03 14:39:35.294315 | controller |
2025-10-03 14:39:35.294324 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:35.294333 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.023)       0:00:26.761 ********
2025-10-03 14:39:35.332073 | controller | ok: [instance]
2025-10-03 14:39:35.556949 | controller |
2025-10-03 14:39:35.556980 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:35.556988 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.037)       0:00:26.799 ********
2025-10-03 14:39:35.556998 | controller | ok: [instance] => (item={'name': 'edpm-nodeset-values', 'src_file': 'values.yaml'})
2025-10-03 14:39:35.624481 | controller |
2025-10-03 14:39:35.624511 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:35.624519 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.224)       0:00:27.024 ********
2025-10-03 14:39:35.624530 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:35.696735 | controller |
2025-10-03 14:39:35.696769 | controller | TASK [Executing pre_stage hooks for examples/va/hci/edpm-pre-ceph/nodeset] *****
2025-10-03 14:39:35.696779 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.067)       0:00:27.091 ********
2025-10-03 14:39:35.696791 | controller | skipping: [instance]
2025-10-03 14:39:35.780846 | controller |
2025-10-03 14:39:35.780927 | controller | TASK [Generate values.yaml for examples/va/hci/edpm-pre-ceph/nodeset] **********
2025-10-03 14:39:35.780937 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.072)       0:00:27.164 ********
2025-10-03 14:39:35.780951 | controller |
2025-10-03 14:39:35.870823 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:35.870884 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.083)       0:00:27.247 ********
2025-10-03 14:39:35.870900 | 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-03 14:39:35.871097 | controller |
2025-10-03 14:39:35.871305 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:35.871456 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.090)       0:00:27.338 ********
2025-10-03 14:39:35.924897 | controller | ok: [instance] => changed=false
2025-10-03 14:39:35.925147 | controller |   msg: All assertions passed
2025-10-03 14:39:35.925301 | controller |
2025-10-03 14:39:35.925447 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:35.925590 | controller | Friday 03 October 2025  14:39:35 +0000 (0:00:00.054)       0:00:27.392 ********
2025-10-03 14:39:36.163215 | controller | ok: [instance]
2025-10-03 14:39:36.163274 | controller |
2025-10-03 14:39:36.163285 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:36.163364 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.237)       0:00:27.630 ********
2025-10-03 14:39:36.219218 | controller | ok: [instance] => changed=false
2025-10-03 14:39:36.219277 | controller |   msg: All assertions passed
2025-10-03 14:39:36.219681 | controller |
2025-10-03 14:39:36.441375 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:36.441405 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.056)       0:00:27.686 ********
2025-10-03 14:39:36.441417 | controller | ok: [instance]
2025-10-03 14:39:36.679727 | controller |
2025-10-03 14:39:36.679759 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:36.679767 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.222)       0:00:27.908 ********
2025-10-03 14:39:36.679777 | controller | ok: [instance]
2025-10-03 14:39:36.747932 | controller |
2025-10-03 14:39:36.747958 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:36.747966 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.238)       0:00:28.147 ********
2025-10-03 14:39:36.747976 | 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-03 14:39:36.819003 | controller |
2025-10-03 14:39:36.819027 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] ***
2025-10-03 14:39:36.819035 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.068)       0:00:28.215 ********
2025-10-03 14:39:36.819044 | 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-03 14:39:36.866177 | controller |
2025-10-03 14:39:36.866201 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] ***
2025-10-03 14:39:36.866209 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.071)       0:00:28.286 ********
2025-10-03 14:39:36.866222 | controller | ok: [instance] => changed=false
2025-10-03 14:39:36.866244 | controller |   msg: All assertions passed
2025-10-03 14:39:36.866252 | controller |
2025-10-03 14:39:36.866440 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ******
2025-10-03 14:39:36.918257 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.047)       0:00:28.333 ********
2025-10-03 14:39:36.918284 | 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-03 14:39:36.918459 | controller |
2025-10-03 14:39:36.918639 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] ***
2025-10-03 14:39:36.918822 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.052)       0:00:28.386 ********
2025-10-03 14:39:36.955648 | controller | skipping: [instance]
2025-10-03 14:39:36.955814 | controller |
2025-10-03 14:39:36.955959 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ********
2025-10-03 14:39:36.956116 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.037)       0:00:28.423 ********
2025-10-03 14:39:36.995382 | controller | ok: [instance]
2025-10-03 14:39:36.995565 | controller |
2025-10-03 14:39:36.995771 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] ***
2025-10-03 14:39:36.995952 | controller | Friday 03 October 2025  14:39:36 +0000 (0:00:00.039)       0:00:28.463 ********
2025-10-03 14:39:37.038612 | controller | ok: [instance] => changed=false
2025-10-03 14:39:37.038827 | controller |   msg: All assertions passed
2025-10-03 14:39:37.038989 | controller |
2025-10-03 14:39:37.039186 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:37.039358 | controller | Friday 03 October 2025  14:39:37 +0000 (0:00:00.043)       0:00:28.506 ********
2025-10-03 14:39:37.245288 | controller | changed: [instance]
2025-10-03 14:39:37.660219 | controller |
2025-10-03 14:39:37.660250 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:37.660258 | controller | Friday 03 October 2025  14:39:37 +0000 (0:00:00.206)       0:00:28.712 ********
2025-10-03 14:39:37.660268 | controller | changed: [instance]
2025-10-03 14:39:37.712906 | controller |
2025-10-03 14:39:37.712938 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:37.712946 | controller | Friday 03 October 2025  14:39:37 +0000 (0:00:00.414)       0:00:29.127 ********
2025-10-03 14:39:37.712956 | controller | ok: [instance]
2025-10-03 14:39:38.069157 | controller |
2025-10-03 14:39:38.069188 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:38.069196 | controller | Friday 03 October 2025  14:39:37 +0000 (0:00:00.052)       0:00:29.180 ********
2025-10-03 14:39:38.069206 | controller | changed: [instance]
2025-10-03 14:39:38.427033 | controller |
2025-10-03 14:39:38.427064 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:38.427072 | controller | Friday 03 October 2025  14:39:38 +0000 (0:00:00.355)       0:00:29.536 ********
2025-10-03 14:39:38.427087 | controller | changed: [instance]
2025-10-03 14:39:38.786186 | controller |
2025-10-03 14:39:38.786223 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:38.786231 | controller | Friday 03 October 2025  14:39:38 +0000 (0:00:00.358)       0:00:29.894 ********
2025-10-03 14:39:38.786242 | controller | changed: [instance]
2025-10-03 14:39:38.786267 | controller |
2025-10-03 14:39:38.786529 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:38.840845 | controller | Friday 03 October 2025  14:39:38 +0000 (0:00:00.359)       0:00:30.253 ********
2025-10-03 14:39:38.840882 | 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-03 14:39:38.881328 | controller |
2025-10-03 14:39:38.881350 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:38.881359 | controller | Friday 03 October 2025  14:39:38 +0000 (0:00:00.054)       0:00:30.308 ********
2025-10-03 14:39:38.881370 | controller | ok: [instance] => changed=false
2025-10-03 14:39:39.085781 | controller |   msg: All assertions passed
2025-10-03 14:39:39.085812 | controller |
2025-10-03 14:39:39.085820 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:39.085826 | controller | Friday 03 October 2025  14:39:38 +0000 (0:00:00.040)       0:00:30.348 ********
2025-10-03 14:39:39.085836 | controller | ok: [instance]
2025-10-03 14:39:39.126162 | controller |
2025-10-03 14:39:39.126194 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:39.126202 | controller | Friday 03 October 2025  14:39:39 +0000 (0:00:00.204)       0:00:30.553 ********
2025-10-03 14:39:39.126212 | controller | ok: [instance]
2025-10-03 14:39:39.702319 | controller |
2025-10-03 14:39:39.702350 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:39.702358 | controller | Friday 03 October 2025  14:39:39 +0000 (0:00:00.040)       0:00:30.593 ********
2025-10-03 14:39:39.702368 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml)
2025-10-03 14:39:39.822982 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml)
2025-10-03 14:39:39.823012 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml)
2025-10-03 14:39:39.823025 | controller |
2025-10-03 14:39:39.823032 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:39.823038 | controller | Friday 03 October 2025  14:39:39 +0000 (0:00:00.575)       0:00:31.169 ********
2025-10-03 14:39:39.823047 | controller | ok: [instance] => (item=02_ci_data.yaml)
2025-10-03 14:39:40.030927 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:40.030959 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:40.030967 | controller |
2025-10-03 14:39:40.030973 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:40.030979 | controller | Friday 03 October 2025  14:39:39 +0000 (0:00:00.120)       0:00:31.290 ********
2025-10-03 14:39:40.030988 | controller | changed: [instance]
2025-10-03 14:39:40.388526 | controller |
2025-10-03 14:39:40.388555 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:40.388563 | controller | Friday 03 October 2025  14:39:40 +0000 (0:00:00.208)       0:00:31.498 ********
2025-10-03 14:39:40.388573 | controller | changed: [instance]
2025-10-03 14:39:40.624751 | controller |
2025-10-03 14:39:40.624781 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-03 14:39:40.624788 | controller | Friday 03 October 2025  14:39:40 +0000 (0:00:00.357)       0:00:31.855 ********
2025-10-03 14:39:40.624799 | controller | changed: [instance] => (item=edpm-nodeset-values)
2025-10-03 14:39:40.663216 | controller |
2025-10-03 14:39:40.663253 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:39:40.663262 | controller | Friday 03 October 2025  14:39:40 +0000 (0:00:00.236)       0:00:32.092 ********
2025-10-03 14:39:40.663276 | controller | skipping: [instance]
2025-10-03 14:39:40.663453 | controller |
2025-10-03 14:39:40.663481 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-03 14:39:40.959127 | controller | Friday 03 October 2025  14:39:40 +0000 (0:00:00.038)       0:00:32.130 ********
2025-10-03 14:39:40.959162 | controller | changed: [instance]
2025-10-03 14:39:41.316638 | controller |
2025-10-03 14:39:41.316668 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:39:41.316694 | controller | Friday 03 October 2025  14:39:40 +0000 (0:00:00.295)       0:00:32.426 ********
2025-10-03 14:39:41.316704 | controller | changed: [instance]
2025-10-03 14:39:41.528992 | controller |
2025-10-03 14:39:41.529022 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-03 14:39:41.529030 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.357)       0:00:32.784 ********
2025-10-03 14:39:41.529040 | controller | changed: [instance]
2025-10-03 14:39:41.566694 | controller |
2025-10-03 14:39:41.566722 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:39:41.566730 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.212)       0:00:32.996 ********
2025-10-03 14:39:41.566740 | controller | skipping: [instance]
2025-10-03 14:39:41.604541 | controller |
2025-10-03 14:39:41.604571 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-03 14:39:41.604579 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.037)       0:00:33.034 ********
2025-10-03 14:39:41.604589 | controller | skipping: [instance]
2025-10-03 14:39:41.644954 | controller |
2025-10-03 14:39:41.644978 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/edpm-pre-ceph/nodeset] ***
2025-10-03 14:39:41.644987 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.037)       0:00:33.072 ********
2025-10-03 14:39:41.645004 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-03 14:39:41.682752 | controller | skipping: [instance]
2025-10-03 14:39:41.682775 | controller |
2025-10-03 14:39:41.682783 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:39:41.682789 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.040)       0:00:33.112 ********
2025-10-03 14:39:41.682798 | controller | skipping: [instance]
2025-10-03 14:39:41.754274 | controller |
2025-10-03 14:39:41.754313 | controller | TASK [Executing post_stage hooks for examples/va/hci/edpm-pre-ceph/nodeset] ****
2025-10-03 14:39:41.754322 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.037)       0:00:33.150 ********
2025-10-03 14:39:41.754335 | controller | skipping: [instance]
2025-10-03 14:39:41.754368 | controller |
2025-10-03 14:39:41.754378 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:41.754404 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.071)       0:00:33.221 ********
2025-10-03 14:39:41.793649 | controller | ok: [instance] => changed=false
2025-10-03 14:39:41.817857 | controller |   msg: All assertions passed
2025-10-03 14:39:41.817876 | controller |
2025-10-03 14:39:41.817883 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:41.817890 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.039)       0:00:33.261 ********
2025-10-03 14:39:41.817898 | controller | skipping: [instance]
2025-10-03 14:39:41.847646 | controller |
2025-10-03 14:39:41.847664 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:41.847688 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.024)       0:00:33.285 ********
2025-10-03 14:39:41.847698 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=30m)
2025-10-03 14:39:41.871222 | controller |
2025-10-03 14:39:41.871257 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:41.871266 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.029)       0:00:33.315 ********
2025-10-03 14:39:41.871277 | controller | skipping: [instance]
2025-10-03 14:39:41.900713 | controller |
2025-10-03 14:39:41.900735 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:41.900743 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.023)       0:00:33.338 ********
2025-10-03 14:39:41.900752 | controller | ok: [instance]
2025-10-03 14:39:42.115212 | controller |
2025-10-03 14:39:42.115247 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:42.115254 | controller | Friday 03 October 2025  14:39:41 +0000 (0:00:00.029)       0:00:33.368 ********
2025-10-03 14:39:42.115265 | controller | ok: [instance] => (item={'name': 'edpm-deployment-values', 'src_file': 'values.yaml'})
2025-10-03 14:39:42.171568 | controller |
2025-10-03 14:39:42.171587 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:42.171595 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.214)       0:00:33.582 ********
2025-10-03 14:39:42.171603 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:42.210316 | controller |
2025-10-03 14:39:42.210335 | controller | TASK [Executing pre_stage hooks for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:42.210342 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.056)       0:00:33.639 ********
2025-10-03 14:39:42.210351 | controller | skipping: [instance]
2025-10-03 14:39:42.283144 | controller |
2025-10-03 14:39:42.283167 | controller | TASK [Generate values.yaml for examples/va/hci/edpm-pre-ceph/deployment] *******
2025-10-03 14:39:42.283177 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.038)       0:00:33.677 ********
2025-10-03 14:39:42.283191 | controller |
2025-10-03 14:39:42.338869 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:42.338891 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.072)       0:00:33.750 ********
2025-10-03 14:39:42.338904 | 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-03 14:39:42.381204 | controller |
2025-10-03 14:39:42.381245 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:42.381255 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.055)       0:00:33.806 ********
2025-10-03 14:39:42.381269 | controller | ok: [instance] => changed=false
2025-10-03 14:39:42.381450 | controller |   msg: All assertions passed
2025-10-03 14:39:42.381472 | controller |
2025-10-03 14:39:42.381482 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:42.590167 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.042)       0:00:33.848 ********
2025-10-03 14:39:42.590201 | controller | ok: [instance]
2025-10-03 14:39:42.590228 | controller |
2025-10-03 14:39:42.590237 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:42.590350 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.208)       0:00:34.057 ********
2025-10-03 14:39:42.631135 | controller | ok: [instance] => changed=false
2025-10-03 14:39:42.822178 | controller |   msg: All assertions passed
2025-10-03 14:39:42.822210 | controller |
2025-10-03 14:39:42.822218 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:42.822224 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.040)       0:00:34.098 ********
2025-10-03 14:39:42.822234 | controller | ok: [instance]
2025-10-03 14:39:42.988946 | controller |
2025-10-03 14:39:42.988981 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:42.988988 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.191)       0:00:34.289 ********
2025-10-03 14:39:42.988999 | controller | ok: [instance]
2025-10-03 14:39:43.027035 | controller |
2025-10-03 14:39:43.027060 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:43.027068 | controller | Friday 03 October 2025  14:39:42 +0000 (0:00:00.166)       0:00:34.456 ********
2025-10-03 14:39:43.027078 | controller | skipping: [instance]
2025-10-03 14:39:43.230186 | controller |
2025-10-03 14:39:43.230232 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:43.230240 | controller | Friday 03 October 2025  14:39:43 +0000 (0:00:00.038)       0:00:34.494 ********
2025-10-03 14:39:43.230251 | controller | changed: [instance]
2025-10-03 14:39:43.276406 | controller |
2025-10-03 14:39:43.276437 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:43.276444 | controller | Friday 03 October 2025  14:39:43 +0000 (0:00:00.202)       0:00:34.697 ********
2025-10-03 14:39:43.276454 | controller | skipping: [instance]
2025-10-03 14:39:43.331207 | controller |
2025-10-03 14:39:43.331239 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:43.331248 | controller | Friday 03 October 2025  14:39:43 +0000 (0:00:00.046)       0:00:34.743 ********
2025-10-03 14:39:43.331259 | controller | ok: [instance]
2025-10-03 14:39:43.686170 | controller |
2025-10-03 14:39:43.686198 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:43.686206 | controller | Friday 03 October 2025  14:39:43 +0000 (0:00:00.054)       0:00:34.798 ********
2025-10-03 14:39:43.686217 | controller | changed: [instance]
2025-10-03 14:39:43.686400 | controller |
2025-10-03 14:39:43.686433 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:44.040298 | controller | Friday 03 October 2025  14:39:43 +0000 (0:00:00.355)       0:00:35.153 ********
2025-10-03 14:39:44.040331 | controller | changed: [instance]
2025-10-03 14:39:44.411266 | controller |
2025-10-03 14:39:44.411306 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:44.411314 | controller | Friday 03 October 2025  14:39:44 +0000 (0:00:00.353)       0:00:35.507 ********
2025-10-03 14:39:44.411325 | controller | changed: [instance]
2025-10-03 14:39:44.411351 | controller |
2025-10-03 14:39:44.411557 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:44.472599 | controller | Friday 03 October 2025  14:39:44 +0000 (0:00:00.371)       0:00:35.878 ********
2025-10-03 14:39:44.472635 | 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-03 14:39:44.515769 | controller |
2025-10-03 14:39:44.515801 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:44.515809 | controller | Friday 03 October 2025  14:39:44 +0000 (0:00:00.060)       0:00:35.939 ********
2025-10-03 14:39:44.515819 | controller | ok: [instance] => changed=false
2025-10-03 14:39:44.723998 | controller |   msg: All assertions passed
2025-10-03 14:39:44.724029 | controller |
2025-10-03 14:39:44.724037 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:44.724048 | controller | Friday 03 October 2025  14:39:44 +0000 (0:00:00.042)       0:00:35.982 ********
2025-10-03 14:39:44.724058 | controller | ok: [instance]
2025-10-03 14:39:44.763982 | controller |
2025-10-03 14:39:44.764013 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:44.764021 | controller | Friday 03 October 2025  14:39:44 +0000 (0:00:00.208)       0:00:36.191 ********
2025-10-03 14:39:44.764031 | controller | ok: [instance]
2025-10-03 14:39:45.155168 | controller |
2025-10-03 14:39:45.155199 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:45.155207 | controller | Friday 03 October 2025  14:39:44 +0000 (0:00:00.039)       0:00:36.231 ********
2025-10-03 14:39:45.155217 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/03_user_data_b64.yaml)
2025-10-03 14:39:45.238955 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/04_user_data.yaml)
2025-10-03 14:39:45.238987 | controller |
2025-10-03 14:39:45.238995 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:45.239001 | controller | Friday 03 October 2025  14:39:45 +0000 (0:00:00.390)       0:00:36.622 ********
2025-10-03 14:39:45.239011 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:45.450181 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:45.450213 | controller |
2025-10-03 14:39:45.450220 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:45.450226 | controller | Friday 03 October 2025  14:39:45 +0000 (0:00:00.083)       0:00:36.706 ********
2025-10-03 14:39:45.450242 | controller | changed: [instance]
2025-10-03 14:39:45.450302 | controller |
2025-10-03 14:39:45.450311 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:45.450318 | controller | Friday 03 October 2025  14:39:45 +0000 (0:00:00.211)       0:00:36.917 ********
2025-10-03 14:39:45.815027 | controller | changed: [instance]
2025-10-03 14:39:46.049768 | controller |
2025-10-03 14:39:46.049797 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:46.049809 | controller | Friday 03 October 2025  14:39:45 +0000 (0:00:00.364)       0:00:37.282 ********
2025-10-03 14:39:46.049819 | controller | changed: [instance] => (item=edpm-deployment-values)
2025-10-03 14:39:46.088042 | controller |
2025-10-03 14:39:46.088060 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:39:46.088067 | controller | Friday 03 October 2025  14:39:46 +0000 (0:00:00.234)       0:00:37.517 ********
2025-10-03 14:39:46.088076 | controller | skipping: [instance]
2025-10-03 14:39:46.380644 | controller |
2025-10-03 14:39:46.380673 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:46.380698 | controller | Friday 03 October 2025  14:39:46 +0000 (0:00:00.038)       0:00:37.555 ********
2025-10-03 14:39:46.380708 | controller | changed: [instance]
2025-10-03 14:39:46.763231 | controller |
2025-10-03 14:39:46.763263 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:39:46.763271 | controller | Friday 03 October 2025  14:39:46 +0000 (0:00:00.292)       0:00:37.848 ********
2025-10-03 14:39:46.763280 | controller | changed: [instance]
2025-10-03 14:39:46.986881 | controller |
2025-10-03 14:39:46.986914 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:46.986922 | controller | Friday 03 October 2025  14:39:46 +0000 (0:00:00.382)       0:00:38.230 ********
2025-10-03 14:39:46.986932 | controller | changed: [instance]
2025-10-03 14:39:47.024459 | controller |
2025-10-03 14:39:47.024490 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:39:47.024498 | controller | Friday 03 October 2025  14:39:46 +0000 (0:00:00.223)       0:00:38.454 ********
2025-10-03 14:39:47.024507 | controller | skipping: [instance]
2025-10-03 14:39:47.063618 | controller |
2025-10-03 14:39:47.063649 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:47.063662 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.037)       0:00:38.491 ********
2025-10-03 14:39:47.063673 | controller | skipping: [instance]
2025-10-03 14:39:47.105649 | controller |
2025-10-03 14:39:47.105695 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:47.105703 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.039)       0:00:38.531 ********
2025-10-03 14:39:47.105713 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=30m)
2025-10-03 14:39:47.144216 | controller | skipping: [instance]
2025-10-03 14:39:47.144252 | controller |
2025-10-03 14:39:47.144262 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:39:47.144270 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.041)       0:00:38.572 ********
2025-10-03 14:39:47.144282 | controller | skipping: [instance]
2025-10-03 14:39:47.144316 | controller |
2025-10-03 14:39:47.144327 | controller | TASK [Executing post_stage hooks for examples/va/hci/edpm-pre-ceph/deployment] ***
2025-10-03 14:39:47.144459 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.039)       0:00:38.612 ********
2025-10-03 14:39:47.187711 | controller | skipping: [instance]
2025-10-03 14:39:47.224200 | controller |
2025-10-03 14:39:47.224232 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:47.224242 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.043)       0:00:38.655 ********
2025-10-03 14:39:47.224254 | controller | ok: [instance] => changed=false
2025-10-03 14:39:47.224283 | controller |   msg: All assertions passed
2025-10-03 14:39:47.224646 | controller |
2025-10-03 14:39:47.248251 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:47.248283 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.036)       0:00:38.692 ********
2025-10-03 14:39:47.248296 | controller | skipping: [instance]
2025-10-03 14:39:47.276732 | controller |
2025-10-03 14:39:47.276753 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:47.276760 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.023)       0:00:38.715 ********
2025-10-03 14:39:47.276769 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-03 14:39:47.299181 | controller |
2025-10-03 14:39:47.299203 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:47.299212 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.028)       0:00:38.744 ********
2025-10-03 14:39:47.299223 | controller | skipping: [instance]
2025-10-03 14:39:47.327191 | controller |
2025-10-03 14:39:47.327222 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:47.327230 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.022)       0:00:38.766 ********
2025-10-03 14:39:47.327240 | controller | ok: [instance]
2025-10-03 14:39:47.327430 | controller |
2025-10-03 14:39:47.327453 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:47.727201 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.028)       0:00:38.795 ********
2025-10-03 14:39:47.727237 | controller | ok: [instance] => (item={'name': 'service-values', 'src_file': 'service-values.yaml'})
2025-10-03 14:39:47.810816 | controller | ok: [instance] => (item={'name': 'edpm-nodeset-values-post-ceph', 'src_file': 'values.yaml'})
2025-10-03 14:39:47.810847 | controller |
2025-10-03 14:39:47.810855 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:47.810861 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.399)       0:00:39.194 ********
2025-10-03 14:39:47.810870 | controller | ok: [instance] => (item=service-values.yaml)
2025-10-03 14:39:47.871545 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:47.871582 | controller |
2025-10-03 14:39:47.871590 | controller | TASK [Executing pre_stage hooks for examples/va/hci] ***************************
2025-10-03 14:39:47.871596 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.083)       0:00:39.278 ********
2025-10-03 14:39:47.871605 | controller | skipping: [instance]
2025-10-03 14:39:47.985091 | controller |
2025-10-03 14:39:47.985145 | controller | TASK [Generate values.yaml for examples/va/hci] ********************************
2025-10-03 14:39:47.985162 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.061)       0:00:39.339 ********
2025-10-03 14:39:47.985172 | controller |
2025-10-03 14:39:48.042222 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:48.042261 | controller | Friday 03 October 2025  14:39:47 +0000 (0:00:00.113)       0:00:39.452 ********
2025-10-03 14:39:48.042276 | 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-03 14:39:48.042305 | controller |
2025-10-03 14:39:48.042315 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:48.042431 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.057)       0:00:39.509 ********
2025-10-03 14:39:48.085912 | controller | ok: [instance] => changed=false
2025-10-03 14:39:48.289092 | controller |   msg: All assertions passed
2025-10-03 14:39:48.289184 | controller |
2025-10-03 14:39:48.289193 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:48.289199 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.043)       0:00:39.553 ********
2025-10-03 14:39:48.289209 | controller | ok: [instance]
2025-10-03 14:39:48.333781 | controller |
2025-10-03 14:39:48.333800 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:48.333808 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.203)       0:00:39.756 ********
2025-10-03 14:39:48.333816 | controller | ok: [instance] => changed=false
2025-10-03 14:39:48.528354 | controller |   msg: All assertions passed
2025-10-03 14:39:48.528384 | controller |
2025-10-03 14:39:48.528392 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:48.528398 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.044)       0:00:39.801 ********
2025-10-03 14:39:48.528408 | controller | ok: [instance]
2025-10-03 14:39:48.726219 | controller |
2025-10-03 14:39:48.726254 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:48.726264 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.194)       0:00:39.995 ********
2025-10-03 14:39:48.726276 | controller | ok: [instance]
2025-10-03 14:39:48.726305 | controller |
2025-10-03 14:39:48.726490 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:48.766205 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.198)       0:00:40.193 ********
2025-10-03 14:39:48.766233 | controller | skipping: [instance]
2025-10-03 14:39:48.766410 | controller |
2025-10-03 14:39:48.766428 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:48.971959 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.040)       0:00:40.233 ********
2025-10-03 14:39:48.971993 | controller | ok: [instance]
2025-10-03 14:39:49.020215 | controller |
2025-10-03 14:39:49.020248 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:49.020256 | controller | Friday 03 October 2025  14:39:48 +0000 (0:00:00.205)       0:00:40.439 ********
2025-10-03 14:39:49.020266 | controller | skipping: [instance]
2025-10-03 14:39:49.020291 | controller |
2025-10-03 14:39:49.020298 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:49.020305 | controller | Friday 03 October 2025  14:39:49 +0000 (0:00:00.048)       0:00:40.487 ********
2025-10-03 14:39:49.074219 | controller | ok: [instance]
2025-10-03 14:39:49.447995 | controller |
2025-10-03 14:39:49.448024 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:49.448032 | controller | Friday 03 October 2025  14:39:49 +0000 (0:00:00.053)       0:00:40.541 ********
2025-10-03 14:39:49.448043 | controller | ok: [instance]
2025-10-03 14:39:49.814029 | controller |
2025-10-03 14:39:49.814059 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:49.814067 | controller | Friday 03 October 2025  14:39:49 +0000 (0:00:00.373)       0:00:40.915 ********
2025-10-03 14:39:49.814077 | controller | ok: [instance]
2025-10-03 14:39:50.176992 | controller |
2025-10-03 14:39:50.177021 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:50.177038 | controller | Friday 03 October 2025  14:39:49 +0000 (0:00:00.365)       0:00:41.281 ********
2025-10-03 14:39:50.177049 | controller | changed: [instance]
2025-10-03 14:39:50.230252 | controller |
2025-10-03 14:39:50.230294 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:50.230303 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.363)       0:00:41.644 ********
2025-10-03 14:39:50.230316 | 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-03 14:39:50.269669 | controller |
2025-10-03 14:39:50.269716 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:50.269724 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.053)       0:00:41.697 ********
2025-10-03 14:39:50.269735 | controller | ok: [instance] => changed=false
2025-10-03 14:39:50.468952 | controller |   msg: All assertions passed
2025-10-03 14:39:50.468981 | controller |
2025-10-03 14:39:50.468989 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:50.468995 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.039)       0:00:41.737 ********
2025-10-03 14:39:50.469005 | controller | ok: [instance]
2025-10-03 14:39:50.505825 | controller |
2025-10-03 14:39:50.505854 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:50.505863 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.199)       0:00:41.936 ********
2025-10-03 14:39:50.505873 | controller | ok: [instance]
2025-10-03 14:39:50.888825 | controller |
2025-10-03 14:39:50.888853 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:50.888861 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.036)       0:00:41.973 ********
2025-10-03 14:39:50.888872 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/03_user_data_b64.yaml)
2025-10-03 14:39:50.972214 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/service-values/04_user_data.yaml)
2025-10-03 14:39:50.972250 | controller |
2025-10-03 14:39:50.972260 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:50.972268 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.382)       0:00:42.356 ********
2025-10-03 14:39:50.972280 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:51.177377 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:51.177406 | controller |
2025-10-03 14:39:51.177414 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:51.177420 | controller | Friday 03 October 2025  14:39:50 +0000 (0:00:00.083)       0:00:42.439 ********
2025-10-03 14:39:51.177429 | controller | ok: [instance]
2025-10-03 14:39:51.555547 | controller |
2025-10-03 14:39:51.555575 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:51.555583 | controller | Friday 03 October 2025  14:39:51 +0000 (0:00:00.205)       0:00:42.644 ********
2025-10-03 14:39:51.555594 | controller | changed: [instance]
2025-10-03 14:39:51.609950 | controller |
2025-10-03 14:39:51.609979 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:51.609987 | controller | Friday 03 October 2025  14:39:51 +0000 (0:00:00.378)       0:00:43.023 ********
2025-10-03 14:39:51.609997 | 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-03 14:39:51.650748 | controller |
2025-10-03 14:39:51.650774 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:51.650783 | controller | Friday 03 October 2025  14:39:51 +0000 (0:00:00.054)       0:00:43.077 ********
2025-10-03 14:39:51.650795 | controller | ok: [instance] => changed=false
2025-10-03 14:39:51.848521 | controller |   msg: All assertions passed
2025-10-03 14:39:51.848550 | controller |
2025-10-03 14:39:51.848558 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:51.848564 | controller | Friday 03 October 2025  14:39:51 +0000 (0:00:00.040)       0:00:43.118 ********
2025-10-03 14:39:51.848578 | controller | ok: [instance]
2025-10-03 14:39:51.891062 | controller |
2025-10-03 14:39:51.891090 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:51.891098 | controller | Friday 03 October 2025  14:39:51 +0000 (0:00:00.197)       0:00:43.316 ********
2025-10-03 14:39:51.891131 | controller | ok: [instance] => changed=false
2025-10-03 14:39:52.086146 | controller |   msg: All assertions passed
2025-10-03 14:39:52.086175 | controller |
2025-10-03 14:39:52.086183 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:52.086189 | controller | Friday 03 October 2025  14:39:51 +0000 (0:00:00.042)       0:00:43.358 ********
2025-10-03 14:39:52.086199 | controller | ok: [instance]
2025-10-03 14:39:52.288148 | controller |
2025-10-03 14:39:52.288178 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:52.288187 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.195)       0:00:43.553 ********
2025-10-03 14:39:52.288197 | controller | ok: [instance]
2025-10-03 14:39:52.327734 | controller |
2025-10-03 14:39:52.327764 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:52.327772 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.201)       0:00:43.755 ********
2025-10-03 14:39:52.327782 | controller | skipping: [instance]
2025-10-03 14:39:52.534972 | controller |
2025-10-03 14:39:52.535005 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:52.535019 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.039)       0:00:43.795 ********
2025-10-03 14:39:52.535030 | controller | changed: [instance]
2025-10-03 14:39:52.580764 | controller |
2025-10-03 14:39:52.580792 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:52.580800 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.207)       0:00:44.002 ********
2025-10-03 14:39:52.580810 | controller | skipping: [instance]
2025-10-03 14:39:52.632772 | controller |
2025-10-03 14:39:52.632804 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:52.632813 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.045)       0:00:44.048 ********
2025-10-03 14:39:52.632824 | controller | ok: [instance]
2025-10-03 14:39:52.979885 | controller |
2025-10-03 14:39:52.979915 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:52.979923 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.051)       0:00:44.100 ********
2025-10-03 14:39:52.979933 | controller | changed: [instance]
2025-10-03 14:39:53.326956 | controller |
2025-10-03 14:39:53.326986 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:53.326994 | controller | Friday 03 October 2025  14:39:52 +0000 (0:00:00.347)       0:00:44.447 ********
2025-10-03 14:39:53.327004 | controller | changed: [instance]
2025-10-03 14:39:53.678871 | controller |
2025-10-03 14:39:53.678901 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:53.678908 | controller | Friday 03 October 2025  14:39:53 +0000 (0:00:00.347)       0:00:44.794 ********
2025-10-03 14:39:53.678918 | controller | changed: [instance]
2025-10-03 14:39:53.734731 | controller |
2025-10-03 14:39:53.734762 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:53.734772 | controller | Friday 03 October 2025  14:39:53 +0000 (0:00:00.351)       0:00:45.146 ********
2025-10-03 14:39:53.734784 | 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-03 14:39:53.775192 | controller |
2025-10-03 14:39:53.775224 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:53.775232 | controller | Friday 03 October 2025  14:39:53 +0000 (0:00:00.055)       0:00:45.202 ********
2025-10-03 14:39:53.775242 | controller | ok: [instance] => changed=false
2025-10-03 14:39:53.775266 | controller |   msg: All assertions passed
2025-10-03 14:39:53.775272 | controller |
2025-10-03 14:39:53.775280 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:53.775349 | controller | Friday 03 October 2025  14:39:53 +0000 (0:00:00.040)       0:00:45.242 ********
2025-10-03 14:39:53.981655 | controller | ok: [instance]
2025-10-03 14:39:54.021491 | controller |
2025-10-03 14:39:54.021524 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:54.021532 | controller | Friday 03 October 2025  14:39:53 +0000 (0:00:00.206)       0:00:45.449 ********
2025-10-03 14:39:54.021542 | controller | ok: [instance]
2025-10-03 14:39:54.411194 | controller |
2025-10-03 14:39:54.411222 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:39:54.411230 | controller | Friday 03 October 2025  14:39:54 +0000 (0:00:00.039)       0:00:45.488 ********
2025-10-03 14:39:54.411240 | 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-03 14:39:54.411501 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/04_user_data.yaml)
2025-10-03 14:39:54.411520 | controller |
2025-10-03 14:39:54.491229 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:39:54.491264 | controller | Friday 03 October 2025  14:39:54 +0000 (0:00:00.389)       0:00:45.878 ********
2025-10-03 14:39:54.491277 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:39:54.491324 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:39:54.491346 | controller |
2025-10-03 14:39:54.491354 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:39:54.491364 | controller | Friday 03 October 2025  14:39:54 +0000 (0:00:00.080)       0:00:45.958 ********
2025-10-03 14:39:54.699144 | controller | changed: [instance]
2025-10-03 14:39:55.072436 | controller |
2025-10-03 14:39:55.072470 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:39:55.072479 | controller | Friday 03 October 2025  14:39:54 +0000 (0:00:00.207)       0:00:46.166 ********
2025-10-03 14:39:55.072491 | controller | changed: [instance]
2025-10-03 14:39:55.507866 | controller |
2025-10-03 14:39:55.507895 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci] ************
2025-10-03 14:39:55.507903 | controller | Friday 03 October 2025  14:39:55 +0000 (0:00:00.373)       0:00:46.539 ********
2025-10-03 14:39:55.507912 | controller | changed: [instance] => (item=service-values)
2025-10-03 14:39:55.545228 | controller | changed: [instance] => (item=edpm-nodeset-values-post-ceph)
2025-10-03 14:39:55.545266 | controller |
2025-10-03 14:39:55.545275 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:39:55.545283 | controller | Friday 03 October 2025  14:39:55 +0000 (0:00:00.435)       0:00:46.975 ********
2025-10-03 14:39:55.545299 | controller | skipping: [instance]
2025-10-03 14:39:55.545322 | controller |
2025-10-03 14:39:55.545454 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci] *********
2025-10-03 14:39:55.545473 | controller | Friday 03 October 2025  14:39:55 +0000 (0:00:00.037)       0:00:47.013 ********
2025-10-03 14:39:55.921173 | controller | changed: [instance]
2025-10-03 14:39:55.921497 | controller |
2025-10-03 14:39:56.298746 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:39:56.298777 | controller | Friday 03 October 2025  14:39:55 +0000 (0:00:00.375)       0:00:47.388 ********
2025-10-03 14:39:56.298789 | controller | changed: [instance]
2025-10-03 14:39:56.542532 | controller |
2025-10-03 14:39:56.542564 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci] ***
2025-10-03 14:39:56.542571 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.377)       0:00:47.766 ********
2025-10-03 14:39:56.542582 | controller | changed: [instance]
2025-10-03 14:39:56.582538 | controller |
2025-10-03 14:39:56.582569 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:39:56.582577 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.243)       0:00:48.009 ********
2025-10-03 14:39:56.582587 | controller | skipping: [instance]
2025-10-03 14:39:56.621741 | controller |
2025-10-03 14:39:56.621771 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci] **********
2025-10-03 14:39:56.621780 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.040)       0:00:48.050 ********
2025-10-03 14:39:56.621795 | controller | skipping: [instance]
2025-10-03 14:39:56.663957 | controller |
2025-10-03 14:39:56.663988 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci] **************
2025-10-03 14:39:56.663996 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.039)       0:00:48.089 ********
2025-10-03 14:39:56.664006 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=SetupReady --timeout=10m)
2025-10-03 14:39:56.703277 | controller | skipping: [instance]
2025-10-03 14:39:56.703321 | controller |
2025-10-03 14:39:56.703331 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:39:56.703339 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.041)       0:00:48.131 ********
2025-10-03 14:39:56.703352 | controller | skipping: [instance]
2025-10-03 14:39:56.748215 | controller |
2025-10-03 14:39:56.748269 | controller | TASK [Executing post_stage hooks for examples/va/hci] **************************
2025-10-03 14:39:56.748279 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.039)       0:00:48.170 ********
2025-10-03 14:39:56.748292 | controller | skipping: [instance]
2025-10-03 14:39:56.784897 | controller |
2025-10-03 14:39:56.784930 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:39:56.784937 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.044)       0:00:48.215 ********
2025-10-03 14:39:56.784947 | controller | ok: [instance] => changed=false
2025-10-03 14:39:56.809217 | controller |   msg: All assertions passed
2025-10-03 14:39:56.809259 | controller |
2025-10-03 14:39:56.809267 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:39:56.809273 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.036)       0:00:48.252 ********
2025-10-03 14:39:56.809284 | controller | skipping: [instance]
2025-10-03 14:39:56.837968 | controller |
2025-10-03 14:39:56.837998 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:39:56.838005 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.024)       0:00:48.276 ********
2025-10-03 14:39:56.838015 | controller | ok: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=80m)
2025-10-03 14:39:56.859811 | controller |
2025-10-03 14:39:56.859833 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:39:56.859841 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.028)       0:00:48.305 ********
2025-10-03 14:39:56.859849 | controller | skipping: [instance]
2025-10-03 14:39:56.887881 | controller |
2025-10-03 14:39:56.887901 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact] ***********************
2025-10-03 14:39:56.887909 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.021)       0:00:48.327 ********
2025-10-03 14:39:56.887920 | controller | ok: [instance]
2025-10-03 14:39:57.110909 | controller |
2025-10-03 14:39:57.110940 | controller | TASK [kustomize_deploy : Ensure source files exists] ***************************
2025-10-03 14:39:57.110948 | controller | Friday 03 October 2025  14:39:56 +0000 (0:00:00.028)       0:00:48.355 ********
2025-10-03 14:39:57.110958 | controller | ok: [instance] => (item={'name': 'edpm-deployment-values-post-ceph', 'src_file': 'values.yaml'})
2025-10-03 14:39:57.171246 | controller |
2025-10-03 14:39:57.171294 | controller | TASK [kustomize_deploy : Assert source files exist] ****************************
2025-10-03 14:39:57.171303 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.222)       0:00:48.578 ********
2025-10-03 14:39:57.171315 | controller | ok: [instance] => (item=values.yaml)
2025-10-03 14:39:57.211810 | controller |
2025-10-03 14:39:57.211853 | controller | TASK [Executing pre_stage hooks for examples/va/hci/deployment] ****************
2025-10-03 14:39:57.211865 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.060)       0:00:48.638 ********
2025-10-03 14:39:57.211877 | controller | skipping: [instance]
2025-10-03 14:39:57.288827 | controller |
2025-10-03 14:39:57.288862 | controller | TASK [Generate values.yaml for examples/va/hci/deployment] *********************
2025-10-03 14:39:57.288870 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.040)       0:00:48.679 ********
2025-10-03 14:39:57.288880 | controller |
2025-10-03 14:39:57.346490 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] ***********************
2025-10-03 14:39:57.346518 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.076)       0:00:48.756 ********
2025-10-03 14:39:57.346529 | 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-03 14:39:57.391150 | controller |
2025-10-03 14:39:57.391169 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] *******
2025-10-03 14:39:57.391176 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.057)       0:00:48.814 ********
2025-10-03 14:39:57.391184 | controller | ok: [instance] => changed=false
2025-10-03 14:39:57.391562 | controller |   msg: All assertions passed
2025-10-03 14:39:57.589985 | controller |
2025-10-03 14:39:57.590014 | controller | TASK [ci_gen_kustomize_values : Stat original source file] *********************
2025-10-03 14:39:57.590023 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.044)       0:00:48.858 ********
2025-10-03 14:39:57.590033 | controller | ok: [instance]
2025-10-03 14:39:57.630200 | controller |
2025-10-03 14:39:57.630232 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] *********************
2025-10-03 14:39:57.630242 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.198)       0:00:49.057 ********
2025-10-03 14:39:57.630254 | controller | ok: [instance] => changed=false
2025-10-03 14:39:57.821165 | controller |   msg: All assertions passed
2025-10-03 14:39:57.821195 | controller |
2025-10-03 14:39:57.821203 | controller | TASK [ci_gen_kustomize_values : Load original values file] *********************
2025-10-03 14:39:57.821209 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.040)       0:00:49.097 ********
2025-10-03 14:39:57.821220 | controller | ok: [instance]
2025-10-03 14:39:58.006010 | controller |
2025-10-03 14:39:58.006042 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] ***********
2025-10-03 14:39:58.006052 | controller | Friday 03 October 2025  14:39:57 +0000 (0:00:00.190)       0:00:49.288 ********
2025-10-03 14:39:58.006064 | controller | ok: [instance]
2025-10-03 14:39:58.043264 | controller |
2025-10-03 14:39:58.043288 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] ***
2025-10-03 14:39:58.043296 | controller | Friday 03 October 2025  14:39:58 +0000 (0:00:00.184)       0:00:49.473 ********
2025-10-03 14:39:58.043306 | controller | skipping: [instance]
2025-10-03 14:39:58.238774 | controller |
2025-10-03 14:39:58.238803 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] ****************
2025-10-03 14:39:58.238811 | controller | Friday 03 October 2025  14:39:58 +0000 (0:00:00.037)       0:00:49.510 ********
2025-10-03 14:39:58.238821 | controller | changed: [instance]
2025-10-03 14:39:58.285204 | controller |
2025-10-03 14:39:58.285237 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] ***************************
2025-10-03 14:39:58.285247 | controller | Friday 03 October 2025  14:39:58 +0000 (0:00:00.195)       0:00:49.706 ********
2025-10-03 14:39:58.285258 | controller | skipping: [instance]
2025-10-03 14:39:58.285467 | controller |
2025-10-03 14:39:58.285487 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ******
2025-10-03 14:39:58.336521 | controller | Friday 03 October 2025  14:39:58 +0000 (0:00:00.046)       0:00:49.752 ********
2025-10-03 14:39:58.336553 | controller | ok: [instance]
2025-10-03 14:39:58.676202 | controller |
2025-10-03 14:39:58.676233 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************
2025-10-03 14:39:58.676242 | controller | Friday 03 October 2025  14:39:58 +0000 (0:00:00.051)       0:00:49.803 ********
2025-10-03 14:39:58.676252 | controller | changed: [instance]
2025-10-03 14:39:58.676638 | controller |
2025-10-03 14:39:59.017894 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ********************
2025-10-03 14:39:59.017923 | controller | Friday 03 October 2025  14:39:58 +0000 (0:00:00.339)       0:00:50.143 ********
2025-10-03 14:39:59.017935 | controller | changed: [instance]
2025-10-03 14:39:59.377613 | controller |
2025-10-03 14:39:59.377643 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] *********************
2025-10-03 14:39:59.377651 | controller | Friday 03 October 2025  14:39:59 +0000 (0:00:00.341)       0:00:50.485 ********
2025-10-03 14:39:59.377660 | controller | changed: [instance]
2025-10-03 14:39:59.433852 | controller |
2025-10-03 14:39:59.433883 | controller | TASK [ci_gen_kustomize_values : Generate values file] **************************
2025-10-03 14:39:59.433894 | controller | Friday 03 October 2025  14:39:59 +0000 (0:00:00.359)       0:00:50.845 ********
2025-10-03 14:39:59.433904 | 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-03 14:39:59.477768 | controller |
2025-10-03 14:39:59.477800 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] ***************
2025-10-03 14:39:59.477814 | controller | Friday 03 October 2025  14:39:59 +0000 (0:00:00.056)       0:00:50.901 ********
2025-10-03 14:39:59.477826 | controller | ok: [instance] => changed=false
2025-10-03 14:39:59.691171 | controller |   msg: All assertions passed
2025-10-03 14:39:59.691200 | controller |
2025-10-03 14:39:59.691208 | controller | TASK [ci_gen_kustomize_values : List snippets] *********************************
2025-10-03 14:39:59.691214 | controller | Friday 03 October 2025  14:39:59 +0000 (0:00:00.043)       0:00:50.945 ********
2025-10-03 14:39:59.691224 | controller | ok: [instance]
2025-10-03 14:39:59.729415 | controller |
2025-10-03 14:39:59.729443 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] **********************
2025-10-03 14:39:59.729450 | controller | Friday 03 October 2025  14:39:59 +0000 (0:00:00.213)       0:00:51.158 ********
2025-10-03 14:39:59.729460 | controller | ok: [instance]
2025-10-03 14:40:00.120963 | controller |
2025-10-03 14:40:00.120993 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ********************
2025-10-03 14:40:00.121001 | controller | Friday 03 October 2025  14:39:59 +0000 (0:00:00.038)       0:00:51.196 ********
2025-10-03 14:40:00.121011 | 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-03 14:40:00.202536 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/04_user_data.yaml)
2025-10-03 14:40:00.202566 | controller |
2025-10-03 14:40:00.202574 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ******************************
2025-10-03 14:40:00.202580 | controller | Friday 03 October 2025  14:40:00 +0000 (0:00:00.391)       0:00:51.588 ********
2025-10-03 14:40:00.202590 | controller | ok: [instance] => (item=03_user_data_b64.yaml)
2025-10-03 14:40:00.419198 | controller | ok: [instance] => (item=04_user_data.yaml)
2025-10-03 14:40:00.419235 | controller |
2025-10-03 14:40:00.419243 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] **********************
2025-10-03 14:40:00.419250 | controller | Friday 03 October 2025  14:40:00 +0000 (0:00:00.081)       0:00:51.669 ********
2025-10-03 14:40:00.419261 | controller | changed: [instance]
2025-10-03 14:40:00.790554 | controller |
2025-10-03 14:40:00.790585 | controller | TASK [ci_gen_kustomize_values : Output values file] ****************************
2025-10-03 14:40:00.790594 | controller | Friday 03 October 2025  14:40:00 +0000 (0:00:00.216)       0:00:51.886 ********
2025-10-03 14:40:00.790604 | controller | changed: [instance]
2025-10-03 14:40:01.042645 | controller |
2025-10-03 14:40:01.042676 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/hci/deployment] ***
2025-10-03 14:40:01.042684 | controller | Friday 03 October 2025  14:40:00 +0000 (0:00:00.371)       0:00:52.257 ********
2025-10-03 14:40:01.042695 | controller | changed: [instance] => (item=edpm-deployment-values-post-ceph)
2025-10-03 14:40:01.083218 | controller |
2025-10-03 14:40:01.083252 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested] ******
2025-10-03 14:40:01.083260 | controller | Friday 03 October 2025  14:40:01 +0000 (0:00:00.252)       0:00:52.510 ********
2025-10-03 14:40:01.083270 | controller | skipping: [instance]
2025-10-03 14:40:01.083294 | controller |
2025-10-03 14:40:01.083511 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/hci/deployment] ***
2025-10-03 14:40:01.385983 | controller | Friday 03 October 2025  14:40:01 +0000 (0:00:00.040)       0:00:52.550 ********
2025-10-03 14:40:01.386017 | controller | changed: [instance]
2025-10-03 14:40:01.741394 | controller |
2025-10-03 14:40:01.741424 | controller | TASK [kustomize_deploy : Output kustomize build in final file] *****************
2025-10-03 14:40:01.741432 | controller | Friday 03 October 2025  14:40:01 +0000 (0:00:00.302)       0:00:52.853 ********
2025-10-03 14:40:01.741447 | controller | changed: [instance]
2025-10-03 14:40:01.954832 | controller |
2025-10-03 14:40:01.954866 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/va/hci/deployment] ***
2025-10-03 14:40:01.954874 | controller | Friday 03 October 2025  14:40:01 +0000 (0:00:00.355)       0:00:53.208 ********
2025-10-03 14:40:01.954885 | controller | changed: [instance]
2025-10-03 14:40:01.993803 | controller |
2025-10-03 14:40:01.993837 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested] *******
2025-10-03 14:40:01.993845 | controller | Friday 03 October 2025  14:40:01 +0000 (0:00:00.213)       0:00:53.422 ********
2025-10-03 14:40:01.993855 | controller | skipping: [instance]
2025-10-03 14:40:02.033799 | controller |
2025-10-03 14:40:02.033832 | controller | TASK [kustomize_deploy : Apply generated content for examples/va/hci/deployment] ***
2025-10-03 14:40:02.033839 | controller | Friday 03 October 2025  14:40:01 +0000 (0:00:00.039)       0:00:53.461 ********
2025-10-03 14:40:02.033849 | controller | skipping: [instance]
2025-10-03 14:40:02.075207 | controller |
2025-10-03 14:40:02.075243 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/va/hci/deployment] ***
2025-10-03 14:40:02.075253 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.039)       0:00:53.501 ********
2025-10-03 14:40:02.075266 | controller | skipping: [instance] => (item=oc -n openstack wait osdpns openstack-edpm --for condition=Ready --timeout=80m)
2025-10-03 14:40:02.075305 | controller | skipping: [instance]
2025-10-03 14:40:02.075315 | controller |
2025-10-03 14:40:02.075322 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested] *****************
2025-10-03 14:40:02.075331 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.041)       0:00:53.542 ********
2025-10-03 14:40:02.115738 | controller | skipping: [instance]
2025-10-03 14:40:02.159267 | controller |
2025-10-03 14:40:02.159316 | controller | TASK [Executing post_stage hooks for examples/va/hci/deployment] ***************
2025-10-03 14:40:02.159330 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.040)       0:00:53.583 ********
2025-10-03 14:40:02.159342 | controller | skipping: [instance]
2025-10-03 14:40:02.159583 | controller |
2025-10-03 14:40:02.159616 | controller | TASK [Run loop deployment again] ***********************************************
2025-10-03 14:40:02.339879 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.043)       0:00:53.626 ********
2025-10-03 14:40:02.339922 | controller |
2025-10-03 14:40:02.378250 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined] ********************
2025-10-03 14:40:02.378286 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.180)       0:00:53.807 ********
2025-10-03 14:40:02.378307 | controller | ok: [instance] => changed=false
2025-10-03 14:40:02.378395 | controller |   msg: All assertions passed
2025-10-03 14:40:02.378425 | controller |
2025-10-03 14:40:02.378433 | controller | TASK [kustomize_deploy : Check custom wait conditions] *************************
2025-10-03 14:40:02.378443 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.038)       0:00:53.845 ********
2025-10-03 14:40:02.407659 | controller | failed: [instance] (item=sudo cat /etc/passwd) => changed=false
2025-10-03 14:40:02.407785 | controller |   ansible_loop_var: item
2025-10-03 14:40:02.407917 | controller |   assertion: item is match(_pattern)
2025-10-03 14:40:02.408032 | controller |   evaluated_to: false
2025-10-03 14:40:02.408164 | controller |   item: sudo cat /etc/passwd
2025-10-03 14:40:02.408297 | controller |   msg: 'The following custom condition is invalid: sudo cat /etc/passwd'
2025-10-03 14:40:02.409943 | controller | failed: [instance] (item=oc rsh exec blah) => changed=false
2025-10-03 14:40:02.410056 | controller |   ansible_loop_var: item
2025-10-03 14:40:02.410189 | controller |   assertion: item is match(_pattern)
2025-10-03 14:40:02.410316 | controller |   evaluated_to: false
2025-10-03 14:40:02.410422 | controller |   item: oc rsh exec blah
2025-10-03 14:40:02.410535 | controller |   msg: 'The following custom condition is invalid: oc rsh exec blah'
2025-10-03 14:40:02.412355 | controller | failed: [instance] (item=kubectl rsh exec bar) => changed=false
2025-10-03 14:40:02.412466 | controller |   ansible_loop_var: item
2025-10-03 14:40:02.412479 | controller |   assertion: item is match(_pattern)
2025-10-03 14:40:02.412578 | controller |   evaluated_to: false
2025-10-03 14:40:02.412685 | controller |   item: kubectl rsh exec bar
2025-10-03 14:40:02.412819 | controller |   msg: 'The following custom condition is invalid: kubectl rsh exec bar'
2025-10-03 14:40:02.445022 | controller | ...ignoring
2025-10-03 14:40:02.445181 | controller |
2025-10-03 14:40:02.445325 | controller | TASK [kustomize_deploy : Check builtin wait conditions] ************************
2025-10-03 14:40:02.445461 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.067)       0:00:53.912 ********
2025-10-03 14:40:02.474346 | 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-03 14:40:02.474474 | controller |
2025-10-03 14:40:02.474607 | controller | TASK [kustomize_deploy : Check wait_conditions validation result] **************
2025-10-03 14:40:02.474718 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.029)       0:00:53.942 ********
2025-10-03 14:40:02.493162 | controller | fatal: [instance]: FAILED! => changed=false
2025-10-03 14:40:02.493195 | controller |   msg: Review and correct the faulty wait_conditions listed above.
2025-10-03 14:40:02.518161 | controller |
2025-10-03 14:40:02.518218 | controller | TASK [Clear expected errors] ***************************************************
2025-10-03 14:40:02.518230 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.026)       0:00:53.968 ********
2025-10-03 14:40:02.518332 | controller |
2025-10-03 14:40:02.518450 | controller | TASK [Ensure a successful end] *************************************************
2025-10-03 14:40:02.518563 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.010)       0:00:53.978 ********
2025-10-03 14:40:02.518669 | controller |
2025-10-03 14:40:02.518775 | controller | PLAY RECAP *********************************************************************
2025-10-03 14:40:02.518896 | controller | instance                   : ok=261  changed=69   unreachable=0    failed=0    skipped=75   rescued=1    ignored=1
2025-10-03 14:40:02.518978 | controller |
2025-10-03 14:40:02.519090 | controller | Friday 03 October 2025  14:40:02 +0000 (0:00:00.006)       0:00:53.985 ********
2025-10-03 14:40:02.519208 | controller | ===============================================================================
2025-10-03 14:40:02.519303 | controller | Gathering Facts --------------------------------------------------------- 0.76s
2025-10-03 14:40:02.519397 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.58s
2025-10-03 14:40:02.519490 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.58s
2025-10-03 14:40:02.519581 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.58s
2025-10-03 14:40:02.519676 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.56s
2025-10-03 14:40:02.519783 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.55s
2025-10-03 14:40:02.519877 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.50s
2025-10-03 14:40:02.519972 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.48s
2025-10-03 14:40:02.520069 | controller | kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking/nncp --- 0.47s
2025-10-03 14:40:02.520183 | controller | kustomize_deploy : Copy generated values for examples/va/hci/control-plane --- 0.47s
2025-10-03 14:40:02.520292 | controller | kustomize_deploy : Copy generated values for examples/va/hci ------------ 0.44s
2025-10-03 14:40:02.520387 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.41s
2025-10-03 14:40:02.520483 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.41s
2025-10-03 14:40:02.520574 | controller | kustomize_deploy : Ensure source files exists --------------------------- 0.41s
2025-10-03 14:40:02.520670 | controller | kustomize_deploy : Ensure source files exists --------------------------- 0.40s
2025-10-03 14:40:02.520792 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.40s
2025-10-03 14:40:02.520885 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.39s
2025-10-03 14:40:02.520977 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.39s
2025-10-03 14:40:02.521069 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.39s
2025-10-03 14:40:02.521188 | controller | kustomize_deploy : Build kustomized content for examples/va/hci/control-plane/networking --- 0.38s
2025-10-03 14:40:02.595574 | controller | INFO     Running flexible_loop > cleanup
2025-10-03 14:40:02.596013 | controller | WARNING  Skipping, cleanup playbook not configured.
2025-10-03 14:40:02.596581 | controller | INFO     Writing /tmp/report.html report.
2025-10-03 14:40:02.709239 | controller | changed
2025-10-03 14:40:02.739736 | 
2025-10-03 14:40:02.739825 | PLAY RECAP
2025-10-03 14:40:02.739869 | controller | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-03 14:40:02.739892 | 
2025-10-03 14:40:02.811881 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main]
2025-10-03 14:40:02.812708 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-03 14:40:03.393553 | 
2025-10-03 14:40:03.393667 | PLAY [Run ci/playbooks/collect-logs.yml]
2025-10-03 14:40:03.419649 | 
2025-10-03 14:40:03.419741 | TASK [Filter out host if needed]
2025-10-03 14:40:03.428112 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller
2025-10-03 14:40:03.432503 | 
2025-10-03 14:40:03.432571 | TASK [Ensure file is present]
2025-10-03 14:40:03.766782 | controller | ok
2025-10-03 14:40:03.773689 | 
2025-10-03 14:40:03.773771 | TASK [Manage molecule report file]
2025-10-03 14:40:04.330772 | controller | changed
2025-10-03 14:40:04.336087 | 
2025-10-03 14:40:04.336232 | TASK [Check if we get ci-framework-data basedir]
2025-10-03 14:40:04.567807 | controller | ok
2025-10-03 14:40:04.573359 | 
2025-10-03 14:40:04.573429 | TASK [Create ci-framework-data log directory for zuul]
2025-10-03 14:40:04.945524 | controller | changed
2025-10-03 14:40:04.951495 | 
2025-10-03 14:40:04.951572 | TASK [Copy ci-framework interesting files]
2025-10-03 14:40:05.168127 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory
2025-10-03 14:40:05.487074 | controller | changed
2025-10-03 14:40:05.493247 | 
2025-10-03 14:40:05.493326 | TASK [Get SELinux listing]
2025-10-03 14:40:06.087047 | controller | changed
2025-10-03 14:40:06.092793 | 
2025-10-03 14:40:06.092865 | TASK [Generate log index]
2025-10-03 14:40:06.721752 | controller | changed
2025-10-03 14:40:06.727201 | 
2025-10-03 14:40:06.727295 | TASK [Get some env related data]
2025-10-03 14:40:07.257825 | controller | /home/zuul/.local/bin/ansible
2025-10-03 14:40:08.253067 | controller | changed
2025-10-03 14:40:08.262050 | 
2025-10-03 14:40:08.262120 | TASK [Generate list of logs to collect in home directory]
2025-10-03 14:40:08.590136 | controller | ok: All paths examined
2025-10-03 14:40:08.595754 | 
2025-10-03 14:40:08.595841 | LOOP [Copy logs from home directory]
2025-10-03 14:40:08.928711 | controller | changed:
2025-10-03 14:40:08.928817 | controller | {
2025-10-03 14:40:08.928846 | controller |   "atime": 1759502298.173736,
2025-10-03 14:40:08.928869 | controller |   "ctime": 1759502313.9598894,
2025-10-03 14:40:08.928888 | controller |   "dev": 64513,
2025-10-03 14:40:08.928941 | controller |   "gid": 1000,
2025-10-03 14:40:08.928972 | controller |   "gr_name": "zuul",
2025-10-03 14:40:08.928994 | controller |   "inode": 4437667,
2025-10-03 14:40:08.929019 | controller |   "isblk": false,
2025-10-03 14:40:08.929038 | controller |   "ischr": false,
2025-10-03 14:40:08.929054 | controller |   "isdir": false,
2025-10-03 14:40:08.929069 | controller |   "isfifo": false,
2025-10-03 14:40:08.929085 | controller |   "isgid": false,
2025-10-03 14:40:08.929101 | controller |   "islnk": false,
2025-10-03 14:40:08.929117 | controller |   "isreg": true,
2025-10-03 14:40:08.929132 | controller |   "issock": false,
2025-10-03 14:40:08.929147 | controller |   "isuid": false,
2025-10-03 14:40:08.929162 | controller |   "mode": "0644",
2025-10-03 14:40:08.929177 | controller |   "mtime": 1759502313.9598894,
2025-10-03 14:40:08.929193 | controller |   "nlink": 1,
2025-10-03 14:40:08.929208 | controller |   "path": "/home/zuul/ansible.log",
2025-10-03 14:40:08.929225 | controller |   "pw_name": "zuul",
2025-10-03 14:40:08.929242 | controller |   "rgrp": true,
2025-10-03 14:40:08.929258 | controller |   "roth": true,
2025-10-03 14:40:08.929274 | controller |   "rusr": true,
2025-10-03 14:40:08.929290 | controller |   "size": 6749,
2025-10-03 14:40:08.929306 | controller |   "uid": 1000,
2025-10-03 14:40:08.929322 | controller |   "wgrp": false,
2025-10-03 14:40:08.929338 | controller |   "woth": false,
2025-10-03 14:40:08.929356 | controller |   "wusr": true,
2025-10-03 14:40:08.929372 | controller |   "xgrp": false,
2025-10-03 14:40:08.929388 | controller |   "xoth": false,
2025-10-03 14:40:08.929403 | controller |   "xusr": false
2025-10-03 14:40:08.929418 | controller | }
2025-10-03 14:40:08.944008 | 
2025-10-03 14:40:08.944076 | TASK [Copy crio stats log file]
2025-10-03 14:40:08.967712 | controller | skipping: Conditional result was False
2025-10-03 14:40:08.973845 | 
2025-10-03 14:40:08.973934 | TASK [Get SELinux related data]
2025-10-03 14:40:09.194023 | controller | <no matches>
2025-10-03 14:40:09.507348 | controller | ERROR
2025-10-03 14:40:09.507459 | controller | {
2025-10-03 14:40:09.507491 | controller |   "delta": "0:00:00.008409",
2025-10-03 14:40:09.507514 | controller |   "end": "2025-10-03 14:40:09.194781",
2025-10-03 14:40:09.507532 | controller |   "msg": "non-zero return code",
2025-10-03 14:40:09.507548 | controller |   "rc": 1,
2025-10-03 14:40:09.507564 | controller |   "start": "2025-10-03 14:40:09.186372"
2025-10-03 14:40:09.507579 | controller | }
2025-10-03 14:40:09.507599 | controller | ERROR: Ignoring Errors
2025-10-03 14:40:09.512802 | 
2025-10-03 14:40:09.512868 | TASK [Create system configuration directory]
2025-10-03 14:40:09.718177 | controller | changed
2025-10-03 14:40:09.728590 | 
2025-10-03 14:40:09.728707 | TASK [Get some of the system configurations]
2025-10-03 14:40:10.254491 | controller | changed
2025-10-03 14:40:10.260627 | 
2025-10-03 14:40:10.260734 | TASK [Copy generated documentation if available]
2025-10-03 14:40:10.294661 | controller | skipping: Conditional result was False
2025-10-03 14:40:10.300885 | 
2025-10-03 14:40:10.300999 | TASK [Copy generated AsciiDoc documentation if available]
2025-10-03 14:40:10.315429 | controller | skipping: Conditional result was False
2025-10-03 14:40:10.323181 | 
2025-10-03 14:40:10.323272 | TASK [Compress logs bigger than 2MB]
2025-10-03 14:40:10.852336 | controller | changed
2025-10-03 14:40:10.861941 | 
2025-10-03 14:40:10.862012 | TASK [Copy files from workspace on node]
2025-10-03 14:40:10.879953 | controller | ok
2025-10-03 14:40:10.903079 | 
2025-10-03 14:40:10.903164 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-03 14:40:10.917316 | controller | skipping: Conditional result was False
2025-10-03 14:40:10.925175 | 
2025-10-03 14:40:10.925251 | TASK [fetch-output : Set log path for single node]
2025-10-03 14:40:10.953704 | controller | ok
2025-10-03 14:40:10.959959 | 
2025-10-03 14:40:10.960031 | LOOP [fetch-output : Ensure local output dirs]
2025-10-03 14:40:11.176184 | controller -> localhost | ok: "/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/logs"
2025-10-03 14:40:11.176404 | controller -> localhost | changed: All items complete
2025-10-03 14:40:11.176436 | 
2025-10-03 14:40:11.375448 | controller -> localhost | changed: "/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/artifacts"
2025-10-03 14:40:11.583691 | controller -> localhost | changed: "/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/docs"
2025-10-03 14:40:11.592695 | 
2025-10-03 14:40:11.592800 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-03 14:40:12.271113 | controller | changed:
2025-10-03 14:40:12.271301 | controller | .d..t...... ./
2025-10-03 14:40:12.271332 | controller | >f+++++++++ README.html
2025-10-03 14:40:12.271355 | controller | >f+++++++++ ansible-execution.log
2025-10-03 14:40:12.271378 | controller | >f+++++++++ ansible.log
2025-10-03 14:40:12.271399 | controller | >f+++++++++ dmesg.log
2025-10-03 14:40:12.271419 | controller | >f+++++++++ installed-pkgs.log
2025-10-03 14:40:12.271440 | controller | >f+++++++++ python.log
2025-10-03 14:40:12.271461 | controller | >f+++++++++ registries.conf
2025-10-03 14:40:12.271479 | controller | >f+++++++++ report.html
2025-10-03 14:40:12.271499 | controller | >f+++++++++ selinux-denials.log
2025-10-03 14:40:12.271517 | controller | >f+++++++++ selinux-listing.log
2025-10-03 14:40:12.271535 | controller | cd+++++++++ ci-framework-data/
2025-10-03 14:40:12.271553 | controller | cd+++++++++ ci-framework-data/artifacts/
2025-10-03 14:40:12.271570 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key
2025-10-03 14:40:12.271587 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub
2025-10-03 14:40:12.271604 | controller | >f+++++++++ ci-framework-data/artifacts/user_key
2025-10-03 14:40:12.271620 | controller | >f+++++++++ ci-framework-data/artifacts/user_key.pub
2025-10-03 14:40:12.271636 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml
2025-10-03 14:40:12.271669 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/
2025-10-03 14:40:12.271689 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values-post-ceph/
2025-10-03 14:40:12.271707 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values-post-ceph/values.yaml
2025-10-03 14:40:12.271725 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values/
2025-10-03 14:40:12.271742 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-deployment-values/values.yaml
2025-10-03 14:40:12.271759 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values-post-ceph/
2025-10-03 14:40:12.271781 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values-post-ceph/values.yaml
2025-10-03 14:40:12.271799 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/
2025-10-03 14:40:12.271816 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml
2025-10-03 14:40:12.271832 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/
2025-10-03 14:40:12.271848 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml
2025-10-03 14:40:12.271864 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/service-values/
2025-10-03 14:40:12.271879 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/service-values/values.yaml
2025-10-03 14:40:12.271895 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/service-values/values.yaml.29018.2025-10-03@14:39:51~
2025-10-03 14:40:12.271931 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/
2025-10-03 14:40:12.271953 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/
2025-10-03 14:40:12.271970 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/01_original.yaml
2025-10-03 14:40:12.271987 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/03_user_data_b64.yaml
2025-10-03 14:40:12.272003 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values-post-ceph/04_user_data.yaml
2025-10-03 14:40:12.272018 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/
2025-10-03 14:40:12.272034 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/01_original.yaml
2025-10-03 14:40:12.272049 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/03_user_data_b64.yaml
2025-10-03 14:40:12.272064 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-deployment-values/04_user_data.yaml
2025-10-03 14:40:12.272079 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/
2025-10-03 14:40:12.272095 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/01_original.yaml
2025-10-03 14:40:12.272110 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/03_user_data_b64.yaml
2025-10-03 14:40:12.272125 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values-post-ceph/04_user_data.yaml
2025-10-03 14:40:12.272142 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/
2025-10-03 14:40:12.272159 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml
2025-10-03 14:40:12.272175 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml
2025-10-03 14:40:12.272190 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml
2025-10-03 14:40:12.272205 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml
2025-10-03 14:40:12.272221 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/
2025-10-03 14:40:12.272237 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml
2025-10-03 14:40:12.272253 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml.27274.2025-10-03@14:39:21~
2025-10-03 14:40:12.272268 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml
2025-10-03 14:40:12.272287 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml
2025-10-03 14:40:12.272303 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml
2025-10-03 14:40:12.272319 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/
2025-10-03 14:40:12.272335 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/01_original.yaml
2025-10-03 14:40:12.272351 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/01_original.yaml.28927.2025-10-03@14:39:50~
2025-10-03 14:40:12.272366 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/03_user_data_b64.yaml
2025-10-03 14:40:12.272382 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/service-values/04_user_data.yaml
2025-10-03 14:40:12.272398 | controller | cd+++++++++ ci-framework-data/artifacts/kustomize_deploy/
2025-10-03 14:40:12.272414 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/control-plane.yaml
2025-10-03 14:40:12.272429 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/deployment-post-ceph.yaml
2025-10-03 14:40:12.272445 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/deployment-pre-ceph.yaml
2025-10-03 14:40:12.272460 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/network.yaml
2025-10-03 14:40:12.272475 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nncp.yaml
2025-10-03 14:40:12.272491 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nodeset-post-ceph.yaml
2025-10-03 14:40:12.272506 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nodeset-pre-ceph.yaml
2025-10-03 14:40:12.272520 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/
2025-10-03 14:40:12.272536 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/
2025-10-03 14:40:12.272550 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/
2025-10-03 14:40:12.272565 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/
2025-10-03 14:40:12.272579 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml
2025-10-03 14:40:12.272594 | controller | cd+++++++++ ci-framework-data/logs/
2025-10-03 14:40:12.272609 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log
2025-10-03 14:40:12.272624 | controller | cd+++++++++ registries.conf.d/
2025-10-03 14:40:12.272639 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf
2025-10-03 14:40:12.272667 | controller | cd+++++++++ system-config/
2025-10-03 14:40:12.272685 | controller | cd+++++++++ system-config/libvirt/
2025-10-03 14:40:12.272700 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf
2025-10-03 14:40:12.272716 | controller | >f+++++++++ system-config/libvirt/libvirt.conf
2025-10-03 14:40:12.653313 | controller | changed: .d..t...... ./
2025-10-03 14:40:13.151249 | controller | changed: .d..t...... ./
2025-10-03 14:40:13.171613 | 
2025-10-03 14:40:13.171729 | TASK [Return artifact to Zuul]
2025-10-03 14:40:13.227511 | controller | ok
2025-10-03 14:40:13.252949 | 
2025-10-03 14:40:13.253015 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host]
2025-10-03 14:40:13.253115 | 
2025-10-03 14:40:13.253143 | PLAY RECAP
2025-10-03 14:40:13.253180 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1
2025-10-03 14:40:13.253213 | 
2025-10-03 14:40:13.351076 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main]
2025-10-03 14:40:13.351832 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-03 14:40:14.214638 | 
2025-10-03 14:40:14.214802 | PLAY [all]
2025-10-03 14:40:14.271435 | 
2025-10-03 14:40:14.271566 | TASK [include_role : fetch-output]
2025-10-03 14:40:14.335374 | controller | ok
2025-10-03 14:40:14.367431 | 
2025-10-03 14:40:14.367553 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-03 14:40:14.447621 | controller | skipping: Conditional result was False
2025-10-03 14:40:14.453500 | 
2025-10-03 14:40:14.453588 | TASK [fetch-output : Set log path for single node]
2025-10-03 14:40:14.482567 | controller | ok
2025-10-03 14:40:14.488051 | 
2025-10-03 14:40:14.488129 | LOOP [fetch-output : Ensure local output dirs]
2025-10-03 14:40:14.867206 | controller -> localhost | ok: "/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/logs"
2025-10-03 14:40:15.056954 | controller -> localhost | ok: "/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/artifacts"
2025-10-03 14:40:15.256930 | controller -> localhost | ok: "/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/docs"
2025-10-03 14:40:15.267429 | 
2025-10-03 14:40:15.267541 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-03 14:40:15.831947 | controller | ok
2025-10-03 14:40:15.832141 | controller | ok: All items complete
2025-10-03 14:40:15.832173 | 
2025-10-03 14:40:16.301563 | controller | ok
2025-10-03 14:40:16.857674 | controller | ok
2025-10-03 14:40:16.876569 | 
2025-10-03 14:40:16.876691 | TASK [include_role : fetch-output-openshift]
2025-10-03 14:40:16.913287 | controller | skipping: Conditional result was False
2025-10-03 14:40:16.919633 | 
2025-10-03 14:40:16.919716 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-03 14:40:17.414388 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006881
2025-10-03 14:40:17.679110 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.032125
2025-10-03 14:40:17.740400 | 
2025-10-03 14:40:17.740509 | PLAY [all]
2025-10-03 14:40:17.780717 | 
2025-10-03 14:40:17.780822 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2025-10-03 14:40:18.286171 | controller | changed
2025-10-03 14:40:18.317314 | 
2025-10-03 14:40:18.317395 | PLAY RECAP
2025-10-03 14:40:18.317442 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0
2025-10-03 14:40:18.317466 | 
2025-10-03 14:40:18.433412 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master]
2025-10-03 14:40:18.434206 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master]
2025-10-03 14:40:19.043073 | 
2025-10-03 14:40:19.043176 | PLAY [localhost]
2025-10-03 14:40:19.061243 | 
2025-10-03 14:40:19.061325 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-03 14:40:19.536365 | localhost | changed
2025-10-03 14:40:19.541214 | 
2025-10-03 14:40:19.541305 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-03 14:40:19.569355 | localhost | ok
2025-10-03 14:40:19.577805 | 
2025-10-03 14:40:19.577892 | TASK [add-fileserver : Create SSH private key tempfile]
2025-10-03 14:40:20.015937 | localhost | changed
2025-10-03 14:40:20.022733 | 
2025-10-03 14:40:20.022810 | TASK [add-fileserver : Create SSH private key from secret]
2025-10-03 14:40:20.949144 | localhost | changed
2025-10-03 14:40:20.964301 | 
2025-10-03 14:40:20.964402 | TASK [add-fileserver : Add fileserver ssh key]
2025-10-03 14:40:21.399044 | localhost | Identity added: /var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/tmp/ansible.p_mz4s93 (/var/lib/zuul/builds/affbb926f8674dca811f8db0291e25b3/work/tmp/ansible.p_mz4s93)
2025-10-03 14:40:21.399221 | localhost | ok: Runtime: 0:00:00.007104
2025-10-03 14:40:21.404373 | 
2025-10-03 14:40:21.404453 | TASK [add-fileserver : Remove SSH private key from disk]
2025-10-03 14:40:21.710308 | localhost | ok: Runtime: 0:00:00.005051
2025-10-03 14:40:21.716599 | 
2025-10-03 14:40:21.716705 | TASK [add-fileserver : Add fileserver to inventory]
2025-10-03 14:40:21.766731 | localhost | changed
2025-10-03 14:40:21.771393 | 
2025-10-03 14:40:21.771477 | TASK [add-fileserver : Add fileserver server to known hosts]
2025-10-03 14:40:22.197965 | localhost | changed
2025-10-03 14:40:22.224333 | 
2025-10-03 14:40:22.224444 | PLAY [localhost]
2025-10-03 14:40:22.237739 | 
2025-10-03 14:40:22.237839 | TASK [Generate bulk log download script]
2025-10-03 14:40:22.284147 | localhost | ok
2025-10-03 14:40:22.297708 | 
2025-10-03 14:40:22.297790 | TASK [local-log-download : Check API endpoint is defined]
2025-10-03 14:40:22.345829 | localhost | ok: All assertions passed
2025-10-03 14:40:22.351674 | 
2025-10-03 14:40:22.351759 | TASK [local-log-download : Create download script]
2025-10-03 14:40:22.885687 | localhost -> localhost | changed
2025-10-03 14:40:22.895453 | 
2025-10-03 14:40:22.895537 | TASK [Register quick-download link]
2025-10-03 14:40:22.932584 | localhost | ok
2025-10-03 14:40:22.947803 | 
2025-10-03 14:40:22.947861 | PLAY [logserver.rdoproject.org]
2025-10-03 14:40:22.957578 | 
2025-10-03 14:40:22.957640 | TASK [Set zuul-log-path fact]
2025-10-03 14:40:22.973369 | logserver.rdoproject.org | ok
2025-10-03 14:40:22.982549 | 
2025-10-03 14:40:22.982622 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-03 14:40:23.006988 | logserver.rdoproject.org | ok
2025-10-03 14:40:23.012752 | 
2025-10-03 14:40:23.012827 | TASK [upload-logs : Create log directories]
2025-10-03 14:40:24.785018 | logserver.rdoproject.org | changed
2025-10-03 14:40:24.788335 | 
2025-10-03 14:40:24.788412 | TASK [upload-logs : Ensure logs are readable before uploading]
2025-10-03 14:40:25.085936 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005597
2025-10-03 14:40:25.090514 | 
2025-10-03 14:40:25.090587 | TASK [upload-logs : Upload logs to log server]
2025-10-03 14:40:26.789637 | logserver.rdoproject.org | Output suppressed because no_log was given
2025-10-03 14:40:26.793561 | 
2025-10-03 14:40:26.793667 | LOOP [upload-logs : Compress console log and json output]
2025-10-03 14:40:26.847662 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 14:40:26.848424 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 14:40:26.862225 | 
2025-10-03 14:40:26.862816 | LOOP [upload-logs : Upload compressed console log and json output]
2025-10-03 14:40:26.905558 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 14:40:26.905791 | 
2025-10-03 14:40:26.906334 | logserver.rdoproject.org | skipping: Conditional result was False
2025-10-03 14:40:26.921227 | 
2025-10-03 14:40:26.921331 | LOOP [upload-logs : Upload console log and json output]