2025-09-30 11:16:59.083827 | Job console starting... 2025-09-30 11:16:59.311289 | Updating repositories 2025-09-30 11:17:00.063547 | Preparing job workspace 2025-09-30 11:17:16.542287 | Running Ansible setup... 2025-09-30 11:17:22.665551 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-09-30 11:17:24.451897 | 2025-09-30 11:17:24.451993 | PLAY [localhost] 2025-09-30 11:17:24.473773 | 2025-09-30 11:17:24.473845 | TASK [Gathering Facts] 2025-09-30 11:17:27.397520 | localhost | ok 2025-09-30 11:17:27.447538 | 2025-09-30 11:17:27.447670 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-30 11:17:28.470265 | localhost -> localhost | changed 2025-09-30 11:17:28.475931 | 2025-09-30 11:17:28.476001 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-30 11:17:30.581868 | localhost -> localhost | changed 2025-09-30 11:17:30.590013 | 2025-09-30 11:17:30.590082 | TASK [Setup log path fact] 2025-09-30 11:17:30.656029 | localhost | ok 2025-09-30 11:17:30.685749 | 2025-09-30 11:17:30.685848 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-30 11:17:30.763294 | localhost | ok 2025-09-30 11:17:30.771560 | 2025-09-30 11:17:30.771630 | TASK [emit-job-header : Print job information] 2025-09-30 11:17:30.849191 | # Job Information 2025-09-30 11:17:30.849335 | Ansible Version: 2.15.12 2025-09-30 11:17:30.849365 | Job: cifmw-molecule-ci_gen_kustomize_values 2025-09-30 11:17:30.849410 | Pipeline: github-check 2025-09-30 11:17:30.849436 | Executor: ibm-bm3-ze.softwarefactory-project.io 2025-09-30 11:17:30.849457 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3333 2025-09-30 11:17:30.849477 | Log URL (when completed): https://logserver.rdoproject.org/d8e/rdoproject.org/d8ec370de0f0412dadd4ba738e9ed9e9/ 2025-09-30 11:17:30.849496 | Event ID: c7820690-9dee-11f0-870e-caa834dfb11c 2025-09-30 11:17:30.853723 | 2025-09-30 11:17:30.853790 | LOOP [emit-job-header : Print node information] 2025-09-30 11:17:31.061346 | localhost | ok: 2025-09-30 11:17:31.061546 | localhost | # Node Information 2025-09-30 11:17:31.061588 | localhost | Inventory Hostname: controller 2025-09-30 11:17:31.061621 | localhost | Hostname: np0005462649 2025-09-30 11:17:31.061649 | localhost | Username: zuul 2025-09-30 11:17:31.061677 | localhost | Distro: CentOS 9 2025-09-30 11:17:31.061702 | localhost | Provider: ibm-bm3-nodepool 2025-09-30 11:17:31.061728 | localhost | Region: regionOne 2025-09-30 11:17:31.061752 | localhost | Label: cloud-centos-9-stream-tripleo-ibm 2025-09-30 11:17:31.061777 | localhost | Product Name: OpenStack Compute 2025-09-30 11:17:31.061801 | localhost | Interface IP: 192.168.25.168 2025-09-30 11:17:31.107715 | 2025-09-30 11:17:31.107792 | PLAY [all] 2025-09-30 11:17:31.122123 | 2025-09-30 11:17:31.122197 | TASK [Gather network facts] 2025-09-30 11:17:31.505457 | controller | ok 2025-09-30 11:17:31.532254 | 2025-09-30 11:17:31.532322 | TASK [include_role : start-zuul-console] 2025-09-30 11:17:31.591184 | controller | ok 2025-09-30 11:17:31.606418 | 2025-09-30 11:17:31.606483 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-30 11:17:32.179059 | controller | ok 2025-09-30 11:17:32.201871 | 2025-09-30 11:17:32.201973 | TASK [include_role : add-build-sshkey] 2025-09-30 11:17:32.230830 | controller | ok 2025-09-30 11:17:32.250973 | 2025-09-30 11:17:32.251042 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-30 11:17:33.022721 | controller -> localhost | ok 2025-09-30 11:17:33.028982 | 2025-09-30 11:17:33.029050 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-30 11:17:33.069910 | controller | ok 2025-09-30 11:17:33.118001 | controller | included: /var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-30 11:17:33.139814 | 2025-09-30 11:17:33.139887 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-30 11:17:35.323807 | controller -> localhost | Generating public/private rsa key pair. 2025-09-30 11:17:35.323973 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/d8ec370de0f0412dadd4ba738e9ed9e9_id_rsa. 2025-09-30 11:17:35.324005 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/d8ec370de0f0412dadd4ba738e9ed9e9_id_rsa.pub. 2025-09-30 11:17:35.324028 | controller -> localhost | The key fingerprint is: 2025-09-30 11:17:35.324048 | controller -> localhost | SHA256:n3BquiLMP1Hd69gwL1KzywCvJppjQttAG8QeTkW6MY0 zuul-build-sshkey 2025-09-30 11:17:35.324066 | controller -> localhost | The key's randomart image is: 2025-09-30 11:17:35.324084 | controller -> localhost | +---[RSA 3072]----+ 2025-09-30 11:17:35.324101 | controller -> localhost | |. oo | 2025-09-30 11:17:35.324120 | controller -> localhost | | =+ | 2025-09-30 11:17:35.324137 | controller -> localhost | |=E.. . . | 2025-09-30 11:17:35.324165 | controller -> localhost | | =+ . . . | 2025-09-30 11:17:35.324184 | controller -> localhost | |..o .. S .. | 2025-09-30 11:17:35.324202 | controller -> localhost | | + .o ==.. | 2025-09-30 11:17:35.324218 | controller -> localhost | |.o+ .o.oXo | 2025-09-30 11:17:35.324235 | controller -> localhost | |o+=.+..=+ + | 2025-09-30 11:17:35.324252 | controller -> localhost | |=o =oooooo | 2025-09-30 11:17:35.324268 | controller -> localhost | +----[SHA256]-----+ 2025-09-30 11:17:35.324308 | controller -> localhost | ok: Runtime: 0:00:00.637120 2025-09-30 11:17:35.332692 | 2025-09-30 11:17:35.332753 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-30 11:17:35.370467 | controller | ok 2025-09-30 11:17:35.414655 | controller | included: /var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-30 11:17:35.462290 | 2025-09-30 11:17:35.462366 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-30 11:17:35.531257 | controller | skipping: Conditional result was False 2025-09-30 11:17:35.536621 | 2025-09-30 11:17:35.536689 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-30 11:17:36.458208 | controller | changed 2025-09-30 11:17:36.464998 | 2025-09-30 11:17:36.465063 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-30 11:17:36.777491 | controller | ok 2025-09-30 11:17:36.783099 | 2025-09-30 11:17:36.783174 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-30 11:17:37.694339 | controller | changed 2025-09-30 11:17:37.704001 | 2025-09-30 11:17:37.704072 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-30 11:17:38.714861 | controller | changed 2025-09-30 11:17:38.937342 | 2025-09-30 11:17:38.937454 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-30 11:17:39.036106 | controller | skipping: Conditional result was False 2025-09-30 11:17:39.042691 | 2025-09-30 11:17:39.042759 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-30 11:17:40.521638 | controller -> localhost | changed 2025-09-30 11:17:40.535733 | 2025-09-30 11:17:40.535817 | TASK [add-build-sshkey : Add back temp key] 2025-09-30 11:17:41.488302 | controller -> localhost | Identity added: /var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/d8ec370de0f0412dadd4ba738e9ed9e9_id_rsa (zuul-build-sshkey) 2025-09-30 11:17:41.488488 | controller -> localhost | ok: Runtime: 0:00:00.019477 2025-09-30 11:17:41.494975 | 2025-09-30 11:17:41.495039 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-30 11:17:41.960447 | controller | ok 2025-09-30 11:17:41.965022 | 2025-09-30 11:17:41.965085 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-30 11:17:42.033623 | controller | skipping: Conditional result was False 2025-09-30 11:17:42.043692 | 2025-09-30 11:17:42.043772 | TASK [include_role : validate-host] 2025-09-30 11:17:42.102032 | controller | ok 2025-09-30 11:17:42.197880 | 2025-09-30 11:17:42.197978 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-30 11:17:42.232425 | controller | ok 2025-09-30 11:17:42.253939 | 2025-09-30 11:17:42.254007 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-30 11:17:43.260732 | controller -> localhost | ok 2025-09-30 11:17:43.272581 | 2025-09-30 11:17:43.272650 | TASK [validate-host : Collect information about the host] 2025-09-30 11:17:43.981318 | controller | ok 2025-09-30 11:17:43.995959 | 2025-09-30 11:17:43.996042 | TASK [validate-host : Sanitize hostname] 2025-09-30 11:17:44.173052 | controller | ok 2025-09-30 11:17:44.184347 | 2025-09-30 11:17:44.184448 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-30 11:17:46.081006 | controller -> localhost | changed 2025-09-30 11:17:46.087041 | 2025-09-30 11:17:46.087110 | TASK [validate-host : Collect information about zuul worker] 2025-09-30 11:17:46.831981 | controller | ok 2025-09-30 11:17:46.836869 | 2025-09-30 11:17:46.836939 | TASK [validate-host : Write out all zuul information for each host] 2025-09-30 11:17:48.512249 | controller -> localhost | changed 2025-09-30 11:17:48.530799 | 2025-09-30 11:17:48.530875 | TASK [include_role : prepare-workspace-openshift] 2025-09-30 11:17:48.640179 | controller | skipping: Conditional result was False 2025-09-30 11:17:48.645691 | 2025-09-30 11:17:48.645757 | TASK [include_role : remove-zuul-sshkey] 2025-09-30 11:17:48.700203 | controller | skipping: Conditional result was False 2025-09-30 11:17:48.706698 | 2025-09-30 11:17:48.706778 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-09-30 11:17:48.951748 | controller | ok: "logs" 2025-09-30 11:17:48.951954 | controller | ok: All items complete 2025-09-30 11:17:48.951986 | 2025-09-30 11:17:49.124896 | controller | ok: "artifacts" 2025-09-30 11:17:49.319895 | controller | ok: "docs" 2025-09-30 11:17:49.327636 | 2025-09-30 11:17:49.327733 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-09-30 11:17:49.687342 | controller | changed: "logs" 2025-09-30 11:17:49.887819 | controller | changed: "artifacts" 2025-09-30 11:17:50.089539 | controller | changed: "docs" 2025-09-30 11:17:50.148194 | 2025-09-30 11:17:50.148303 | PLAY RECAP 2025-09-30 11:17:50.148348 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-09-30 11:17:50.148379 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-30 11:17:50.148423 | 2025-09-30 11:17:50.585644 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-09-30 11:17:50.586373 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-09-30 11:17:53.003678 | 2025-09-30 11:17:53.003814 | PLAY [all] 2025-09-30 11:17:53.064417 | 2025-09-30 11:17:53.064505 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-09-30 11:17:53.244307 | controller | ok 2025-09-30 11:17:53.249492 | 2025-09-30 11:17:53.249570 | TASK [mirror-info-fork : Create /etc/ci] 2025-09-30 11:17:54.114255 | controller | changed 2025-09-30 11:17:54.122363 | 2025-09-30 11:17:54.122467 | TASK [mirror-info-fork : Install ci_mirror script] 2025-09-30 11:17:56.216298 | controller | changed 2025-09-30 11:17:56.242985 | 2025-09-30 11:17:56.243061 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-09-30 11:17:57.396835 | controller | changed: 2025-09-30 11:17:57.397002 | controller | { 2025-09-30 11:17:57.397034 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-09-30 11:17:57.397064 | controller | } 2025-09-30 11:17:57.637083 | controller | changed: 2025-09-30 11:17:57.637179 | controller | { 2025-09-30 11:17:57.637217 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-09-30 11:17:57.637246 | controller | } 2025-09-30 11:17:57.854308 | controller | changed: 2025-09-30 11:17:57.854396 | controller | { 2025-09-30 11:17:57.854430 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-09-30 11:17:57.854453 | controller | } 2025-09-30 11:17:58.109280 | controller | changed: 2025-09-30 11:17:58.109357 | controller | { 2025-09-30 11:17:58.109423 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-09-30 11:17:58.109454 | controller | } 2025-09-30 11:17:58.327134 | controller | changed: 2025-09-30 11:17:58.327235 | controller | { 2025-09-30 11:17:58.327262 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-09-30 11:17:58.327282 | controller | } 2025-09-30 11:17:58.544623 | controller | changed: 2025-09-30 11:17:58.544707 | controller | { 2025-09-30 11:17:58.544735 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-09-30 11:17:58.544756 | controller | } 2025-09-30 11:17:58.776013 | controller | changed: 2025-09-30 11:17:58.776097 | controller | { 2025-09-30 11:17:58.776125 | 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-09-30 11:17:58.776163 | controller | } 2025-09-30 11:17:59.040345 | controller | changed: 2025-09-30 11:17:59.040428 | controller | { 2025-09-30 11:17:59.040457 | 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-09-30 11:17:59.040479 | controller | } 2025-09-30 11:17:59.215135 | controller | changed: 2025-09-30 11:17:59.215236 | controller | { 2025-09-30 11:17:59.215263 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-09-30 11:17:59.215284 | controller | } 2025-09-30 11:17:59.434225 | controller | changed: 2025-09-30 11:17:59.434300 | controller | { 2025-09-30 11:17:59.434327 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-09-30 11:17:59.434347 | controller | } 2025-09-30 11:17:59.669343 | controller | changed: 2025-09-30 11:17:59.669444 | controller | { 2025-09-30 11:17:59.669472 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-09-30 11:17:59.669493 | controller | } 2025-09-30 11:17:59.902020 | controller | changed: 2025-09-30 11:17:59.902172 | controller | { 2025-09-30 11:17:59.902202 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-09-30 11:17:59.902223 | controller | } 2025-09-30 11:18:00.176300 | controller | changed: 2025-09-30 11:18:00.176396 | controller | { 2025-09-30 11:18:00.176428 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-09-30 11:18:00.176449 | controller | } 2025-09-30 11:18:00.424449 | controller | changed: 2025-09-30 11:18:00.424528 | controller | { 2025-09-30 11:18:00.424554 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-09-30 11:18:00.424575 | controller | } 2025-09-30 11:18:00.683249 | controller | changed: 2025-09-30 11:18:00.683324 | controller | { 2025-09-30 11:18:00.683350 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-09-30 11:18:00.683371 | controller | } 2025-09-30 11:18:00.920758 | controller | changed: 2025-09-30 11:18:00.920841 | controller | { 2025-09-30 11:18:00.920868 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-09-30 11:18:00.920888 | controller | } 2025-09-30 11:18:01.133936 | controller | changed: 2025-09-30 11:18:01.134017 | controller | { 2025-09-30 11:18:01.134044 | 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-09-30 11:18:01.134066 | controller | } 2025-09-30 11:18:01.406770 | controller | changed: 2025-09-30 11:18:01.406885 | controller | { 2025-09-30 11:18:01.406917 | 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-09-30 11:18:01.406965 | controller | } 2025-09-30 11:18:01.640370 | controller | changed: 2025-09-30 11:18:01.640471 | controller | { 2025-09-30 11:18:01.640499 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-09-30 11:18:01.640519 | controller | } 2025-09-30 11:18:01.892417 | controller | changed: 2025-09-30 11:18:01.892490 | controller | { 2025-09-30 11:18:01.892517 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-09-30 11:18:01.892538 | controller | } 2025-09-30 11:18:02.138298 | controller | changed: 2025-09-30 11:18:02.138375 | controller | { 2025-09-30 11:18:02.138440 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-09-30 11:18:02.138465 | controller | } 2025-09-30 11:18:02.382092 | controller | changed: 2025-09-30 11:18:02.382180 | controller | { 2025-09-30 11:18:02.382209 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-09-30 11:18:02.382230 | controller | } 2025-09-30 11:18:02.612193 | controller | changed: 2025-09-30 11:18:02.612270 | controller | { 2025-09-30 11:18:02.612300 | 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-09-30 11:18:02.612321 | controller | } 2025-09-30 11:18:02.872001 | controller | changed: 2025-09-30 11:18:02.872143 | controller | { 2025-09-30 11:18:02.872183 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-09-30 11:18:02.872205 | controller | } 2025-09-30 11:18:03.103727 | controller | changed: 2025-09-30 11:18:03.103804 | controller | { 2025-09-30 11:18:03.103830 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-09-30 11:18:03.103851 | controller | } 2025-09-30 11:18:03.329752 | controller | changed: 2025-09-30 11:18:03.329826 | controller | { 2025-09-30 11:18:03.329853 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-09-30 11:18:03.329874 | controller | } 2025-09-30 11:18:03.394513 | 2025-09-30 11:18:03.394726 | TASK [Set timezone to UTC] 2025-09-30 11:18:04.946922 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-09-30 11:18:04.951706 | 2025-09-30 11:18:04.951771 | TASK [Create nodepool directory] 2025-09-30 11:18:05.283068 | controller | changed 2025-09-30 11:18:05.301592 | 2025-09-30 11:18:05.301668 | TASK [Create nodepool sub_nodes file] 2025-09-30 11:18:06.151706 | controller | changed 2025-09-30 11:18:06.161182 | 2025-09-30 11:18:06.161252 | TASK [Create nodepool sub_nodes_private file] 2025-09-30 11:18:06.923172 | controller | changed 2025-09-30 11:18:06.930856 | 2025-09-30 11:18:06.930919 | LOOP [Populate nodepool sub_nodes file] 2025-09-30 11:18:07.026295 | 2025-09-30 11:18:07.031721 | LOOP [Populate nodepool sub_nodes_private file] 2025-09-30 11:18:07.163757 | 2025-09-30 11:18:07.163907 | TASK [Create nodepool primary file] 2025-09-30 11:18:07.250311 | controller | skipping: Conditional result was False 2025-09-30 11:18:07.255742 | 2025-09-30 11:18:07.255817 | TASK [Create nodepool node_private for this node] 2025-09-30 11:18:08.151764 | controller | changed 2025-09-30 11:18:08.168521 | 2025-09-30 11:18:08.168598 | LOOP [Copy ssh keys to nodepool directory] 2025-09-30 11:18:09.320591 | controller | ok: Item: id_rsa Runtime: 0:00:00.005594 2025-09-30 11:18:09.320810 | 2025-09-30 11:18:09.521171 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.004936 2025-09-30 11:18:09.535527 | 2025-09-30 11:18:09.535606 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-09-30 11:18:10.413747 | controller | changed 2025-09-30 11:18:10.419125 | 2025-09-30 11:18:10.419195 | TASK [Validate sudoers config after edits] 2025-09-30 11:18:10.901625 | controller | /etc/sudoers: parsed OK 2025-09-30 11:18:10.901710 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-09-30 11:18:10.901721 | controller | /etc/sudoers.d/zuul: parsed OK 2025-09-30 11:18:10.901727 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-09-30 11:18:11.070899 | controller | ok: Runtime: 0:00:00.005269 2025-09-30 11:18:11.076457 | 2025-09-30 11:18:11.076522 | TASK [Show the environment passed in to job shell scripts] 2025-09-30 11:18:11.532945 | controller | SHELL=/bin/bash 2025-09-30 11:18:11.532996 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-09-30 11:18:11.533009 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-09-30 11:18:11.533016 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/53/3353/70225949d764f12a7e698f7b0c4331d3defbb889^openstack-k8s-operators/ci-framework:main:refs/changes/33/3333/b461fc761ffaeed72eedc04b84a1fb92d251fe5d 2025-09-30 11:18:11.533024 | controller | PWD=/home/zuul 2025-09-30 11:18:11.533029 | controller | ZUUL_PIPELINE=github-check 2025-09-30 11:18:11.533035 | controller | LOGNAME=zuul 2025-09-30 11:18:11.533040 | controller | XDG_SESSION_TYPE=tty 2025-09-30 11:18:11.533072 | controller | _=/usr/bin/env 2025-09-30 11:18:11.533079 | controller | MOTD_SHOWN=pam 2025-09-30 11:18:11.533085 | controller | HOME=/home/zuul 2025-09-30 11:18:11.533090 | controller | LANG=en_US.UTF-8 2025-09-30 11:18:11.533095 | controller | SSH_CONNECTION=192.168.25.12 44268 192.168.25.168 22 2025-09-30 11:18:11.533100 | 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-09-30 11:18:11.533105 | controller | ZUUL_CHANGE_IDS=3353,70225949d764f12a7e698f7b0c4331d3defbb889 3333,b461fc761ffaeed72eedc04b84a1fb92d251fe5d 2025-09-30 11:18:11.533111 | controller | WORKSPACE=/home/zuul/workspace 2025-09-30 11:18:11.533116 | controller | XDG_SESSION_CLASS=user 2025-09-30 11:18:11.533121 | controller | SELINUX_ROLE_REQUESTED= 2025-09-30 11:18:11.533126 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-09-30 11:18:11.533131 | controller | USER=zuul 2025-09-30 11:18:11.533137 | controller | ZUUL_VOTING=True 2025-09-30 11:18:11.533142 | controller | BUILD_TIMEOUT=1800000 2025-09-30 11:18:11.533147 | controller | SELINUX_USE_CURRENT_RANGE= 2025-09-30 11:18:11.533152 | controller | SHLVL=1 2025-09-30 11:18:11.533157 | controller | ZUUL_PATCHSET=b461fc761ffaeed72eedc04b84a1fb92d251fe5d 2025-09-30 11:18:11.533162 | controller | XDG_SESSION_ID=1 2025-09-30 11:18:11.533167 | controller | ZUUL_BRANCH=main 2025-09-30 11:18:11.533173 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-09-30 11:18:11.533178 | controller | SSH_CLIENT=192.168.25.12 44268 22 2025-09-30 11:18:11.533183 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-09-30 11:18:11.533188 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-09-30 11:18:11.533193 | controller | which_declare=declare -f 2025-09-30 11:18:11.533198 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-09-30 11:18:11.533204 | controller | SELINUX_LEVEL_REQUESTED= 2025-09-30 11:18:11.533209 | controller | ZUUL_CHANGE=3333 2025-09-30 11:18:11.533214 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-09-30 11:18:11.533219 | controller | ZUUL_UUID=d8ec370de0f0412dadd4ba738e9ed9e9 2025-09-30 11:18:11.533225 | controller | BASH_FUNC_which%%=() { ( alias; 2025-09-30 11:18:11.533238 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-09-30 11:18:11.533243 | controller | } 2025-09-30 11:18:11.673742 | controller | ok: Runtime: 0:00:00.005599 2025-09-30 11:18:11.687263 | 2025-09-30 11:18:11.687330 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-09-30 11:18:11.734954 | controller | skipping: Conditional result was False 2025-09-30 11:18:11.740492 | 2025-09-30 11:18:11.740557 | TASK [Symlink /home/zuul-worker/workspace] 2025-09-30 11:18:12.421557 | controller | skipping: Conditional result was False 2025-09-30 11:18:12.440021 | 2025-09-30 11:18:12.440094 | TASK [Ensure legacy workspace directory] 2025-09-30 11:18:12.707584 | controller | changed 2025-09-30 11:18:12.790581 | 2025-09-30 11:18:12.790662 | PLAY RECAP 2025-09-30 11:18:12.790707 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-09-30 11:18:12.790731 | 2025-09-30 11:18:13.141140 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-09-30 11:18:13.142160 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-09-30 11:18:15.291316 | 2025-09-30 11:18:15.291429 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-09-30 11:18:15.362964 | 2025-09-30 11:18:15.363055 | TASK [Create zuul-output directory] 2025-09-30 11:18:16.318747 | controller | changed 2025-09-30 11:18:16.332460 | 2025-09-30 11:18:16.332541 | TASK [Slurp Zuul inventory test] 2025-09-30 11:18:17.431972 | controller -> localhost | ok 2025-09-30 11:18:17.441481 | 2025-09-30 11:18:17.441553 | TASK [Save zuul inventory] 2025-09-30 11:18:18.877349 | controller | changed 2025-09-30 11:18:18.886045 | 2025-09-30 11:18:18.886111 | TASK [Save zuul vars without the change_message] 2025-09-30 11:18:19.652485 | controller | changed 2025-09-30 11:18:19.716936 | 2025-09-30 11:18:19.717009 | PLAY RECAP 2025-09-30 11:18:19.717063 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-30 11:18:19.717089 | 2025-09-30 11:18:19.952920 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-09-30 11:18:19.953673 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-09-30 11:18:21.963096 | 2025-09-30 11:18:21.963209 | PLAY [Run ci/playbooks/molecule-prepare.yml] 2025-09-30 11:18:22.020185 | 2025-09-30 11:18:22.020280 | TASK [Execute mirror info role to configure /etc/ci/mirror_info.sh] 2025-09-30 11:18:22.099915 | controller | ok 2025-09-30 11:18:22.126031 | 2025-09-30 11:18:22.126122 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-09-30 11:18:22.187321 | controller | skipping: Conditional result was False 2025-09-30 11:18:22.193800 | 2025-09-30 11:18:22.193884 | TASK [mirror-info-fork : Create /etc/ci] 2025-09-30 11:18:22.797324 | controller | ok 2025-09-30 11:18:22.808813 | 2025-09-30 11:18:22.808906 | TASK [mirror-info-fork : Install ci_mirror script] 2025-09-30 11:18:23.901024 | controller | ok 2025-09-30 11:18:23.927700 | 2025-09-30 11:18:23.927787 | TASK [Prepare workspace] 2025-09-30 11:18:23.995720 | controller | ok 2025-09-30 11:18:24.036757 | 2025-09-30 11:18:24.036853 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-09-30 11:18:24.599885 | controller | ok 2025-09-30 11:18:24.605775 | 2025-09-30 11:18:24.605841 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-09-30 11:18:31.279107 | controller | Output suppressed because no_log was given 2025-09-30 11:18:31.302257 | 2025-09-30 11:18:31.302345 | LOOP [Create zuul-output directory] 2025-09-30 11:18:31.549963 | controller | changed: "/home/zuul/ci-framework-data/logs" 2025-09-30 11:18:31.723636 | controller | ok: "/home/zuul/zuul-output/logs" 2025-09-30 11:18:31.733782 | 2025-09-30 11:18:31.733870 | TASK [Install required packages] 2025-09-30 11:19:34.212423 | controller | changed 2025-09-30 11:19:34.217617 | 2025-09-30 11:19:34.217685 | TASK [Install venv] 2025-09-30 11:20:37.904804 | controller | changed 2025-09-30 11:20:37.930940 | 2025-09-30 11:20:37.931061 | PLAY RECAP 2025-09-30 11:20:37.931121 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-09-30 11:20:37.931161 | 2025-09-30 11:20:38.014170 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-prepare.yml@main] 2025-09-30 11:20:38.014981 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-09-30 11:20:38.611902 | 2025-09-30 11:20:38.612124 | PLAY [Run ci/playbooks/molecule-test.yml] 2025-09-30 11:20:38.635921 | 2025-09-30 11:20:38.636046 | TASK [Gather required facts] 2025-09-30 11:20:39.147539 | controller | ok 2025-09-30 11:20:39.153184 | 2025-09-30 11:20:39.153264 | TASK [Load environment var if instructed to] 2025-09-30 11:20:39.178459 | controller | skipping: Conditional result was False 2025-09-30 11:20:39.185191 | 2025-09-30 11:20:39.185271 | TASK [Run molecule] 2025-09-30 11:20:40.182114 | controller | INFO Found config file /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/.config/molecule/config.yml 2025-09-30 11:20:40.251211 | controller | INFO Performing prerun with role_name_check=0... 2025-09-30 11:20:57.562298 | controller | WARNING Another version of '@NAMESPACE@.@NAME@' 3.1.4 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 3.1.4 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.563004 | controller | WARNING Another version of 'ansible.netcommon' 7.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 7.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.563577 | controller | WARNING Another version of 'ansible.posix' 1.6.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.6.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.564126 | controller | WARNING Another version of 'ansible.utils' 5.1.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.1.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.564655 | controller | WARNING Another version of 'cifmw.general' 1.0.0+f3b7a729 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0+f3b7a729 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.565181 | controller | WARNING Another version of 'cisco.ios' 9.0.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.0.3 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.565671 | controller | WARNING Another version of 'community.crypto' 2.22.3 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.22.3 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.566188 | controller | WARNING Another version of 'community.general' 10.0.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 10.0.1 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.566666 | controller | WARNING Another version of 'community.libvirt' 1.3.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.3.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.567201 | controller | WARNING Another version of 'community.okd' 4.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 4.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.567685 | controller | WARNING Another version of 'containers.podman' 1.16.2 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.16.2 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.568188 | controller | WARNING Another version of 'junipernetworks.junos' 9.1.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 9.1.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.568661 | controller | WARNING Another version of 'kubernetes.core' 5.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 5.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.569156 | controller | WARNING Another version of 'mellanox.onyx' 1.0.0 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 1.0.0 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.569630 | controller | WARNING Another version of 'openstack.config_template' 2.1.1 was found installed in /home/zuul/.cache/ansible-compat/9b0c27/collections/ansible_collections, only the first one will be used, 2.1.1 (/home/zuul/.ansible/collections/ansible_collections). 2025-09-30 11:20:57.579614 | controller | INFO Running default > prepare 2025-09-30 11:20:58.282496 | controller | 2025-09-30 11:20:59.122956 | controller | PLAY [Prepare] ***************************************************************** 2025-09-30 11:20:59.123020 | controller | 2025-09-30 11:20:59.123029 | controller | TASK [Gathering Facts] ********************************************************* 2025-09-30 11:20:59.123035 | controller | Tuesday 30 September 2025 11:20:58 +0000 (0:00:00.019) 0:00:00.019 ***** 2025-09-30 11:20:59.123045 | controller | ok: [instance] 2025-09-30 11:20:59.140437 | controller | 2025-09-30 11:20:59.140458 | controller | TASK [test_deps : Gather facts if they don't exist] **************************** 2025-09-30 11:20:59.140466 | controller | Tuesday 30 September 2025 11:20:59 +0000 (0:00:00.841) 0:00:00.860 ***** 2025-09-30 11:20:59.140476 | controller | skipping: [instance] 2025-09-30 11:20:59.171890 | controller | 2025-09-30 11:20:59.171914 | controller | TASK [test_deps : Gather variables for each operating system] ****************** 2025-09-30 11:20:59.171924 | controller | Tuesday 30 September 2025 11:20:59 +0000 (0:00:00.017) 0:00:00.878 ***** 2025-09-30 11:20:59.171935 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/test_deps/vars/centos-9.yml) 2025-09-30 11:20:59.445340 | controller | 2025-09-30 11:20:59.445371 | controller | TASK [test_deps : Detect mirrors file] ***************************************** 2025-09-30 11:20:59.445379 | controller | Tuesday 30 September 2025 11:20:59 +0000 (0:00:00.031) 0:00:00.909 ***** 2025-09-30 11:20:59.445389 | controller | ok: [instance] 2025-09-30 11:20:59.746569 | controller | 2025-09-30 11:20:59.746601 | controller | TASK [test_deps : Disable ubi host subscription-manager integration] *********** 2025-09-30 11:20:59.746609 | controller | Tuesday 30 September 2025 11:20:59 +0000 (0:00:00.273) 0:00:01.183 ***** 2025-09-30 11:20:59.746619 | controller | ok: [instance] 2025-09-30 11:21:00.435327 | controller | 2025-09-30 11:21:00.435356 | controller | TASK [test_deps : Disable ubi 9 repos] ***************************************** 2025-09-30 11:21:00.435364 | controller | Tuesday 30 September 2025 11:20:59 +0000 (0:00:00.301) 0:00:01.484 ***** 2025-09-30 11:21:00.435374 | controller | ok: [instance] => (item=ubi-9-appstream) 2025-09-30 11:21:00.493384 | controller | ok: [instance] => (item=ubi-9-baseos) 2025-09-30 11:21:00.493409 | controller | ok: [instance] => (item=ubi-9-codeready-builder) 2025-09-30 11:21:00.493419 | controller | 2025-09-30 11:21:00.493426 | controller | TASK [Deploy repo-setup] ******************************************************* 2025-09-30 11:21:00.493433 | controller | Tuesday 30 September 2025 11:21:00 +0000 (0:00:00.688) 0:00:02.173 ***** 2025-09-30 11:21:00.493443 | controller | 2025-09-30 11:21:01.025417 | controller | TASK [repo_setup : Ensure directories are present] ***************************** 2025-09-30 11:21:01.025449 | controller | Tuesday 30 September 2025 11:21:00 +0000 (0:00:00.058) 0:00:02.231 ***** 2025-09-30 11:21:01.025461 | controller | changed: [instance] => (item=tmp) 2025-09-30 11:21:01.805546 | controller | changed: [instance] => (item=artifacts/repositories) 2025-09-30 11:21:01.805582 | controller | changed: [instance] => (item=venv/repo_setup) 2025-09-30 11:21:01.805595 | controller | 2025-09-30 11:21:01.805601 | controller | TASK [repo_setup : Make sure git-core package is installed] ******************** 2025-09-30 11:21:01.805607 | controller | Tuesday 30 September 2025 11:21:01 +0000 (0:00:00.531) 0:00:02.763 ***** 2025-09-30 11:21:01.805617 | controller | ok: [instance] 2025-09-30 11:21:03.024793 | controller | 2025-09-30 11:21:03.024825 | controller | TASK [repo_setup : Get repo-setup repository] ********************************** 2025-09-30 11:21:03.024834 | controller | Tuesday 30 September 2025 11:21:01 +0000 (0:00:00.780) 0:00:03.543 ***** 2025-09-30 11:21:03.024844 | controller | changed: [instance] 2025-09-30 11:21:10.940515 | controller | 2025-09-30 11:21:10.940553 | controller | TASK [repo_setup : Initialize python venv and install requirements] ************ 2025-09-30 11:21:10.940564 | controller | Tuesday 30 September 2025 11:21:03 +0000 (0:00:01.219) 0:00:04.762 ***** 2025-09-30 11:21:10.940574 | controller | changed: [instance] 2025-09-30 11:21:11.641251 | controller | 2025-09-30 11:21:11.641293 | controller | TASK [repo_setup : Install repo-setup package] ********************************* 2025-09-30 11:21:11.641302 | controller | Tuesday 30 September 2025 11:21:10 +0000 (0:00:07.915) 0:00:12.678 ***** 2025-09-30 11:21:11.641312 | controller | changed: [instance] 2025-09-30 11:21:11.662057 | controller | 2025-09-30 11:21:11.662093 | controller | TASK [repo_setup : Set cifmw_repo_setup_dlrn_hash_tag from content provider] *** 2025-09-30 11:21:11.662101 | controller | Tuesday 30 September 2025 11:21:11 +0000 (0:00:00.700) 0:00:13.379 ***** 2025-09-30 11:21:11.662112 | controller | skipping: [instance] 2025-09-30 11:21:11.662135 | controller | 2025-09-30 11:21:11.662143 | controller | TASK [repo_setup : Run repo-setup] ********************************************* 2025-09-30 11:21:11.662273 | controller | Tuesday 30 September 2025 11:21:11 +0000 (0:00:00.021) 0:00:13.400 ***** 2025-09-30 11:21:12.476762 | controller | changed: [instance] 2025-09-30 11:21:12.502039 | controller | 2025-09-30 11:21:12.502066 | controller | TASK [repo_setup : Get component repo] ***************************************** 2025-09-30 11:21:12.502073 | controller | Tuesday 30 September 2025 11:21:12 +0000 (0:00:00.814) 0:00:14.214 ***** 2025-09-30 11:21:12.502083 | controller | skipping: [instance] 2025-09-30 11:21:12.502104 | controller | 2025-09-30 11:21:12.502112 | controller | TASK [repo_setup : Rename component repo] ************************************** 2025-09-30 11:21:12.502245 | controller | Tuesday 30 September 2025 11:21:12 +0000 (0:00:00.025) 0:00:14.240 ***** 2025-09-30 11:21:12.527637 | controller | skipping: [instance] 2025-09-30 11:21:12.552440 | controller | 2025-09-30 11:21:12.552467 | controller | TASK [repo_setup : Disable component repo in current-podified dlrn repo] ******* 2025-09-30 11:21:12.552475 | controller | Tuesday 30 September 2025 11:21:12 +0000 (0:00:00.025) 0:00:14.265 ***** 2025-09-30 11:21:12.552486 | controller | skipping: [instance] 2025-09-30 11:21:13.087936 | controller | 2025-09-30 11:21:13.087991 | controller | TASK [repo_setup : Run repo-setup-get-hash] ************************************ 2025-09-30 11:21:13.088005 | controller | Tuesday 30 September 2025 11:21:12 +0000 (0:00:00.025) 0:00:14.290 ***** 2025-09-30 11:21:13.088016 | controller | changed: [instance] 2025-09-30 11:21:13.522107 | controller | 2025-09-30 11:21:13.522139 | controller | TASK [repo_setup : Dump full hash in delorean.repo.md5 file] ******************* 2025-09-30 11:21:13.522147 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.535) 0:00:14.825 ***** 2025-09-30 11:21:13.522157 | controller | changed: [instance] 2025-09-30 11:21:13.539550 | controller | 2025-09-30 11:21:13.539577 | controller | TASK [repo_setup : Dump current-podified hash] ********************************* 2025-09-30 11:21:13.539586 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.434) 0:00:15.259 ***** 2025-09-30 11:21:13.539597 | controller | skipping: [instance] 2025-09-30 11:21:13.557331 | controller | 2025-09-30 11:21:13.557348 | controller | TASK [repo_setup : Slurp current podified hash] ******************************** 2025-09-30 11:21:13.557355 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.017) 0:00:15.277 ***** 2025-09-30 11:21:13.557367 | controller | skipping: [instance] 2025-09-30 11:21:13.575011 | controller | 2025-09-30 11:21:13.575029 | controller | TASK [repo_setup : Update the value of full_hash] ****************************** 2025-09-30 11:21:13.575036 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.017) 0:00:15.295 ***** 2025-09-30 11:21:13.575045 | controller | skipping: [instance] 2025-09-30 11:21:13.603048 | controller | 2025-09-30 11:21:13.603081 | controller | TASK [repo_setup : Export hashes facts for further use] ************************ 2025-09-30 11:21:13.603089 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.017) 0:00:15.313 ***** 2025-09-30 11:21:13.603100 | controller | ok: [instance] 2025-09-30 11:21:13.603125 | controller | 2025-09-30 11:21:13.603348 | controller | TASK [repo_setup : Create download directory] ********************************** 2025-09-30 11:21:13.620660 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.028) 0:00:15.341 ***** 2025-09-30 11:21:13.620681 | controller | skipping: [instance] 2025-09-30 11:21:13.637395 | controller | 2025-09-30 11:21:13.637412 | controller | TASK [repo_setup : Print the URL to request] *********************************** 2025-09-30 11:21:13.637419 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.017) 0:00:15.358 ***** 2025-09-30 11:21:13.637434 | controller | skipping: [instance] 2025-09-30 11:21:13.653476 | controller | 2025-09-30 11:21:13.653493 | controller | TASK [Download the RPM] ******************************************************** 2025-09-30 11:21:13.653500 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.016) 0:00:15.375 ***** 2025-09-30 11:21:13.653509 | controller | skipping: [instance] 2025-09-30 11:21:13.668848 | controller | 2025-09-30 11:21:13.668868 | controller | TASK [repo_setup : Install RHOS Release tool] ********************************** 2025-09-30 11:21:13.668877 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.016) 0:00:15.391 ***** 2025-09-30 11:21:13.668887 | controller | skipping: [instance] 2025-09-30 11:21:13.683862 | controller | 2025-09-30 11:21:13.683882 | controller | TASK [repo_setup : Get rhos-release tool version] ****************************** 2025-09-30 11:21:13.683890 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.015) 0:00:15.407 ***** 2025-09-30 11:21:13.683900 | controller | skipping: [instance] 2025-09-30 11:21:13.700666 | controller | 2025-09-30 11:21:13.700684 | controller | TASK [repo_setup : Print rhos-release tool version] **************************** 2025-09-30 11:21:13.700690 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.014) 0:00:15.422 ***** 2025-09-30 11:21:13.700698 | controller | skipping: [instance] 2025-09-30 11:21:13.715307 | controller | 2025-09-30 11:21:13.715323 | controller | TASK [repo_setup : Generate repos using rhos-release {{ cifmw_repo_setup_rhos_release_args }}] *** 2025-09-30 11:21:13.715330 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.016) 0:00:15.439 ***** 2025-09-30 11:21:13.715339 | controller | skipping: [instance] 2025-09-30 11:21:13.897731 | controller | 2025-09-30 11:21:13.897764 | controller | TASK [repo_setup : Check for /etc/ci/mirror_info.sh] *************************** 2025-09-30 11:21:13.897772 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.014) 0:00:15.453 ***** 2025-09-30 11:21:13.897783 | controller | ok: [instance] 2025-09-30 11:21:14.109497 | controller | 2025-09-30 11:21:14.109529 | controller | TASK [repo_setup : Use RDO proxy mirrors] ************************************** 2025-09-30 11:21:14.109537 | controller | Tuesday 30 September 2025 11:21:13 +0000 (0:00:00.181) 0:00:15.635 ***** 2025-09-30 11:21:14.109546 | controller | changed: [instance] 2025-09-30 11:21:14.324678 | controller | 2025-09-30 11:21:14.324711 | controller | TASK [repo_setup : Use RDO CentOS mirrors (remove CentOS 10 conditional when Nodepool mirrors exist)] *** 2025-09-30 11:21:14.324719 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.211) 0:00:15.847 ***** 2025-09-30 11:21:14.324729 | controller | changed: [instance] 2025-09-30 11:21:14.344708 | controller | 2025-09-30 11:21:14.344731 | controller | TASK [repo_setup : Check for gating.repo file on content provider] ************* 2025-09-30 11:21:14.344737 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.215) 0:00:16.062 ***** 2025-09-30 11:21:14.344746 | controller | skipping: [instance] 2025-09-30 11:21:14.366281 | controller | 2025-09-30 11:21:14.366307 | controller | TASK [repo_setup : Populate gating repo from content provider ip] ************** 2025-09-30 11:21:14.366315 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.083 ***** 2025-09-30 11:21:14.366325 | controller | skipping: [instance] 2025-09-30 11:21:14.386826 | controller | 2025-09-30 11:21:14.386845 | controller | TASK [repo_setup : Check for DLRN repo at the destination] ********************* 2025-09-30 11:21:14.386852 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.021) 0:00:16.104 ***** 2025-09-30 11:21:14.386860 | controller | skipping: [instance] 2025-09-30 11:21:14.407103 | controller | 2025-09-30 11:21:14.407136 | controller | TASK [repo_setup : Lower the priority of DLRN repos to allow installation from gating repo] *** 2025-09-30 11:21:14.407145 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.125 ***** 2025-09-30 11:21:14.407155 | controller | skipping: [instance] 2025-09-30 11:21:14.407179 | controller | 2025-09-30 11:21:14.407188 | controller | TASK [repo_setup : Check for DLRN component repo] ****************************** 2025-09-30 11:21:14.407289 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.145 ***** 2025-09-30 11:21:14.427497 | controller | skipping: [instance] 2025-09-30 11:21:14.427650 | controller | 2025-09-30 11:21:14.427802 | controller | TASK [repo_setup : Lower the priority of componennt repos to allow installation from gating repo] *** 2025-09-30 11:21:14.428005 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.166 ***** 2025-09-30 11:21:14.448788 | controller | skipping: [instance] 2025-09-30 11:21:14.449016 | controller | 2025-09-30 11:21:14.449199 | controller | TASK [repo_setup : Find existing repos from /etc/yum.repos.d directory] ******** 2025-09-30 11:21:14.449374 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.021) 0:00:16.187 ***** 2025-09-30 11:21:14.463637 | controller | skipping: [instance] 2025-09-30 11:21:14.463785 | controller | 2025-09-30 11:21:14.463949 | controller | TASK [repo_setup : Remove existing repos from /etc/yum.repos.d directory] ****** 2025-09-30 11:21:14.464117 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.014) 0:00:16.202 ***** 2025-09-30 11:21:14.481357 | controller | skipping: [instance] 2025-09-30 11:21:14.481547 | controller | 2025-09-30 11:21:14.481733 | controller | TASK [repo_setup : Cleanup existing metadata] ********************************** 2025-09-30 11:21:14.481900 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.017) 0:00:16.219 ***** 2025-09-30 11:21:14.496288 | controller | skipping: [instance] 2025-09-30 11:21:14.496481 | controller | 2025-09-30 11:21:14.496662 | controller | TASK [repo_setup : Copy generated repos to /etc/yum.repos.d directory] ********* 2025-09-30 11:21:14.496843 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.014) 0:00:16.234 ***** 2025-09-30 11:21:14.515014 | controller | skipping: [instance] 2025-09-30 11:21:14.515165 | controller | 2025-09-30 11:21:14.515323 | controller | TASK [test_deps : Look for redhat-release rpm] ********************************* 2025-09-30 11:21:14.515486 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.018) 0:00:16.253 ***** 2025-09-30 11:21:14.535602 | controller | skipping: [instance] 2025-09-30 11:21:14.556427 | controller | 2025-09-30 11:21:14.556455 | controller | TASK [test_deps : Remove redhat-release] *************************************** 2025-09-30 11:21:14.556465 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.273 ***** 2025-09-30 11:21:14.556477 | controller | skipping: [instance] 2025-09-30 11:21:14.577084 | controller | 2025-09-30 11:21:14.577108 | controller | TASK [test_deps : Install centos-stream-release] ******************************* 2025-09-30 11:21:14.577125 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.021) 0:00:16.294 ***** 2025-09-30 11:21:14.577136 | controller | skipping: [instance] 2025-09-30 11:21:14.577156 | controller | 2025-09-30 11:21:14.577166 | controller | TASK [test_deps : Install additional packages] ********************************* 2025-09-30 11:21:14.577284 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.315 ***** 2025-09-30 11:21:14.598042 | controller | skipping: [instance] 2025-09-30 11:21:14.598088 | controller | 2025-09-30 11:21:14.598098 | controller | TASK [test_deps : Install selinux python libs] ********************************* 2025-09-30 11:21:14.598256 | controller | Tuesday 30 September 2025 11:21:14 +0000 (0:00:00.020) 0:00:16.336 ***** 2025-09-30 11:21:58.173046 | controller | ok: [instance] 2025-09-30 11:21:58.173205 | controller | 2025-09-30 11:21:58.173217 | controller | TASK [test_deps : Install python yaml libs] ************************************ 2025-09-30 11:21:58.173227 | controller | Tuesday 30 September 2025 11:21:58 +0000 (0:00:43.574) 0:00:59.911 ***** 2025-09-30 11:21:59.347045 | controller | ok: [instance] 2025-09-30 11:21:59.369026 | controller | 2025-09-30 11:21:59.369048 | controller | TASK [test_deps : Install extra packages] ************************************** 2025-09-30 11:21:59.369057 | controller | Tuesday 30 September 2025 11:21:59 +0000 (0:00:01.173) 0:01:01.085 ***** 2025-09-30 11:21:59.369068 | controller | skipping: [instance] 2025-09-30 11:21:59.369115 | controller | 2025-09-30 11:21:59.369131 | controller | TASK [ci_setup : Gather variables for each operating system] ******************* 2025-09-30 11:21:59.369140 | controller | Tuesday 30 September 2025 11:21:59 +0000 (0:00:00.022) 0:01:01.107 ***** 2025-09-30 11:21:59.401029 | controller | ok: [instance] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml) 2025-09-30 11:21:59.401070 | controller | 2025-09-30 11:21:59.401292 | controller | TASK [ci_setup : List packages to install] ************************************* 2025-09-30 11:21:59.420009 | controller | Tuesday 30 September 2025 11:21:59 +0000 (0:00:00.032) 0:01:01.139 ***** 2025-09-30 11:21:59.420032 | controller | ok: [instance] => 2025-09-30 11:21:59.421010 | controller | cifmw_ci_setup_packages: 2025-09-30 11:21:59.421181 | controller | - bash-completion 2025-09-30 11:21:59.421196 | controller | - ca-certificates 2025-09-30 11:21:59.421203 | controller | - git-core 2025-09-30 11:21:59.421209 | controller | - make 2025-09-30 11:21:59.421215 | controller | - tar 2025-09-30 11:21:59.421220 | controller | - tmux 2025-09-30 11:21:59.421225 | controller | - python3-pip 2025-09-30 11:21:59.421231 | controller | 2025-09-30 11:21:59.421239 | controller | TASK [ci_setup : Install needed packages] ************************************** 2025-09-30 11:22:03.693842 | controller | Tuesday 30 September 2025 11:21:59 +0000 (0:00:00.018) 0:01:01.158 ***** 2025-09-30 11:22:03.693876 | controller | changed: [instance] 2025-09-30 11:22:03.880084 | controller | 2025-09-30 11:22:03.880122 | controller | TASK [ci_setup : Gather version of openshift client] *************************** 2025-09-30 11:22:03.880140 | controller | Tuesday 30 September 2025 11:22:03 +0000 (0:00:04.273) 0:01:05.431 ***** 2025-09-30 11:22:03.880153 | controller | ok: [instance] 2025-09-30 11:22:03.880180 | controller | 2025-09-30 11:22:03.880190 | controller | TASK [ci_setup : Ensure openshift client install path is present] ************** 2025-09-30 11:22:03.880214 | controller | Tuesday 30 September 2025 11:22:03 +0000 (0:00:00.186) 0:01:05.618 ***** 2025-09-30 11:22:04.068554 | controller | changed: [instance] 2025-09-30 11:22:09.869447 | controller | 2025-09-30 11:22:09.869479 | controller | TASK [ci_setup : Install openshift client] ************************************* 2025-09-30 11:22:09.869487 | controller | Tuesday 30 September 2025 11:22:04 +0000 (0:00:00.188) 0:01:05.806 ***** 2025-09-30 11:22:09.869497 | controller | changed: [instance] 2025-09-30 11:22:09.897200 | controller | 2025-09-30 11:22:09.897224 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed] ********************** 2025-09-30 11:22:09.897232 | controller | Tuesday 30 September 2025 11:22:09 +0000 (0:00:05.800) 0:01:11.607 ***** 2025-09-30 11:22:09.897241 | controller | ok: [instance] 2025-09-30 11:22:10.154812 | controller | 2025-09-30 11:22:10.154843 | controller | TASK [ci_setup : Create completion file] *************************************** 2025-09-30 11:22:10.154851 | controller | Tuesday 30 September 2025 11:22:09 +0000 (0:00:00.027) 0:01:11.635 ***** 2025-09-30 11:22:10.154860 | controller | changed: [instance] 2025-09-30 11:22:10.427317 | controller | 2025-09-30 11:22:10.427346 | controller | TASK [ci_setup : Source completion from within .bashrc] ************************ 2025-09-30 11:22:10.427354 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.257) 0:01:11.892 ***** 2025-09-30 11:22:10.427364 | controller | changed: [instance] 2025-09-30 11:22:10.444642 | controller | 2025-09-30 11:22:10.444670 | controller | TASK [ci_setup : Check rhsm status] ******************************************** 2025-09-30 11:22:10.444678 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.272) 0:01:12.165 ***** 2025-09-30 11:22:10.444688 | controller | skipping: [instance] 2025-09-30 11:22:10.461777 | controller | 2025-09-30 11:22:10.461802 | controller | TASK [ci_setup : Gather the repos to be enabled] ******************************* 2025-09-30 11:22:10.461810 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.017) 0:01:12.182 ***** 2025-09-30 11:22:10.461820 | controller | skipping: [instance] 2025-09-30 11:22:10.478730 | controller | 2025-09-30 11:22:10.478753 | controller | TASK [ci_setup : Enabling the required repositories.] ************************** 2025-09-30 11:22:10.478761 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.017) 0:01:12.199 ***** 2025-09-30 11:22:10.478771 | controller | skipping: [instance] 2025-09-30 11:22:10.494873 | controller | 2025-09-30 11:22:10.494897 | controller | TASK [ci_setup : Get current /etc/redhat-release] ****************************** 2025-09-30 11:22:10.494906 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.017) 0:01:12.216 ***** 2025-09-30 11:22:10.494915 | controller | skipping: [instance] 2025-09-30 11:22:10.511782 | controller | 2025-09-30 11:22:10.511805 | controller | TASK [ci_setup : Print current /etc/redhat-release] **************************** 2025-09-30 11:22:10.511813 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.016) 0:01:12.233 ***** 2025-09-30 11:22:10.511823 | controller | skipping: [instance] 2025-09-30 11:22:10.534016 | controller | 2025-09-30 11:22:10.534038 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum] ********* 2025-09-30 11:22:10.534053 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.016) 0:01:12.250 ***** 2025-09-30 11:22:10.534063 | controller | skipping: [instance] 2025-09-30 11:22:11.494031 | controller | 2025-09-30 11:22:11.494060 | controller | TASK [ci_setup : Manage directories] ******************************************* 2025-09-30 11:22:11.494068 | controller | Tuesday 30 September 2025 11:22:10 +0000 (0:00:00.022) 0:01:12.272 ***** 2025-09-30 11:22:11.494078 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr) 2025-09-30 11:22:11.684437 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/logs) 2025-09-30 11:22:11.684466 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/tmp) 2025-09-30 11:22:11.684474 | controller | changed: [instance] => (item=/home/zuul/ci-framework-data/volumes) 2025-09-30 11:22:11.684480 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/parameters) 2025-09-30 11:22:11.684486 | controller | 2025-09-30 11:22:11.684492 | controller | TASK [Ensure directory exists] ************************************************* 2025-09-30 11:22:11.684497 | controller | Tuesday 30 September 2025 11:22:11 +0000 (0:00:00.959) 0:01:13.231 ***** 2025-09-30 11:22:11.684526 | controller | changed: [instance] 2025-09-30 11:22:12.039032 | controller | 2025-09-30 11:22:12.039062 | controller | TASK [Create nova migration keypair] ******************************************* 2025-09-30 11:22:12.039070 | controller | Tuesday 30 September 2025 11:22:11 +0000 (0:00:00.190) 0:01:13.422 ***** 2025-09-30 11:22:12.039080 | controller | changed: [instance] 2025-09-30 11:22:12.039296 | controller | 2025-09-30 11:22:12.039309 | controller | PLAY [Download tools] ********************************************************** 2025-09-30 11:22:12.039315 | controller | 2025-09-30 11:22:12.039328 | controller | TASK [Gathering Facts] ********************************************************* 2025-09-30 11:22:12.625062 | controller | Tuesday 30 September 2025 11:22:12 +0000 (0:00:00.354) 0:01:13.777 ***** 2025-09-30 11:22:12.625159 | controller | ok: [localhost] 2025-09-30 11:22:18.533712 | controller | 2025-09-30 11:22:18.533745 | controller | TASK [download_tools : Install build dependencies] ***************************** 2025-09-30 11:22:18.533754 | controller | Tuesday 30 September 2025 11:22:12 +0000 (0:00:00.585) 0:01:14.362 ***** 2025-09-30 11:22:18.533764 | controller | changed: [localhost] 2025-09-30 11:22:18.533814 | controller | 2025-09-30 11:22:18.534260 | controller | TASK [download_tools : Set opm download url suffix] **************************** 2025-09-30 11:22:18.554863 | controller | Tuesday 30 September 2025 11:22:18 +0000 (0:00:05.909) 0:01:20.272 ***** 2025-09-30 11:22:18.554892 | controller | skipping: [localhost] 2025-09-30 11:22:18.554902 | controller | 2025-09-30 11:22:18.555048 | controller | TASK [download_tools : Set opm download url suffix] **************************** 2025-09-30 11:22:18.555177 | controller | Tuesday 30 September 2025 11:22:18 +0000 (0:00:00.021) 0:01:20.293 ***** 2025-09-30 11:22:18.580671 | controller | ok: [localhost] 2025-09-30 11:22:18.767076 | controller | 2025-09-30 11:22:18.767133 | controller | TASK [download_tools : Create $HOME/bin dir] *********************************** 2025-09-30 11:22:18.767142 | controller | Tuesday 30 September 2025 11:22:18 +0000 (0:00:00.025) 0:01:20.318 ***** 2025-09-30 11:22:18.767155 | controller | ok: [localhost] 2025-09-30 11:22:18.773172 | controller | 2025-09-30 11:22:18.773213 | controller | TASK [download_tools : Download opm] ******************************************* 2025-09-30 11:22:20.224983 | controller | Tuesday 30 September 2025 11:22:18 +0000 (0:00:00.183) 0:01:20.502 ***** 2025-09-30 11:22:20.225031 | controller | changed: [localhost] 2025-09-30 11:22:20.245468 | controller | 2025-09-30 11:22:20.245489 | controller | TASK [download_tools : Get version from sdk_version] *************************** 2025-09-30 11:22:20.245497 | controller | Tuesday 30 September 2025 11:22:20 +0000 (0:00:01.459) 0:01:21.962 ***** 2025-09-30 11:22:20.245506 | controller | ok: [localhost] 2025-09-30 11:22:20.266045 | controller | 2025-09-30 11:22:20.266070 | controller | TASK [download_tools : Set operator-sdk file for version < 1.3.0] ************** 2025-09-30 11:22:20.266079 | controller | Tuesday 30 September 2025 11:22:20 +0000 (0:00:00.021) 0:01:21.983 ***** 2025-09-30 11:22:20.266090 | controller | skipping: [localhost] 2025-09-30 11:22:20.266115 | controller | 2025-09-30 11:22:20.266135 | controller | TASK [download_tools : Set operator-sdk file for version >= 1.3.0] ************* 2025-09-30 11:22:20.266251 | controller | Tuesday 30 September 2025 11:22:20 +0000 (0:00:00.020) 0:01:22.004 ***** 2025-09-30 11:22:20.288526 | controller | ok: [localhost] 2025-09-30 11:22:21.749531 | controller | 2025-09-30 11:22:21.749561 | controller | TASK [download_tools : Download operator-sdk] ********************************** 2025-09-30 11:22:21.749569 | controller | Tuesday 30 September 2025 11:22:20 +0000 (0:00:00.022) 0:01:22.026 ***** 2025-09-30 11:22:21.749579 | controller | changed: [localhost] 2025-09-30 11:22:22.776715 | controller | 2025-09-30 11:22:22.776745 | controller | TASK [download_tools : Download and extract kustomize] ************************* 2025-09-30 11:22:22.776753 | controller | Tuesday 30 September 2025 11:22:21 +0000 (0:00:01.460) 0:01:23.487 ***** 2025-09-30 11:22:22.776764 | controller | changed: [localhost] 2025-09-30 11:22:23.154552 | controller | 2025-09-30 11:22:23.154615 | controller | TASK [download_tools : Download kubectl] *************************************** 2025-09-30 11:22:23.154625 | controller | Tuesday 30 September 2025 11:22:22 +0000 (0:00:01.027) 0:01:24.514 ***** 2025-09-30 11:22:23.154638 | controller | ok: [localhost] 2025-09-30 11:22:24.198589 | controller | 2025-09-30 11:22:24.198620 | controller | TASK [download_tools : Download kuttl] ***************************************** 2025-09-30 11:22:24.198628 | controller | Tuesday 30 September 2025 11:22:23 +0000 (0:00:00.377) 0:01:24.891 ***** 2025-09-30 11:22:24.198638 | controller | changed: [localhost] 2025-09-30 11:22:27.225730 | controller | 2025-09-30 11:22:27.225761 | controller | TASK [download_tools : Download chainsaw] ************************************** 2025-09-30 11:22:27.225769 | controller | Tuesday 30 September 2025 11:22:24 +0000 (0:00:01.044) 0:01:25.936 ***** 2025-09-30 11:22:27.225779 | controller | changed: [localhost] 2025-09-30 11:22:28.389880 | controller | 2025-09-30 11:22:28.389911 | controller | TASK [download_tools : Download and extract yq] ******************************** 2025-09-30 11:22:28.389919 | controller | Tuesday 30 September 2025 11:22:27 +0000 (0:00:03.027) 0:01:28.963 ***** 2025-09-30 11:22:28.389929 | controller | changed: [localhost] 2025-09-30 11:22:28.569056 | controller | 2025-09-30 11:22:28.569086 | controller | TASK [download_tools : Link yq_linux_amd64 as yq] ****************************** 2025-09-30 11:22:28.569100 | controller | Tuesday 30 September 2025 11:22:28 +0000 (0:00:01.164) 0:01:30.127 ***** 2025-09-30 11:22:28.569111 | controller | changed: [localhost] 2025-09-30 11:22:28.569136 | controller | 2025-09-30 11:22:28.569405 | controller | TASK [download_tools : Deinstall golang] *************************************** 2025-09-30 11:22:30.066799 | controller | Tuesday 30 September 2025 11:22:28 +0000 (0:00:00.179) 0:01:30.307 ***** 2025-09-30 11:22:30.066834 | controller | ok: [localhost] 2025-09-30 11:22:30.960908 | controller | 2025-09-30 11:22:30.960939 | controller | TASK [download_tools : Delete old go version installed from upstream] ********** 2025-09-30 11:22:30.960948 | controller | Tuesday 30 September 2025 11:22:30 +0000 (0:00:01.497) 0:01:31.804 ***** 2025-09-30 11:22:30.960975 | controller | ok: [localhost] => (item=/usr/local/go) 2025-09-30 11:22:43.434786 | controller | ok: [localhost] => (item=/home/zuul/bin/go) 2025-09-30 11:22:43.434818 | controller | ok: [localhost] => (item=/home/zuul/bin/gofmt) 2025-09-30 11:22:43.434825 | controller | ok: [localhost] => (item=/usr/local/bin/go) 2025-09-30 11:22:43.434831 | controller | ok: [localhost] => (item=/usr/local/bin/gofmt) 2025-09-30 11:22:43.434836 | controller | 2025-09-30 11:22:43.434842 | controller | TASK [download_tools : Download and extract golang] **************************** 2025-09-30 11:22:43.434848 | controller | Tuesday 30 September 2025 11:22:30 +0000 (0:00:00.893) 0:01:32.698 ***** 2025-09-30 11:22:43.434858 | controller | changed: [localhost] 2025-09-30 11:22:43.819624 | controller | 2025-09-30 11:22:43.819653 | controller | TASK [download_tools : Set alternatives link to installed go version] ********** 2025-09-30 11:22:43.819661 | controller | Tuesday 30 September 2025 11:22:43 +0000 (0:00:12.474) 0:01:45.172 ***** 2025-09-30 11:22:43.819672 | controller | changed: [localhost] => (item=go) 2025-09-30 11:22:43.853031 | controller | changed: [localhost] => (item=gofmt) 2025-09-30 11:22:43.853057 | controller | 2025-09-30 11:22:43.853065 | controller | TASK [download_tools : Clean bash cache] *************************************** 2025-09-30 11:22:43.853079 | controller | Tuesday 30 September 2025 11:22:43 +0000 (0:00:00.384) 0:01:45.557 ***** 2025-09-30 11:22:43.853089 | controller | ok: [localhost] => 2025-09-30 11:22:43.854014 | controller | msg: When move from rpm to upstream version, make sure to clean bash cache using `hash -d go` 2025-09-30 11:22:43.854028 | controller | 2025-09-30 11:22:43.854035 | controller | PLAY RECAP ********************************************************************* 2025-09-30 11:22:43.854043 | controller | instance : ok=31 changed=17 unreachable=0 failed=0 skipped=36 rescued=0 ignored=0 2025-09-30 11:22:43.854059 | controller | localhost : ok=19 changed=10 unreachable=0 failed=0 skipped=2 rescued=0 ignored=0 2025-09-30 11:22:43.854065 | controller | 2025-09-30 11:22:43.854070 | controller | Tuesday 30 September 2025 11:22:43 +0000 (0:00:00.033) 0:01:45.590 ***** 2025-09-30 11:22:43.854076 | controller | =============================================================================== 2025-09-30 11:22:43.854081 | controller | test_deps : Install selinux python libs -------------------------------- 43.57s 2025-09-30 11:22:43.854086 | controller | download_tools : Download and extract golang --------------------------- 12.47s 2025-09-30 11:22:43.854092 | controller | repo_setup : Initialize python venv and install requirements ------------ 7.92s 2025-09-30 11:22:43.854097 | controller | download_tools : Install build dependencies ----------------------------- 5.91s 2025-09-30 11:22:43.854104 | controller | ci_setup : Install openshift client ------------------------------------- 5.80s 2025-09-30 11:22:43.855559 | controller | ci_setup : Install needed packages -------------------------------------- 4.27s 2025-09-30 11:22:43.913889 | controller | download_tools : Download chainsaw -------------------------------------- 3.03s 2025-09-30 11:22:43.913914 | controller | download_tools : Deinstall golang --------------------------------------- 1.50s 2025-09-30 11:22:43.913922 | controller | download_tools : Download operator-sdk ---------------------------------- 1.46s 2025-09-30 11:22:43.913927 | controller | download_tools : Download opm ------------------------------------------- 1.46s 2025-09-30 11:22:43.913933 | controller | repo_setup : Get repo-setup repository ---------------------------------- 1.22s 2025-09-30 11:22:43.913938 | controller | test_deps : Install python yaml libs ------------------------------------ 1.17s 2025-09-30 11:22:43.913943 | controller | download_tools : Download and extract yq -------------------------------- 1.16s 2025-09-30 11:22:43.913949 | controller | download_tools : Download kuttl ----------------------------------------- 1.04s 2025-09-30 11:22:43.913954 | controller | download_tools : Download and extract kustomize ------------------------- 1.03s 2025-09-30 11:22:43.913975 | controller | ci_setup : Manage directories ------------------------------------------- 0.96s 2025-09-30 11:22:43.913984 | controller | download_tools : Delete old go version installed from upstream ---------- 0.89s 2025-09-30 11:22:43.913995 | controller | Gathering Facts --------------------------------------------------------- 0.84s 2025-09-30 11:22:43.914001 | controller | repo_setup : Run repo-setup --------------------------------------------- 0.81s 2025-09-30 11:22:43.914006 | controller | repo_setup : Make sure git-core package is installed -------------------- 0.78s 2025-09-30 11:22:43.914015 | controller | INFO Running default > converge 2025-09-30 11:22:44.332507 | controller | 2025-09-30 11:22:45.104485 | controller | PLAY [Converge] **************************************************************** 2025-09-30 11:22:45.104515 | controller | 2025-09-30 11:22:45.104523 | controller | TASK [Gathering Facts] ********************************************************* 2025-09-30 11:22:45.104529 | controller | Tuesday 30 September 2025 11:22:44 +0000 (0:00:00.013) 0:00:00.013 ***** 2025-09-30 11:22:45.104538 | controller | ok: [instance] 2025-09-30 11:22:45.732648 | controller | 2025-09-30 11:22:45.732681 | controller | TASK [Ensure architecture repository is building] ****************************** 2025-09-30 11:22:45.732689 | controller | Tuesday 30 September 2025 11:22:45 +0000 (0:00:00.772) 0:00:00.785 ***** 2025-09-30 11:22:45.732699 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'}) 2025-09-30 11:22:46.100445 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'}) 2025-09-30 11:22:46.100480 | controller | 2025-09-30 11:22:46.100489 | controller | TASK [Create nova migration keypair] ******************************************* 2025-09-30 11:22:46.100495 | controller | Tuesday 30 September 2025 11:22:45 +0000 (0:00:00.627) 0:00:01.413 ***** 2025-09-30 11:22:46.100505 | controller | changed: [instance] 2025-09-30 11:22:46.157049 | controller | 2025-09-30 11:22:46.157079 | controller | TASK [Generate needed facts out of local files] ******************************** 2025-09-30 11:22:46.157088 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.367) 0:00:01.781 ***** 2025-09-30 11:22:46.157097 | controller | ok: [instance] 2025-09-30 11:22:46.157515 | controller | 2025-09-30 11:22:46.181980 | controller | TASK [Generate network-values] ************************************************* 2025-09-30 11:22:46.182014 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.057) 0:00:01.838 ***** 2025-09-30 11:22:46.182029 | controller | 2025-09-30 11:22:46.208479 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] *********************** 2025-09-30 11:22:46.208503 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.024) 0:00:01.863 ***** 2025-09-30 11:22:46.208516 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance 2025-09-30 11:22:46.233617 | controller | 2025-09-30 11:22:46.233642 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] ******* 2025-09-30 11:22:46.233651 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.026) 0:00:01.889 ***** 2025-09-30 11:22:46.233663 | controller | ok: [instance] => changed=false 2025-09-30 11:22:46.233849 | controller | msg: All assertions passed 2025-09-30 11:22:46.234047 | controller | 2025-09-30 11:22:46.234244 | controller | TASK [ci_gen_kustomize_values : Stat original source file] ********************* 2025-09-30 11:22:46.234421 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.025) 0:00:01.915 ***** 2025-09-30 11:22:46.507065 | controller | ok: [instance] 2025-09-30 11:22:46.538097 | controller | 2025-09-30 11:22:46.538128 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] ********************* 2025-09-30 11:22:46.538136 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.272) 0:00:02.188 ***** 2025-09-30 11:22:46.538146 | controller | ok: [instance] => changed=false 2025-09-30 11:22:46.538171 | controller | msg: All assertions passed 2025-09-30 11:22:46.538491 | controller | 2025-09-30 11:22:46.814056 | controller | TASK [ci_gen_kustomize_values : Load original values file] ********************* 2025-09-30 11:22:46.814085 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.031) 0:00:02.219 ***** 2025-09-30 11:22:46.814096 | controller | ok: [instance] 2025-09-30 11:22:47.073088 | controller | 2025-09-30 11:22:47.073123 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] *********** 2025-09-30 11:22:47.073133 | controller | Tuesday 30 September 2025 11:22:46 +0000 (0:00:00.275) 0:00:02.495 ***** 2025-09-30 11:22:47.073145 | controller | ok: [instance] 2025-09-30 11:22:47.115758 | controller | 2025-09-30 11:22:47.115793 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] *** 2025-09-30 11:22:47.115802 | controller | Tuesday 30 September 2025 11:22:47 +0000 (0:00:00.259) 0:00:02.754 ***** 2025-09-30 11:22:47.115814 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance 2025-09-30 11:22:47.139687 | controller | 2025-09-30 11:22:47.139708 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] ************** 2025-09-30 11:22:47.139715 | controller | Tuesday 30 September 2025 11:22:47 +0000 (0:00:00.042) 0:00:02.796 ***** 2025-09-30 11:22:47.139724 | controller | ok: [instance] => changed=false 2025-09-30 11:22:47.418044 | controller | msg: All assertions passed 2025-09-30 11:22:47.418075 | controller | 2025-09-30 11:22:47.418083 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] **************** 2025-09-30 11:22:47.418090 | controller | Tuesday 30 September 2025 11:22:47 +0000 (0:00:00.023) 0:00:02.820 ***** 2025-09-30 11:22:47.418105 | controller | changed: [instance] 2025-09-30 11:22:47.418282 | controller | 2025-09-30 11:22:47.418294 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] *************************** 2025-09-30 11:22:47.418309 | controller | Tuesday 30 September 2025 11:22:47 +0000 (0:00:00.278) 0:00:03.099 ***** 2025-09-30 11:22:47.941377 | controller | changed: [instance] 2025-09-30 11:22:47.975035 | controller | 2025-09-30 11:22:47.975061 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ****** 2025-09-30 11:22:47.975069 | controller | Tuesday 30 September 2025 11:22:47 +0000 (0:00:00.523) 0:00:03.622 ***** 2025-09-30 11:22:47.975079 | controller | ok: [instance] 2025-09-30 11:22:48.311141 | controller | 2025-09-30 11:22:48.311171 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************ 2025-09-30 11:22:48.311179 | controller | Tuesday 30 September 2025 11:22:47 +0000 (0:00:00.033) 0:00:03.656 ***** 2025-09-30 11:22:48.311188 | controller | changed: [instance] 2025-09-30 11:22:48.652855 | controller | 2025-09-30 11:22:48.652884 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ******************** 2025-09-30 11:22:48.652892 | controller | Tuesday 30 September 2025 11:22:48 +0000 (0:00:00.335) 0:00:03.992 ***** 2025-09-30 11:22:48.652901 | controller | changed: [instance] 2025-09-30 11:22:48.989515 | controller | 2025-09-30 11:22:48.989545 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] ********************* 2025-09-30 11:22:48.989553 | controller | Tuesday 30 September 2025 11:22:48 +0000 (0:00:00.341) 0:00:04.334 ***** 2025-09-30 11:22:48.989563 | controller | changed: [instance] 2025-09-30 11:22:49.016720 | controller | 2025-09-30 11:22:49.016744 | controller | TASK [ci_gen_kustomize_values : Generate values file] ************************** 2025-09-30 11:22:49.016752 | controller | Tuesday 30 September 2025 11:22:48 +0000 (0:00:00.336) 0:00:04.670 ***** 2025-09-30 11:22:49.016761 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance 2025-09-30 11:22:49.041991 | controller | 2025-09-30 11:22:49.042019 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] *************** 2025-09-30 11:22:49.042027 | controller | Tuesday 30 September 2025 11:22:49 +0000 (0:00:00.027) 0:00:04.698 ***** 2025-09-30 11:22:49.042037 | controller | ok: [instance] => changed=false 2025-09-30 11:22:49.322043 | controller | msg: All assertions passed 2025-09-30 11:22:49.322086 | controller | 2025-09-30 11:22:49.322094 | controller | TASK [ci_gen_kustomize_values : List snippets] ********************************* 2025-09-30 11:22:49.322101 | controller | Tuesday 30 September 2025 11:22:49 +0000 (0:00:00.024) 0:00:04.723 ***** 2025-09-30 11:22:49.322120 | controller | ok: [instance] 2025-09-30 11:22:49.338861 | controller | 2025-09-30 11:22:49.338887 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] ********************** 2025-09-30 11:22:49.338896 | controller | Tuesday 30 September 2025 11:22:49 +0000 (0:00:00.279) 0:00:05.003 ***** 2025-09-30 11:22:49.338907 | controller | ok: [instance] 2025-09-30 11:22:49.833047 | controller | 2025-09-30 11:22:49.833077 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ******************** 2025-09-30 11:22:49.833085 | controller | Tuesday 30 September 2025 11:22:49 +0000 (0:00:00.017) 0:00:05.020 ***** 2025-09-30 11:22:49.833095 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml) 2025-09-30 11:22:49.833322 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml) 2025-09-30 11:22:49.833335 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml) 2025-09-30 11:22:49.833341 | controller | 2025-09-30 11:22:49.833349 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ****************************** 2025-09-30 11:22:49.895056 | controller | Tuesday 30 September 2025 11:22:49 +0000 (0:00:00.493) 0:00:05.514 ***** 2025-09-30 11:22:49.895082 | controller | ok: [instance] => (item=02_ci_data.yaml) 2025-09-30 11:22:49.895119 | controller | ok: [instance] => (item=03_user_data_b64.yaml) 2025-09-30 11:22:49.895138 | controller | ok: [instance] => (item=04_user_data.yaml) 2025-09-30 11:22:49.895147 | controller | 2025-09-30 11:22:49.895154 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] ********************** 2025-09-30 11:22:49.895164 | controller | Tuesday 30 September 2025 11:22:49 +0000 (0:00:00.062) 0:00:05.576 ***** 2025-09-30 11:22:50.092045 | controller | changed: [instance] 2025-09-30 11:22:50.447924 | controller | 2025-09-30 11:22:50.447954 | controller | TASK [ci_gen_kustomize_values : Output values file] **************************** 2025-09-30 11:22:50.448026 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.196) 0:00:05.773 ***** 2025-09-30 11:22:50.448042 | controller | changed: [instance] 2025-09-30 11:22:50.473704 | controller | 2025-09-30 11:22:50.473728 | controller | TASK [Generate edpm-nodeset-values] ******************************************** 2025-09-30 11:22:50.473736 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.355) 0:00:06.129 ***** 2025-09-30 11:22:50.473745 | controller | 2025-09-30 11:22:50.499739 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] *********************** 2025-09-30 11:22:50.499765 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.025) 0:00:06.154 ***** 2025-09-30 11:22:50.499776 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance 2025-09-30 11:22:50.526875 | controller | 2025-09-30 11:22:50.526898 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] ******* 2025-09-30 11:22:50.526913 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.025) 0:00:06.180 ***** 2025-09-30 11:22:50.526923 | controller | ok: [instance] => changed=false 2025-09-30 11:22:50.712503 | controller | msg: All assertions passed 2025-09-30 11:22:50.712535 | controller | 2025-09-30 11:22:50.712543 | controller | TASK [ci_gen_kustomize_values : Stat original source file] ********************* 2025-09-30 11:22:50.712550 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.027) 0:00:06.207 ***** 2025-09-30 11:22:50.712559 | controller | ok: [instance] 2025-09-30 11:22:50.744779 | controller | 2025-09-30 11:22:50.744808 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] ********************* 2025-09-30 11:22:50.744817 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.185) 0:00:06.393 ***** 2025-09-30 11:22:50.744829 | controller | ok: [instance] => changed=false 2025-09-30 11:22:50.926867 | controller | msg: All assertions passed 2025-09-30 11:22:50.926896 | controller | 2025-09-30 11:22:50.926904 | controller | TASK [ci_gen_kustomize_values : Load original values file] ********************* 2025-09-30 11:22:50.926911 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.032) 0:00:06.425 ***** 2025-09-30 11:22:50.926920 | controller | ok: [instance] 2025-09-30 11:22:51.150727 | controller | 2025-09-30 11:22:51.150759 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] *********** 2025-09-30 11:22:51.150768 | controller | Tuesday 30 September 2025 11:22:50 +0000 (0:00:00.182) 0:00:06.607 ***** 2025-09-30 11:22:51.150780 | controller | ok: [instance] 2025-09-30 11:22:51.193640 | controller | 2025-09-30 11:22:51.193664 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] *** 2025-09-30 11:22:51.193673 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.223) 0:00:06.831 ***** 2025-09-30 11:22:51.193684 | 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-09-30 11:22:51.226033 | controller | 2025-09-30 11:22:51.226057 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] *** 2025-09-30 11:22:51.226067 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.043) 0:00:06.874 ***** 2025-09-30 11:22:51.226077 | 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-09-30 11:22:51.226103 | controller | 2025-09-30 11:22:51.226113 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] *** 2025-09-30 11:22:51.226197 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.032) 0:00:06.907 ***** 2025-09-30 11:22:51.254108 | controller | ok: [instance] => changed=false 2025-09-30 11:22:51.254160 | controller | msg: All assertions passed 2025-09-30 11:22:51.254170 | controller | 2025-09-30 11:22:51.254377 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ****** 2025-09-30 11:22:51.278719 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.027) 0:00:06.935 ***** 2025-09-30 11:22:51.278746 | 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-09-30 11:22:51.278923 | controller | 2025-09-30 11:22:51.279133 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] *** 2025-09-30 11:22:51.279299 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.024) 0:00:06.960 ***** 2025-09-30 11:22:51.294271 | controller | skipping: [instance] 2025-09-30 11:22:51.294460 | controller | 2025-09-30 11:22:51.294646 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ******** 2025-09-30 11:22:51.294821 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.015) 0:00:06.975 ***** 2025-09-30 11:22:51.312791 | controller | ok: [instance] 2025-09-30 11:22:51.313018 | controller | 2025-09-30 11:22:51.313222 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] *** 2025-09-30 11:22:51.313366 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.018) 0:00:06.994 ***** 2025-09-30 11:22:51.337659 | controller | ok: [instance] => changed=false 2025-09-30 11:22:51.337859 | controller | msg: All assertions passed 2025-09-30 11:22:51.338086 | controller | 2025-09-30 11:22:51.338277 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] **************** 2025-09-30 11:22:51.338418 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.024) 0:00:07.019 ***** 2025-09-30 11:22:51.515359 | controller | changed: [instance] 2025-09-30 11:22:51.888355 | controller | 2025-09-30 11:22:51.888384 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] *************************** 2025-09-30 11:22:51.888392 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.177) 0:00:07.196 ***** 2025-09-30 11:22:51.888402 | controller | changed: [instance] 2025-09-30 11:22:51.909954 | controller | 2025-09-30 11:22:51.909994 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ****** 2025-09-30 11:22:51.910002 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.373) 0:00:07.569 ***** 2025-09-30 11:22:51.910012 | controller | ok: [instance] 2025-09-30 11:22:52.251081 | controller | 2025-09-30 11:22:52.251113 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************ 2025-09-30 11:22:52.251122 | controller | Tuesday 30 September 2025 11:22:51 +0000 (0:00:00.021) 0:00:07.591 ***** 2025-09-30 11:22:52.251134 | controller | changed: [instance] 2025-09-30 11:22:52.251160 | controller | 2025-09-30 11:22:52.251168 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ******************** 2025-09-30 11:22:52.251189 | controller | Tuesday 30 September 2025 11:22:52 +0000 (0:00:00.341) 0:00:07.932 ***** 2025-09-30 11:22:52.563512 | controller | changed: [instance] 2025-09-30 11:22:52.877888 | controller | 2025-09-30 11:22:52.877917 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] ********************* 2025-09-30 11:22:52.877925 | controller | Tuesday 30 September 2025 11:22:52 +0000 (0:00:00.312) 0:00:08.244 ***** 2025-09-30 11:22:52.877941 | controller | changed: [instance] 2025-09-30 11:22:52.903080 | controller | 2025-09-30 11:22:52.903106 | controller | TASK [ci_gen_kustomize_values : Generate values file] ************************** 2025-09-30 11:22:52.903115 | controller | Tuesday 30 September 2025 11:22:52 +0000 (0:00:00.314) 0:00:08.559 ***** 2025-09-30 11:22:52.903126 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance 2025-09-30 11:22:52.903336 | controller | 2025-09-30 11:22:52.903355 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] *************** 2025-09-30 11:22:52.926008 | controller | Tuesday 30 September 2025 11:22:52 +0000 (0:00:00.025) 0:00:08.584 ***** 2025-09-30 11:22:52.926035 | controller | ok: [instance] => changed=false 2025-09-30 11:22:52.926062 | controller | msg: All assertions passed 2025-09-30 11:22:52.926407 | controller | 2025-09-30 11:22:53.097930 | controller | TASK [ci_gen_kustomize_values : List snippets] ********************************* 2025-09-30 11:22:53.097960 | controller | Tuesday 30 September 2025 11:22:52 +0000 (0:00:00.022) 0:00:08.607 ***** 2025-09-30 11:22:53.097997 | controller | ok: [instance] 2025-09-30 11:22:53.112610 | controller | 2025-09-30 11:22:53.112629 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] ********************** 2025-09-30 11:22:53.112636 | controller | Tuesday 30 September 2025 11:22:53 +0000 (0:00:00.171) 0:00:08.778 ***** 2025-09-30 11:22:53.112645 | controller | ok: [instance] 2025-09-30 11:22:53.575732 | controller | 2025-09-30 11:22:53.575762 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ******************** 2025-09-30 11:22:53.575770 | controller | Tuesday 30 September 2025 11:22:53 +0000 (0:00:00.015) 0:00:08.793 ***** 2025-09-30 11:22:53.575781 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml) 2025-09-30 11:22:53.619643 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml) 2025-09-30 11:22:53.619667 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml) 2025-09-30 11:22:53.619674 | controller | 2025-09-30 11:22:53.619681 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ****************************** 2025-09-30 11:22:53.619687 | controller | Tuesday 30 September 2025 11:22:53 +0000 (0:00:00.462) 0:00:09.256 ***** 2025-09-30 11:22:53.619697 | controller | ok: [instance] => (item=02_ci_data.yaml) 2025-09-30 11:22:53.796079 | controller | ok: [instance] => (item=03_user_data_b64.yaml) 2025-09-30 11:22:53.796108 | controller | ok: [instance] => (item=04_user_data.yaml) 2025-09-30 11:22:53.796116 | controller | 2025-09-30 11:22:53.796122 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] ********************** 2025-09-30 11:22:53.796128 | controller | Tuesday 30 September 2025 11:22:53 +0000 (0:00:00.043) 0:00:09.300 ***** 2025-09-30 11:22:53.796137 | controller | changed: [instance] 2025-09-30 11:22:54.121906 | controller | 2025-09-30 11:22:54.121935 | controller | TASK [ci_gen_kustomize_values : Output values file] **************************** 2025-09-30 11:22:54.121943 | controller | Tuesday 30 September 2025 11:22:53 +0000 (0:00:00.176) 0:00:09.477 ***** 2025-09-30 11:22:54.121954 | controller | changed: [instance] 2025-09-30 11:22:54.448434 | controller | 2025-09-30 11:22:54.448464 | controller | TASK [Get generated files status] ********************************************** 2025-09-30 11:22:54.448473 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.325) 0:00:09.803 ***** 2025-09-30 11:22:54.448483 | controller | ok: [instance] => (item=network-values) 2025-09-30 11:22:54.474069 | controller | ok: [instance] => (item=edpm-nodeset-values) 2025-09-30 11:22:54.474102 | controller | 2025-09-30 11:22:54.474111 | controller | TASK [Assert generated values.yaml exists] ************************************* 2025-09-30 11:22:54.474120 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.326) 0:00:10.129 ***** 2025-09-30 11:22:54.474131 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml) => changed=false 2025-09-30 11:22:54.474177 | controller | ansible_loop_var: item 2025-09-30 11:22:54.474186 | controller | item: 2025-09-30 11:22:54.474193 | controller | ansible_loop_var: item 2025-09-30 11:22:54.474200 | controller | changed: false 2025-09-30 11:22:54.474207 | controller | failed: false 2025-09-30 11:22:54.474213 | controller | invocation: 2025-09-30 11:22:54.474220 | controller | module_args: 2025-09-30 11:22:54.474226 | controller | checksum_algorithm: sha1 2025-09-30 11:22:54.474235 | controller | follow: false 2025-09-30 11:22:54.474260 | controller | get_attributes: false 2025-09-30 11:22:54.474599 | controller | get_checksum: false 2025-09-30 11:22:54.474998 | controller | get_md5: false 2025-09-30 11:22:54.475015 | controller | get_mime: false 2025-09-30 11:22:54.475022 | controller | path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml 2025-09-30 11:22:54.475031 | controller | item: network-values 2025-09-30 11:22:54.475124 | controller | stat: 2025-09-30 11:22:54.475132 | controller | atime: 1759231370.4097798 2025-09-30 11:22:54.475138 | controller | block_size: 4096 2025-09-30 11:22:54.475145 | controller | blocks: 16 2025-09-30 11:22:54.475272 | controller | ctime: 1759231370.4127798 2025-09-30 11:22:54.475397 | controller | dev: 64513 2025-09-30 11:22:54.475525 | controller | device_type: 0 2025-09-30 11:22:54.475648 | controller | executable: false 2025-09-30 11:22:54.475795 | controller | exists: true 2025-09-30 11:22:54.475937 | controller | gid: 1000 2025-09-30 11:22:54.476108 | controller | gr_name: zuul 2025-09-30 11:22:54.476281 | controller | inode: 167806184 2025-09-30 11:22:54.476421 | controller | isblk: false 2025-09-30 11:22:54.476557 | controller | ischr: false 2025-09-30 11:22:54.476693 | controller | isdir: false 2025-09-30 11:22:54.476832 | controller | isfifo: false 2025-09-30 11:22:54.476985 | controller | isgid: false 2025-09-30 11:22:54.477140 | controller | islnk: false 2025-09-30 11:22:54.477305 | controller | isreg: true 2025-09-30 11:22:54.477445 | controller | issock: false 2025-09-30 11:22:54.477583 | controller | isuid: false 2025-09-30 11:22:54.477719 | controller | mode: '0644' 2025-09-30 11:22:54.477854 | controller | mtime: 1759231370.2657802 2025-09-30 11:22:54.478013 | controller | nlink: 1 2025-09-30 11:22:54.478186 | controller | path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml 2025-09-30 11:22:54.478328 | controller | pw_name: zuul 2025-09-30 11:22:54.478462 | controller | readable: true 2025-09-30 11:22:54.478594 | controller | rgrp: true 2025-09-30 11:22:54.478743 | controller | roth: true 2025-09-30 11:22:54.478879 | controller | rusr: true 2025-09-30 11:22:54.479037 | controller | size: 5726 2025-09-30 11:22:54.479194 | controller | uid: 1000 2025-09-30 11:22:54.479339 | controller | wgrp: false 2025-09-30 11:22:54.479474 | controller | woth: false 2025-09-30 11:22:54.479609 | controller | writeable: true 2025-09-30 11:22:54.479742 | controller | wusr: true 2025-09-30 11:22:54.479875 | controller | xgrp: false 2025-09-30 11:22:54.480042 | controller | xoth: false 2025-09-30 11:22:54.480208 | controller | xusr: false 2025-09-30 11:22:54.480347 | controller | msg: All assertions passed 2025-09-30 11:22:54.480498 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml) => changed=false 2025-09-30 11:22:54.480635 | controller | ansible_loop_var: item 2025-09-30 11:22:54.480769 | controller | item: 2025-09-30 11:22:54.480903 | controller | ansible_loop_var: item 2025-09-30 11:22:54.481064 | controller | changed: false 2025-09-30 11:22:54.481221 | controller | failed: false 2025-09-30 11:22:54.481359 | controller | invocation: 2025-09-30 11:22:54.481501 | controller | module_args: 2025-09-30 11:22:54.481637 | controller | checksum_algorithm: sha1 2025-09-30 11:22:54.481771 | controller | follow: false 2025-09-30 11:22:54.481906 | controller | get_attributes: false 2025-09-30 11:22:54.482065 | controller | get_checksum: false 2025-09-30 11:22:54.482229 | controller | get_md5: false 2025-09-30 11:22:54.482365 | controller | get_mime: false 2025-09-30 11:22:54.482513 | controller | path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml 2025-09-30 11:22:54.482648 | controller | item: edpm-nodeset-values 2025-09-30 11:22:54.482781 | controller | stat: 2025-09-30 11:22:54.482915 | controller | atime: 1759231374.0857682 2025-09-30 11:22:54.483074 | controller | block_size: 4096 2025-09-30 11:22:54.483238 | controller | blocks: 40 2025-09-30 11:22:54.483381 | controller | ctime: 1759231374.0887682 2025-09-30 11:22:54.483519 | controller | dev: 64513 2025-09-30 11:22:54.483652 | controller | device_type: 0 2025-09-30 11:22:54.483784 | controller | executable: false 2025-09-30 11:22:54.483915 | controller | exists: true 2025-09-30 11:22:54.484071 | controller | gid: 1000 2025-09-30 11:22:54.484233 | controller | gr_name: zuul 2025-09-30 11:22:54.484367 | controller | inode: 138444257 2025-09-30 11:22:54.484500 | controller | isblk: false 2025-09-30 11:22:54.484632 | controller | ischr: false 2025-09-30 11:22:54.484773 | controller | isdir: false 2025-09-30 11:22:54.484906 | controller | isfifo: false 2025-09-30 11:22:54.485072 | controller | isgid: false 2025-09-30 11:22:54.485233 | controller | islnk: false 2025-09-30 11:22:54.485370 | controller | isreg: true 2025-09-30 11:22:54.485503 | controller | issock: false 2025-09-30 11:22:54.485635 | controller | isuid: false 2025-09-30 11:22:54.485764 | controller | mode: '0644' 2025-09-30 11:22:54.485897 | controller | mtime: 1759231373.9557686 2025-09-30 11:22:54.486056 | controller | nlink: 1 2025-09-30 11:22:54.486224 | controller | path: /home/zuul/ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml 2025-09-30 11:22:54.486359 | controller | pw_name: zuul 2025-09-30 11:22:54.486501 | controller | readable: true 2025-09-30 11:22:54.486633 | controller | rgrp: true 2025-09-30 11:22:54.486764 | controller | roth: true 2025-09-30 11:22:54.486910 | controller | rusr: true 2025-09-30 11:22:54.487067 | controller | size: 16482 2025-09-30 11:22:54.487224 | controller | uid: 1000 2025-09-30 11:22:54.487366 | controller | wgrp: false 2025-09-30 11:22:54.487500 | controller | woth: false 2025-09-30 11:22:54.487632 | controller | writeable: true 2025-09-30 11:22:54.487764 | controller | wusr: true 2025-09-30 11:22:54.487896 | controller | xgrp: false 2025-09-30 11:22:54.488054 | controller | xoth: false 2025-09-30 11:22:54.488210 | controller | xusr: false 2025-09-30 11:22:54.488349 | controller | msg: All assertions passed 2025-09-30 11:22:54.488476 | controller | 2025-09-30 11:22:54.488620 | controller | TASK [Ensure we have correct MAC] ********************************************** 2025-09-30 11:22:54.488755 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.025) 0:00:10.154 ***** 2025-09-30 11:22:54.503436 | controller | ok: [instance] => changed=false 2025-09-30 11:22:54.503600 | controller | msg: All assertions passed 2025-09-30 11:22:54.503736 | controller | 2025-09-30 11:22:54.503878 | controller | TASK [Ensure we don't have node_1 nor node_2] ********************************** 2025-09-30 11:22:54.504058 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.030) 0:00:10.184 ***** 2025-09-30 11:22:54.534337 | controller | ok: [instance] => changed=false 2025-09-30 11:22:54.534524 | controller | msg: All assertions passed 2025-09-30 11:22:54.534666 | controller | 2025-09-30 11:22:54.534814 | controller | TASK [Update cifmw_networking_env_definition] ********************************** 2025-09-30 11:22:54.534960 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.030) 0:00:10.215 ***** 2025-09-30 11:22:54.558414 | controller | ok: [instance] 2025-09-30 11:22:54.558623 | controller | 2025-09-30 11:22:54.558805 | controller | TASK [Regenerate network-values] *********************************************** 2025-09-30 11:22:54.559012 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.024) 0:00:10.239 ***** 2025-09-30 11:22:54.579913 | controller | 2025-09-30 11:22:54.580201 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] *********************** 2025-09-30 11:22:54.580385 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.021) 0:00:10.261 ***** 2025-09-30 11:22:54.605055 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance 2025-09-30 11:22:54.605295 | controller | 2025-09-30 11:22:54.605463 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] ******* 2025-09-30 11:22:54.605615 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.025) 0:00:10.286 ***** 2025-09-30 11:22:54.630081 | controller | ok: [instance] => changed=false 2025-09-30 11:22:54.630361 | controller | msg: All assertions passed 2025-09-30 11:22:54.630515 | controller | 2025-09-30 11:22:54.630668 | controller | TASK [ci_gen_kustomize_values : Stat original source file] ********************* 2025-09-30 11:22:54.630817 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.025) 0:00:10.311 ***** 2025-09-30 11:22:54.800036 | controller | ok: [instance] 2025-09-30 11:22:54.821947 | controller | 2025-09-30 11:22:54.822000 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] ********************* 2025-09-30 11:22:54.822008 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.169) 0:00:10.481 ***** 2025-09-30 11:22:54.822018 | controller | ok: [instance] => changed=false 2025-09-30 11:22:54.991196 | controller | msg: All assertions passed 2025-09-30 11:22:54.991226 | controller | 2025-09-30 11:22:54.991233 | controller | TASK [ci_gen_kustomize_values : Load original values file] ********************* 2025-09-30 11:22:54.991240 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.021) 0:00:10.502 ***** 2025-09-30 11:22:54.991249 | controller | ok: [instance] 2025-09-30 11:22:55.222052 | controller | 2025-09-30 11:22:55.222087 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] *********** 2025-09-30 11:22:55.222096 | controller | Tuesday 30 September 2025 11:22:54 +0000 (0:00:00.169) 0:00:10.672 ***** 2025-09-30 11:22:55.222108 | controller | ok: [instance] 2025-09-30 11:22:55.222299 | controller | 2025-09-30 11:22:55.222313 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] *** 2025-09-30 11:22:55.222334 | controller | Tuesday 30 September 2025 11:22:55 +0000 (0:00:00.230) 0:00:10.903 ***** 2025-09-30 11:22:55.254415 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for instance 2025-09-30 11:22:55.279428 | controller | 2025-09-30 11:22:55.279453 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters] ************** 2025-09-30 11:22:55.279463 | controller | Tuesday 30 September 2025 11:22:55 +0000 (0:00:00.032) 0:00:10.935 ***** 2025-09-30 11:22:55.279474 | controller | ok: [instance] => changed=false 2025-09-30 11:22:55.458608 | controller | msg: All assertions passed 2025-09-30 11:22:55.458638 | controller | 2025-09-30 11:22:55.458646 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] **************** 2025-09-30 11:22:55.458652 | controller | Tuesday 30 September 2025 11:22:55 +0000 (0:00:00.024) 0:00:10.960 ***** 2025-09-30 11:22:55.458662 | controller | ok: [instance] 2025-09-30 11:22:55.916268 | controller | 2025-09-30 11:22:55.916297 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] *************************** 2025-09-30 11:22:55.916306 | controller | Tuesday 30 September 2025 11:22:55 +0000 (0:00:00.179) 0:00:11.139 ***** 2025-09-30 11:22:55.916315 | controller | changed: [instance] 2025-09-30 11:22:55.939674 | controller | 2025-09-30 11:22:55.939694 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ****** 2025-09-30 11:22:55.939702 | controller | Tuesday 30 September 2025 11:22:55 +0000 (0:00:00.457) 0:00:11.597 ***** 2025-09-30 11:22:55.939711 | controller | ok: [instance] 2025-09-30 11:22:56.280950 | controller | 2025-09-30 11:22:56.281004 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************ 2025-09-30 11:22:56.281013 | controller | Tuesday 30 September 2025 11:22:55 +0000 (0:00:00.023) 0:00:11.620 ***** 2025-09-30 11:22:56.281024 | controller | ok: [instance] 2025-09-30 11:22:56.615196 | controller | 2025-09-30 11:22:56.615226 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ******************** 2025-09-30 11:22:56.615234 | controller | Tuesday 30 September 2025 11:22:56 +0000 (0:00:00.341) 0:00:11.962 ***** 2025-09-30 11:22:56.615244 | controller | ok: [instance] 2025-09-30 11:22:56.951626 | controller | 2025-09-30 11:22:56.951656 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] ********************* 2025-09-30 11:22:56.951664 | controller | Tuesday 30 September 2025 11:22:56 +0000 (0:00:00.334) 0:00:12.296 ***** 2025-09-30 11:22:56.951674 | controller | ok: [instance] 2025-09-30 11:22:56.978074 | controller | 2025-09-30 11:22:56.978097 | controller | TASK [ci_gen_kustomize_values : Generate values file] ************************** 2025-09-30 11:22:56.978106 | controller | Tuesday 30 September 2025 11:22:56 +0000 (0:00:00.336) 0:00:12.632 ***** 2025-09-30 11:22:56.978118 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance 2025-09-30 11:22:57.002042 | controller | 2025-09-30 11:22:57.002075 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] *************** 2025-09-30 11:22:57.002084 | controller | Tuesday 30 September 2025 11:22:56 +0000 (0:00:00.026) 0:00:12.659 ***** 2025-09-30 11:22:57.002094 | controller | ok: [instance] => changed=false 2025-09-30 11:22:57.002118 | controller | msg: All assertions passed 2025-09-30 11:22:57.002126 | controller | 2025-09-30 11:22:57.002422 | controller | TASK [ci_gen_kustomize_values : List snippets] ********************************* 2025-09-30 11:22:57.182327 | controller | Tuesday 30 September 2025 11:22:56 +0000 (0:00:00.024) 0:00:12.683 ***** 2025-09-30 11:22:57.182363 | controller | ok: [instance] 2025-09-30 11:22:57.199997 | controller | 2025-09-30 11:22:57.200024 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] ********************** 2025-09-30 11:22:57.200037 | controller | Tuesday 30 September 2025 11:22:57 +0000 (0:00:00.179) 0:00:12.863 ***** 2025-09-30 11:22:57.200047 | controller | ok: [instance] 2025-09-30 11:22:57.683065 | controller | 2025-09-30 11:22:57.683100 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ******************** 2025-09-30 11:22:57.683108 | controller | Tuesday 30 September 2025 11:22:57 +0000 (0:00:00.017) 0:00:12.881 ***** 2025-09-30 11:22:57.683123 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml) 2025-09-30 11:22:57.683162 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml) 2025-09-30 11:22:57.683599 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml) 2025-09-30 11:22:57.739037 | controller | 2025-09-30 11:22:57.739068 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ****************************** 2025-09-30 11:22:57.739076 | controller | Tuesday 30 September 2025 11:22:57 +0000 (0:00:00.483) 0:00:13.364 ***** 2025-09-30 11:22:57.739086 | controller | ok: [instance] => (item=02_ci_data.yaml) 2025-09-30 11:22:57.739109 | controller | ok: [instance] => (item=03_user_data_b64.yaml) 2025-09-30 11:22:57.739116 | controller | ok: [instance] => (item=04_user_data.yaml) 2025-09-30 11:22:57.739121 | controller | 2025-09-30 11:22:57.739140 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] ********************** 2025-09-30 11:22:57.739273 | controller | Tuesday 30 September 2025 11:22:57 +0000 (0:00:00.055) 0:00:13.420 ***** 2025-09-30 11:22:57.920692 | controller | ok: [instance] 2025-09-30 11:22:58.287199 | controller | 2025-09-30 11:22:58.287228 | controller | TASK [ci_gen_kustomize_values : Output values file] **************************** 2025-09-30 11:22:58.287237 | controller | Tuesday 30 September 2025 11:22:57 +0000 (0:00:00.181) 0:00:13.601 ***** 2025-09-30 11:22:58.287246 | controller | changed: [instance] 2025-09-30 11:22:58.311726 | controller | 2025-09-30 11:22:58.311752 | controller | TASK [Regenerate edpm-nodeset-values] ****************************************** 2025-09-30 11:22:58.311761 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.366) 0:00:13.968 ***** 2025-09-30 11:22:58.311773 | controller | 2025-09-30 11:22:58.336496 | controller | TASK [ci_gen_kustomize_values : Generate snippets files] *********************** 2025-09-30 11:22:58.336519 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.024) 0:00:13.993 ***** 2025-09-30 11:22:58.336530 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for instance 2025-09-30 11:22:58.361930 | controller | 2025-09-30 11:22:58.361949 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set] ******* 2025-09-30 11:22:58.361956 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.024) 0:00:14.017 ***** 2025-09-30 11:22:58.361987 | controller | ok: [instance] => changed=false 2025-09-30 11:22:58.555190 | controller | msg: All assertions passed 2025-09-30 11:22:58.555250 | controller | 2025-09-30 11:22:58.555259 | controller | TASK [ci_gen_kustomize_values : Stat original source file] ********************* 2025-09-30 11:22:58.555267 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.025) 0:00:14.043 ***** 2025-09-30 11:22:58.555281 | controller | ok: [instance] 2025-09-30 11:22:58.578220 | controller | 2025-09-30 11:22:58.578266 | controller | TASK [ci_gen_kustomize_values : Assert source file exists] ********************* 2025-09-30 11:22:58.578275 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.193) 0:00:14.236 ***** 2025-09-30 11:22:58.578288 | controller | ok: [instance] => changed=false 2025-09-30 11:22:58.769931 | controller | msg: All assertions passed 2025-09-30 11:22:58.769992 | controller | 2025-09-30 11:22:58.770004 | controller | TASK [ci_gen_kustomize_values : Load original values file] ********************* 2025-09-30 11:22:58.770011 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.023) 0:00:14.259 ***** 2025-09-30 11:22:58.770022 | controller | ok: [instance] 2025-09-30 11:22:58.976181 | controller | 2025-09-30 11:22:58.976220 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage] *********** 2025-09-30 11:22:58.976230 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.191) 0:00:14.450 ***** 2025-09-30 11:22:58.976243 | controller | ok: [instance] 2025-09-30 11:22:59.009947 | controller | 2025-09-30 11:22:59.009991 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type] *** 2025-09-30 11:22:59.010002 | controller | Tuesday 30 September 2025 11:22:58 +0000 (0:00:00.206) 0:00:14.657 ***** 2025-09-30 11:22:59.010012 | 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-09-30 11:22:59.034551 | controller | 2025-09-30 11:22:59.034572 | controller | TASK [ci_gen_kustomize_values : Check if all required variables for accessing the node is provided.] *** 2025-09-30 11:22:59.034581 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.034) 0:00:14.691 ***** 2025-09-30 11:22:59.034593 | 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-09-30 11:22:59.067198 | controller | 2025-09-30 11:22:59.067279 | controller | TASK [ci_gen_kustomize_values : Ensure the required parameters are defined and configured.] *** 2025-09-30 11:22:59.067290 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.024) 0:00:14.715 ***** 2025-09-30 11:22:59.067316 | controller | ok: [instance] => changed=false 2025-09-30 11:22:59.092148 | controller | msg: All assertions passed 2025-09-30 11:22:59.092204 | controller | 2025-09-30 11:22:59.092215 | controller | TASK [ci_gen_kustomize_values : Get common data for dataplane templating] ****** 2025-09-30 11:22:59.092225 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.032) 0:00:14.748 ***** 2025-09-30 11:22:59.092240 | 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-09-30 11:22:59.092329 | controller | 2025-09-30 11:22:59.092341 | controller | TASK [ci_gen_kustomize_values : Fetch the already deployed services for further usage] *** 2025-09-30 11:22:59.092353 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.025) 0:00:14.773 ***** 2025-09-30 11:22:59.108267 | controller | skipping: [instance] 2025-09-30 11:22:59.108381 | controller | 2025-09-30 11:22:59.108507 | controller | TASK [ci_gen_kustomize_values : Expose the deployed services as a fact] ******** 2025-09-30 11:22:59.108637 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.016) 0:00:14.789 ***** 2025-09-30 11:22:59.139683 | controller | ok: [instance] 2025-09-30 11:22:59.139828 | controller | 2025-09-30 11:22:59.139987 | controller | TASK [ci_gen_kustomize_values : Check if required variables for nova migration are provided.] *** 2025-09-30 11:22:59.140134 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.031) 0:00:14.821 ***** 2025-09-30 11:22:59.174374 | controller | ok: [instance] => changed=false 2025-09-30 11:22:59.174502 | controller | msg: All assertions passed 2025-09-30 11:22:59.174616 | controller | 2025-09-30 11:22:59.174740 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists] **************** 2025-09-30 11:22:59.174864 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.034) 0:00:14.855 ***** 2025-09-30 11:22:59.388876 | controller | ok: [instance] 2025-09-30 11:22:59.808718 | controller | 2025-09-30 11:22:59.808749 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet] *************************** 2025-09-30 11:22:59.808757 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.213) 0:00:15.069 ***** 2025-09-30 11:22:59.808766 | controller | ok: [instance] 2025-09-30 11:22:59.844095 | controller | 2025-09-30 11:22:59.844142 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches] ****** 2025-09-30 11:22:59.844151 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.419) 0:00:15.489 ***** 2025-09-30 11:22:59.844160 | controller | ok: [instance] 2025-09-30 11:22:59.844351 | controller | 2025-09-30 11:22:59.844376 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches] ************************ 2025-09-30 11:23:00.202324 | controller | Tuesday 30 September 2025 11:22:59 +0000 (0:00:00.035) 0:00:15.525 ***** 2025-09-30 11:23:00.202364 | controller | ok: [instance] 2025-09-30 11:23:00.542477 | controller | 2025-09-30 11:23:00.542507 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset] ******************** 2025-09-30 11:23:00.542516 | controller | Tuesday 30 September 2025 11:23:00 +0000 (0:00:00.357) 0:00:15.883 ***** 2025-09-30 11:23:00.542526 | controller | ok: [instance] 2025-09-30 11:23:00.878465 | controller | 2025-09-30 11:23:00.878493 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml] ********************* 2025-09-30 11:23:00.878501 | controller | Tuesday 30 September 2025 11:23:00 +0000 (0:00:00.340) 0:00:16.223 ***** 2025-09-30 11:23:00.878512 | controller | ok: [instance] 2025-09-30 11:23:00.906003 | controller | 2025-09-30 11:23:00.906035 | controller | TASK [ci_gen_kustomize_values : Generate values file] ************************** 2025-09-30 11:23:00.906043 | controller | Tuesday 30 September 2025 11:23:00 +0000 (0:00:00.335) 0:00:16.559 ***** 2025-09-30 11:23:00.906054 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for instance 2025-09-30 11:23:00.931638 | controller | 2025-09-30 11:23:00.931659 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter] *************** 2025-09-30 11:23:00.931667 | controller | Tuesday 30 September 2025 11:23:00 +0000 (0:00:00.027) 0:00:16.587 ***** 2025-09-30 11:23:00.931676 | controller | ok: [instance] => changed=false 2025-09-30 11:23:01.112030 | controller | msg: All assertions passed 2025-09-30 11:23:01.112060 | controller | 2025-09-30 11:23:01.112074 | controller | TASK [ci_gen_kustomize_values : List snippets] ********************************* 2025-09-30 11:23:01.112081 | controller | Tuesday 30 September 2025 11:23:00 +0000 (0:00:00.025) 0:00:16.612 ***** 2025-09-30 11:23:01.112091 | controller | ok: [instance] 2025-09-30 11:23:01.112254 | controller | 2025-09-30 11:23:01.112266 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty] ********************** 2025-09-30 11:23:01.112275 | controller | Tuesday 30 September 2025 11:23:01 +0000 (0:00:00.180) 0:00:16.793 ***** 2025-09-30 11:23:01.129051 | controller | ok: [instance] 2025-09-30 11:23:01.129112 | controller | 2025-09-30 11:23:01.129122 | controller | TASK [ci_gen_kustomize_values : Load various snippet files] ******************** 2025-09-30 11:23:01.129131 | controller | Tuesday 30 September 2025 11:23:01 +0000 (0:00:00.017) 0:00:16.810 ***** 2025-09-30 11:23:01.625009 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml) 2025-09-30 11:23:01.688604 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml) 2025-09-30 11:23:01.688634 | controller | ok: [instance] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml) 2025-09-30 11:23:01.688643 | controller | 2025-09-30 11:23:01.688649 | controller | TASK [ci_gen_kustomize_values : Combine snippets] ****************************** 2025-09-30 11:23:01.688656 | controller | Tuesday 30 September 2025 11:23:01 +0000 (0:00:00.495) 0:00:17.305 ***** 2025-09-30 11:23:01.688665 | controller | ok: [instance] => (item=02_ci_data.yaml) 2025-09-30 11:23:01.874113 | controller | ok: [instance] => (item=03_user_data_b64.yaml) 2025-09-30 11:23:01.874147 | controller | ok: [instance] => (item=04_user_data.yaml) 2025-09-30 11:23:01.874155 | controller | 2025-09-30 11:23:01.874168 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist] ********************** 2025-09-30 11:23:01.874174 | controller | Tuesday 30 September 2025 11:23:01 +0000 (0:00:00.063) 0:00:17.369 ***** 2025-09-30 11:23:01.874184 | controller | ok: [instance] 2025-09-30 11:23:02.215041 | controller | 2025-09-30 11:23:02.215071 | controller | TASK [ci_gen_kustomize_values : Output values file] **************************** 2025-09-30 11:23:02.215079 | controller | Tuesday 30 September 2025 11:23:01 +0000 (0:00:00.185) 0:00:17.555 ***** 2025-09-30 11:23:02.215098 | controller | ok: [instance] 2025-09-30 11:23:02.215121 | controller | 2025-09-30 11:23:02.215129 | controller | TASK [Copy generated values to correct location] ******************************* 2025-09-30 11:23:02.215190 | controller | Tuesday 30 September 2025 11:23:02 +0000 (0:00:00.341) 0:00:17.896 ***** 2025-09-30 11:23:02.566045 | controller | changed: [instance] => (item={'key': 'network-values', 'value': 'examples/va/hci/control-plane/networking/nncp/values.yaml'}) 2025-09-30 11:23:02.566111 | controller | changed: [instance] => (item={'key': 'edpm-nodeset-values', 'value': 'examples/va/hci/edpm-pre-ceph/nodeset/values.yaml'}) 2025-09-30 11:23:02.566477 | controller | 2025-09-30 11:23:03.086079 | controller | TASK [Ensure kustomize is able to build] *************************************** 2025-09-30 11:23:03.086127 | controller | Tuesday 30 September 2025 11:23:02 +0000 (0:00:00.351) 0:00:18.247 ***** 2025-09-30 11:23:03.086141 | controller | changed: [instance] => (item={'name': 'ctlplane', 'path': 'examples/va/hci/control-plane/networking/nncp'}) 2025-09-30 11:23:03.086169 | controller | changed: [instance] => (item={'name': 'dataplane', 'path': 'examples/va/hci/edpm-pre-ceph/nodeset'}) 2025-09-30 11:23:03.086182 | controller | 2025-09-30 11:23:03.086189 | controller | PLAY RECAP ********************************************************************* 2025-09-30 11:23:03.086196 | controller | instance : ok=107 changed=20 unreachable=0 failed=0 skipped=2 rescued=0 ignored=0 2025-09-30 11:23:03.086202 | controller | 2025-09-30 11:23:03.086209 | controller | Tuesday 30 September 2025 11:23:03 +0000 (0:00:00.518) 0:00:18.765 ***** 2025-09-30 11:23:03.086216 | controller | =============================================================================== 2025-09-30 11:23:03.086222 | controller | Gathering Facts --------------------------------------------------------- 0.77s 2025-09-30 11:23:03.086229 | controller | Ensure architecture repository is building ------------------------------ 0.63s 2025-09-30 11:23:03.086235 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.52s 2025-09-30 11:23:03.086242 | controller | Ensure kustomize is able to build --------------------------------------- 0.52s 2025-09-30 11:23:03.086248 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.50s 2025-09-30 11:23:03.086255 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.49s 2025-09-30 11:23:03.086261 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.48s 2025-09-30 11:23:03.086267 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.46s 2025-09-30 11:23:03.086274 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.46s 2025-09-30 11:23:03.086280 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.42s 2025-09-30 11:23:03.086287 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.37s 2025-09-30 11:23:03.086293 | controller | Create nova migration keypair ------------------------------------------- 0.37s 2025-09-30 11:23:03.086302 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.37s 2025-09-30 11:23:03.086327 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.36s 2025-09-30 11:23:03.086799 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.36s 2025-09-30 11:23:03.086818 | controller | Copy generated values to correct location ------------------------------- 0.35s 2025-09-30 11:23:03.144092 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.34s 2025-09-30 11:23:03.144124 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.34s 2025-09-30 11:23:03.144132 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.34s 2025-09-30 11:23:03.144138 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.34s 2025-09-30 11:23:03.144148 | controller | INFO Running default > cleanup 2025-09-30 11:23:03.144602 | controller | WARNING Skipping, cleanup playbook not configured. 2025-09-30 11:23:03.145210 | controller | INFO Writing /tmp/report.html report. 2025-09-30 11:23:03.381937 | controller | changed 2025-09-30 11:23:03.440823 | 2025-09-30 11:23:03.440922 | PLAY RECAP 2025-09-30 11:23:03.440966 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-09-30 11:23:03.440989 | 2025-09-30 11:23:03.541661 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/molecule-test.yml@main] 2025-09-30 11:23:03.542470 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-09-30 11:23:04.199890 | 2025-09-30 11:23:04.199998 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-09-30 11:23:04.222235 | 2025-09-30 11:23:04.222313 | TASK [Filter out host if needed] 2025-09-30 11:23:04.231315 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-09-30 11:23:04.235837 | 2025-09-30 11:23:04.235904 | TASK [Ensure file is present] 2025-09-30 11:23:04.570585 | controller | ok 2025-09-30 11:23:04.577269 | 2025-09-30 11:23:04.577345 | TASK [Manage molecule report file] 2025-09-30 11:23:05.101493 | controller | changed 2025-09-30 11:23:05.106770 | 2025-09-30 11:23:05.106854 | TASK [Check if we get ci-framework-data basedir] 2025-09-30 11:23:05.334275 | controller | ok 2025-09-30 11:23:05.339989 | 2025-09-30 11:23:05.340054 | TASK [Create ci-framework-data log directory for zuul] 2025-09-30 11:23:05.837562 | controller | changed 2025-09-30 11:23:05.855095 | 2025-09-30 11:23:05.855188 | TASK [Copy ci-framework interesting files] 2025-09-30 11:23:06.095560 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-09-30 11:23:06.394852 | controller | changed 2025-09-30 11:23:06.400611 | 2025-09-30 11:23:06.400680 | TASK [Get SELinux listing] 2025-09-30 11:23:06.929017 | controller | changed 2025-09-30 11:23:06.935041 | 2025-09-30 11:23:06.935109 | TASK [Generate log index] 2025-09-30 11:23:07.790877 | controller | changed 2025-09-30 11:23:07.798217 | 2025-09-30 11:23:07.798300 | TASK [Get some env related data] 2025-09-30 11:23:08.397788 | controller | /home/zuul/.local/bin/ansible 2025-09-30 11:23:09.369030 | controller | changed 2025-09-30 11:23:09.381074 | 2025-09-30 11:23:09.381168 | TASK [Generate list of logs to collect in home directory] 2025-09-30 11:23:09.692763 | controller | ok: All paths examined 2025-09-30 11:23:09.699099 | 2025-09-30 11:23:09.699183 | LOOP [Copy logs from home directory] 2025-09-30 11:23:10.046867 | controller | changed: 2025-09-30 11:23:10.047012 | controller | { 2025-09-30 11:23:10.047041 | controller | "atime": 1759231219.0310407, 2025-09-30 11:23:10.047061 | controller | "ctime": 1759231237.4709613, 2025-09-30 11:23:10.047081 | controller | "dev": 64513, 2025-09-30 11:23:10.047098 | controller | "gid": 1000, 2025-09-30 11:23:10.047116 | controller | "gr_name": "zuul", 2025-09-30 11:23:10.047134 | controller | "inode": 4403446, 2025-09-30 11:23:10.047163 | controller | "isblk": false, 2025-09-30 11:23:10.047181 | controller | "ischr": false, 2025-09-30 11:23:10.047632 | controller | "isdir": false, 2025-09-30 11:23:10.047814 | controller | "isfifo": false, 2025-09-30 11:23:10.047844 | controller | "isgid": false, 2025-09-30 11:23:10.047863 | controller | "islnk": false, 2025-09-30 11:23:10.047881 | controller | "isreg": true, 2025-09-30 11:23:10.047898 | controller | "issock": false, 2025-09-30 11:23:10.047916 | controller | "isuid": false, 2025-09-30 11:23:10.047933 | controller | "mode": "0644", 2025-09-30 11:23:10.047950 | controller | "mtime": 1759231237.4709613, 2025-09-30 11:23:10.047966 | controller | "nlink": 1, 2025-09-30 11:23:10.047983 | controller | "path": "/home/zuul/ansible.log", 2025-09-30 11:23:10.048000 | controller | "pw_name": "zuul", 2025-09-30 11:23:10.048026 | controller | "rgrp": true, 2025-09-30 11:23:10.048043 | controller | "roth": true, 2025-09-30 11:23:10.048059 | controller | "rusr": true, 2025-09-30 11:23:10.048074 | controller | "size": 6749, 2025-09-30 11:23:10.048089 | controller | "uid": 1000, 2025-09-30 11:23:10.048105 | controller | "wgrp": false, 2025-09-30 11:23:10.048120 | controller | "woth": false, 2025-09-30 11:23:10.048138 | controller | "wusr": true, 2025-09-30 11:23:10.048163 | controller | "xgrp": false, 2025-09-30 11:23:10.048180 | controller | "xoth": false, 2025-09-30 11:23:10.048196 | controller | "xusr": false 2025-09-30 11:23:10.048212 | controller | } 2025-09-30 11:23:10.058612 | 2025-09-30 11:23:10.058691 | TASK [Copy crio stats log file] 2025-09-30 11:23:10.097668 | controller | skipping: Conditional result was False 2025-09-30 11:23:10.103191 | 2025-09-30 11:23:10.103257 | TASK [Get SELinux related data] 2025-09-30 11:23:10.369367 | controller | 2025-09-30 11:23:10.666929 | controller | ERROR 2025-09-30 11:23:10.667045 | controller | { 2025-09-30 11:23:10.667077 | controller | "delta": "0:00:00.008769", 2025-09-30 11:23:10.667099 | controller | "end": "2025-09-30 11:23:10.370400", 2025-09-30 11:23:10.667117 | controller | "msg": "non-zero return code", 2025-09-30 11:23:10.667134 | controller | "rc": 1, 2025-09-30 11:23:10.667162 | controller | "start": "2025-09-30 11:23:10.361631" 2025-09-30 11:23:10.667181 | controller | } 2025-09-30 11:23:10.667204 | controller | ERROR: Ignoring Errors 2025-09-30 11:23:10.672565 | 2025-09-30 11:23:10.672633 | TASK [Create system configuration directory] 2025-09-30 11:23:10.904826 | controller | changed 2025-09-30 11:23:10.911471 | 2025-09-30 11:23:10.911536 | TASK [Get some of the system configurations] 2025-09-30 11:23:11.463834 | controller | changed 2025-09-30 11:23:11.480969 | 2025-09-30 11:23:11.481066 | TASK [Copy generated documentation if available] 2025-09-30 11:23:11.534983 | controller | skipping: Conditional result was False 2025-09-30 11:23:11.540898 | 2025-09-30 11:23:11.540965 | TASK [Copy generated AsciiDoc documentation if available] 2025-09-30 11:23:11.574705 | controller | skipping: Conditional result was False 2025-09-30 11:23:11.580377 | 2025-09-30 11:23:11.580464 | TASK [Compress logs bigger than 2MB] 2025-09-30 11:23:12.141455 | controller | changed 2025-09-30 11:23:12.147216 | 2025-09-30 11:23:12.147289 | TASK [Copy files from workspace on node] 2025-09-30 11:23:12.197275 | controller | ok 2025-09-30 11:23:12.227375 | 2025-09-30 11:23:12.227513 | TASK [fetch-output : Set log path for multiple nodes] 2025-09-30 11:23:12.272812 | controller | skipping: Conditional result was False 2025-09-30 11:23:12.279718 | 2025-09-30 11:23:12.279809 | TASK [fetch-output : Set log path for single node] 2025-09-30 11:23:12.318713 | controller | ok 2025-09-30 11:23:12.323715 | 2025-09-30 11:23:12.323778 | LOOP [fetch-output : Ensure local output dirs] 2025-09-30 11:23:12.701124 | controller -> localhost | ok: "/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/logs" 2025-09-30 11:23:12.701370 | controller -> localhost | changed: All items complete 2025-09-30 11:23:12.701461 | 2025-09-30 11:23:12.955879 | controller -> localhost | changed: "/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/artifacts" 2025-09-30 11:23:13.279307 | controller -> localhost | changed: "/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/docs" 2025-09-30 11:23:13.290996 | 2025-09-30 11:23:13.291093 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-09-30 11:23:13.928889 | controller | changed: 2025-09-30 11:23:13.929116 | controller | .d..t...... ./ 2025-09-30 11:23:13.929164 | controller | >f+++++++++ README.html 2025-09-30 11:23:13.929190 | controller | >f+++++++++ ansible-execution.log 2025-09-30 11:23:13.929211 | controller | >f+++++++++ ansible.log 2025-09-30 11:23:13.929230 | controller | >f+++++++++ dmesg.log 2025-09-30 11:23:13.929249 | controller | >f+++++++++ installed-pkgs.log 2025-09-30 11:23:13.929270 | controller | >f+++++++++ python.log 2025-09-30 11:23:13.929292 | controller | >f+++++++++ registries.conf 2025-09-30 11:23:13.929311 | controller | >f+++++++++ report.html 2025-09-30 11:23:13.929331 | controller | >f+++++++++ selinux-denials.log 2025-09-30 11:23:13.929349 | controller | >f+++++++++ selinux-listing.log 2025-09-30 11:23:13.929368 | controller | cd+++++++++ ci-framework-data/ 2025-09-30 11:23:13.929410 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-09-30 11:23:13.929432 | controller | >f+++++++++ ci-framework-data/artifacts/ctlplane.yaml 2025-09-30 11:23:13.929450 | controller | >f+++++++++ ci-framework-data/artifacts/dataplane.yaml 2025-09-30 11:23:13.929467 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key 2025-09-30 11:23:13.929484 | controller | >f+++++++++ ci-framework-data/artifacts/nova_migration_key.pub 2025-09-30 11:23:13.929500 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-ctlplane.yaml 2025-09-30 11:23:13.929518 | controller | >f+++++++++ ci-framework-data/artifacts/vanilla-dataplane.yaml 2025-09-30 11:23:13.929534 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-09-30 11:23:13.929551 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/ 2025-09-30 11:23:13.929567 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/ 2025-09-30 11:23:13.929585 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/edpm-nodeset-values/values.yaml 2025-09-30 11:23:13.929602 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/ 2025-09-30 11:23:13.929619 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml 2025-09-30 11:23:13.929636 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml.28924.2025-09-30@11:22:58~ 2025-09-30 11:23:13.929653 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/ 2025-09-30 11:23:13.929670 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/ 2025-09-30 11:23:13.929687 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/01_original.yaml 2025-09-30 11:23:13.929703 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/02_ci_data.yaml 2025-09-30 11:23:13.929719 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/03_user_data_b64.yaml 2025-09-30 11:23:13.929735 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/edpm-nodeset-values/04_user_data.yaml 2025-09-30 11:23:13.929756 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/ 2025-09-30 11:23:13.929773 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml 2025-09-30 11:23:13.929790 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml 2025-09-30 11:23:13.929806 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml.28754.2025-09-30@11:22:55~ 2025-09-30 11:23:13.929822 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml 2025-09-30 11:23:13.929837 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml 2025-09-30 11:23:13.929853 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/ 2025-09-30 11:23:13.929869 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/ 2025-09-30 11:23:13.929884 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/ 2025-09-30 11:23:13.929899 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-09-30 11:23:13.929915 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-09-30 11:23:13.929931 | controller | cd+++++++++ ci-framework-data/artifacts/repositories/ 2025-09-30 11:23:13.929946 | controller | >f+++++++++ ci-framework-data/artifacts/repositories/delorean.repo.md5 2025-09-30 11:23:13.929962 | controller | cd+++++++++ ci-framework-data/logs/ 2025-09-30 11:23:13.929978 | controller | >f+++++++++ ci-framework-data/logs/molecule-execution.log 2025-09-30 11:23:13.929994 | controller | cd+++++++++ registries.conf.d/ 2025-09-30 11:23:13.930009 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-09-30 11:23:13.930025 | controller | cd+++++++++ system-config/ 2025-09-30 11:23:13.930040 | controller | cd+++++++++ system-config/libvirt/ 2025-09-30 11:23:13.930056 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-09-30 11:23:13.930071 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-09-30 11:23:14.358552 | controller | changed: .d..t...... ./ 2025-09-30 11:23:14.838695 | controller | changed: .d..t...... ./ 2025-09-30 11:23:14.863419 | 2025-09-30 11:23:14.863523 | TASK [Return artifact to Zuul] 2025-09-30 11:23:14.924172 | controller | ok 2025-09-30 11:23:14.965070 | 2025-09-30 11:23:14.965167 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-09-30 11:23:14.965273 | 2025-09-30 11:23:14.965303 | PLAY RECAP 2025-09-30 11:23:14.965341 | controller | ok: 18 changed: 13 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 1 2025-09-30 11:23:14.965362 | 2025-09-30 11:23:15.070631 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-09-30 11:23:15.071379 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-09-30 11:23:16.021229 | 2025-09-30 11:23:16.021338 | PLAY [all] 2025-09-30 11:23:16.040300 | 2025-09-30 11:23:16.040374 | TASK [include_role : fetch-output] 2025-09-30 11:23:16.099540 | controller | ok 2025-09-30 11:23:16.124597 | 2025-09-30 11:23:16.124701 | TASK [fetch-output : Set log path for multiple nodes] 2025-09-30 11:23:16.180137 | controller | skipping: Conditional result was False 2025-09-30 11:23:16.185882 | 2025-09-30 11:23:16.185958 | TASK [fetch-output : Set log path for single node] 2025-09-30 11:23:16.225505 | controller | ok 2025-09-30 11:23:16.230748 | 2025-09-30 11:23:16.230818 | LOOP [fetch-output : Ensure local output dirs] 2025-09-30 11:23:16.740928 | controller -> localhost | ok: "/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/logs" 2025-09-30 11:23:17.039274 | controller -> localhost | ok: "/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/artifacts" 2025-09-30 11:23:17.390640 | controller -> localhost | ok: "/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/docs" 2025-09-30 11:23:17.403117 | 2025-09-30 11:23:17.403211 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-09-30 11:23:18.348337 | controller | ok 2025-09-30 11:23:18.348652 | controller | ok: All items complete 2025-09-30 11:23:18.348692 | 2025-09-30 11:23:18.887155 | controller | ok 2025-09-30 11:23:19.299266 | controller | ok 2025-09-30 11:23:19.311711 | 2025-09-30 11:23:19.311826 | TASK [include_role : fetch-output-openshift] 2025-09-30 11:23:19.326179 | controller | skipping: Conditional result was False 2025-09-30 11:23:19.332035 | 2025-09-30 11:23:19.332104 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-09-30 11:23:19.802187 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.019862 2025-09-30 11:23:20.207099 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.034148 2025-09-30 11:23:20.278513 | 2025-09-30 11:23:20.278600 | PLAY [all] 2025-09-30 11:23:20.311396 | 2025-09-30 11:23:20.311484 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-30 11:23:20.775541 | controller | changed 2025-09-30 11:23:20.846486 | 2025-09-30 11:23:20.846614 | PLAY RECAP 2025-09-30 11:23:20.846741 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-09-30 11:23:20.846800 | 2025-09-30 11:23:21.041223 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-09-30 11:23:21.041969 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-09-30 11:23:21.738504 | 2025-09-30 11:23:21.738609 | PLAY [localhost] 2025-09-30 11:23:21.756578 | 2025-09-30 11:23:21.756657 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-30 11:23:22.216228 | localhost | changed 2025-09-30 11:23:22.221198 | 2025-09-30 11:23:22.221288 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-30 11:23:22.277935 | localhost | ok 2025-09-30 11:23:22.286829 | 2025-09-30 11:23:22.286917 | TASK [add-fileserver : Create SSH private key tempfile] 2025-09-30 11:23:22.878534 | localhost | changed 2025-09-30 11:23:22.883672 | 2025-09-30 11:23:22.883744 | TASK [add-fileserver : Create SSH private key from secret] 2025-09-30 11:23:23.561160 | localhost | changed 2025-09-30 11:23:23.566116 | 2025-09-30 11:23:23.566210 | TASK [add-fileserver : Add fileserver ssh key] 2025-09-30 11:23:24.023118 | localhost | Identity added: /var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/tmp/ansible.f5taojk0 (/var/lib/zuul/builds/d8ec370de0f0412dadd4ba738e9ed9e9/work/tmp/ansible.f5taojk0) 2025-09-30 11:23:24.023338 | localhost | ok: Runtime: 0:00:00.026683 2025-09-30 11:23:24.028240 | 2025-09-30 11:23:24.028309 | TASK [add-fileserver : Remove SSH private key from disk] 2025-09-30 11:23:24.313903 | localhost | ok: Runtime: 0:00:00.006417 2025-09-30 11:23:24.318815 | 2025-09-30 11:23:24.318885 | TASK [add-fileserver : Add fileserver to inventory] 2025-09-30 11:23:24.367107 | localhost | changed 2025-09-30 11:23:24.371435 | 2025-09-30 11:23:24.371503 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-09-30 11:23:24.719791 | localhost | changed 2025-09-30 11:23:24.775773 | 2025-09-30 11:23:24.775879 | PLAY [localhost] 2025-09-30 11:23:24.792962 | 2025-09-30 11:23:24.793025 | TASK [Generate bulk log download script] 2025-09-30 11:23:24.810424 | localhost | ok 2025-09-30 11:23:24.822514 | 2025-09-30 11:23:24.822589 | TASK [local-log-download : Check API endpoint is defined] 2025-09-30 11:23:24.849713 | localhost | ok: All assertions passed 2025-09-30 11:23:24.854436 | 2025-09-30 11:23:24.854503 | TASK [local-log-download : Create download script] 2025-09-30 11:23:25.242617 | localhost -> localhost | changed 2025-09-30 11:23:25.251404 | 2025-09-30 11:23:25.251474 | TASK [Register quick-download link] 2025-09-30 11:23:25.270159 | localhost | ok 2025-09-30 11:23:25.309046 | 2025-09-30 11:23:25.309130 | PLAY [logserver.rdoproject.org] 2025-09-30 11:23:25.318807 | 2025-09-30 11:23:25.318867 | TASK [Set zuul-log-path fact] 2025-09-30 11:23:25.334379 | logserver.rdoproject.org | ok 2025-09-30 11:23:25.349792 | 2025-09-30 11:23:25.349865 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-30 11:23:25.376160 | logserver.rdoproject.org | ok 2025-09-30 11:23:25.381687 | 2025-09-30 11:23:25.381757 | TASK [upload-logs : Create log directories] 2025-09-30 11:23:27.127313 | logserver.rdoproject.org | changed 2025-09-30 11:23:27.130621 | 2025-09-30 11:23:27.130688 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-30 11:23:27.378662 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.005505 2025-09-30 11:23:27.383487 | 2025-09-30 11:23:27.383553 | TASK [upload-logs : Upload logs to log server] 2025-09-30 11:23:28.999963 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-09-30 11:23:29.005345 | 2025-09-30 11:23:29.005474 | LOOP [upload-logs : Compress console log and json output] 2025-09-30 11:23:29.068261 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 11:23:29.076124 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 11:23:29.084256 | 2025-09-30 11:23:29.084356 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-30 11:23:29.127322 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 11:23:29.127574 | 2025-09-30 11:23:29.130751 | logserver.rdoproject.org | skipping: Conditional result was False 2025-09-30 11:23:29.141742 | 2025-09-30 11:23:29.141840 | LOOP [upload-logs : Upload console log and json output]