2025-11-25 15:40:52.038729 | Job console starting... 2025-11-25 15:40:52.055048 | Updating repositories 2025-11-25 15:40:52.097064 | Preparing job workspace 2025-11-25 15:40:57.201833 | Running Ansible setup... 2025-11-25 15:41:04.358867 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-11-25 15:41:04.968061 | 2025-11-25 15:41:04.968207 | PLAY [localhost] 2025-11-25 15:41:04.979095 | 2025-11-25 15:41:04.979185 | TASK [Gathering Facts] 2025-11-25 15:41:06.018100 | localhost | ok 2025-11-25 15:41:06.045203 | 2025-11-25 15:41:06.045403 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-25 15:41:06.512129 | localhost -> localhost | changed 2025-11-25 15:41:06.519157 | 2025-11-25 15:41:06.519249 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-25 15:41:07.463867 | localhost -> localhost | changed 2025-11-25 15:41:07.477616 | 2025-11-25 15:41:07.477730 | TASK [Setup log path fact] 2025-11-25 15:41:07.499400 | localhost | ok 2025-11-25 15:41:07.517714 | 2025-11-25 15:41:07.517850 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-25 15:41:07.547871 | localhost | ok 2025-11-25 15:41:07.556332 | 2025-11-25 15:41:07.556404 | TASK [emit-job-header : Print job information] 2025-11-25 15:41:07.586844 | # Job Information 2025-11-25 15:41:07.587060 | Ansible Version: 2.15.12 2025-11-25 15:41:07.587351 | Job: rhoso-architecture-validate-nova04delta-adoption 2025-11-25 15:41:07.587395 | Pipeline: github-check 2025-11-25 15:41:07.587425 | Executor: ze01.softwarefactory-project.io 2025-11-25 15:41:07.587452 | Triggered by: https://github.com/openstack-k8s-operators/architecture/pull/661 2025-11-25 15:41:07.587482 | Log URL (when completed): https://logserver.rdoproject.org/ac6/rdoproject.org/ac6d664ac2e44e9585d5941fd3c6ee96/ 2025-11-25 15:41:07.587510 | Event ID: eeb71d20-ca14-11f0-8454-6efd9d9e23db 2025-11-25 15:41:07.594428 | 2025-11-25 15:41:07.594523 | LOOP [emit-job-header : Print node information] 2025-11-25 15:41:07.705382 | localhost | ok: 2025-11-25 15:41:07.705792 | localhost | # Node Information 2025-11-25 15:41:07.705826 | localhost | Inventory Hostname: controller 2025-11-25 15:41:07.705849 | localhost | Hostname: np0005535555 2025-11-25 15:41:07.705868 | localhost | Username: zuul 2025-11-25 15:41:07.705888 | localhost | Distro: CentOS 9 2025-11-25 15:41:07.705905 | localhost | Provider: vexxhost-nodepool-tripleo 2025-11-25 15:41:07.705922 | localhost | Region: RegionOne 2025-11-25 15:41:07.705938 | localhost | Label: cloud-centos-9-stream-tripleo 2025-11-25 15:41:07.705954 | localhost | Product Name: OpenStack Nova 2025-11-25 15:41:07.705970 | localhost | Interface IP: 38.129.56.60 2025-11-25 15:41:07.741679 | 2025-11-25 15:41:07.741802 | PLAY [all] 2025-11-25 15:41:07.748879 | 2025-11-25 15:41:07.748947 | TASK [Gather network facts] 2025-11-25 15:41:08.276865 | controller | ok 2025-11-25 15:41:08.294556 | 2025-11-25 15:41:08.294640 | TASK [include_role : start-zuul-console] 2025-11-25 15:41:08.314862 | controller | ok 2025-11-25 15:41:08.327636 | 2025-11-25 15:41:08.327711 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-25 15:41:08.770736 | controller | ok 2025-11-25 15:41:08.780826 | 2025-11-25 15:41:08.780952 | TASK [include_role : add-build-sshkey] 2025-11-25 15:41:08.811548 | controller | ok 2025-11-25 15:41:08.826215 | 2025-11-25 15:41:08.826347 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-25 15:41:09.097011 | controller -> localhost | ok 2025-11-25 15:41:09.106003 | 2025-11-25 15:41:09.106182 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-25 15:41:09.145530 | controller | ok 2025-11-25 15:41:09.182644 | controller | included: /var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-25 15:41:09.197556 | 2025-11-25 15:41:09.198058 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-25 15:41:10.214149 | controller -> localhost | Generating public/private rsa key pair. 2025-11-25 15:41:10.214471 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/ac6d664ac2e44e9585d5941fd3c6ee96_id_rsa. 2025-11-25 15:41:10.214503 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/ac6d664ac2e44e9585d5941fd3c6ee96_id_rsa.pub. 2025-11-25 15:41:10.214524 | controller -> localhost | The key fingerprint is: 2025-11-25 15:41:10.214548 | controller -> localhost | SHA256:4GJ6dPIpHySA4rYproXBOtQOmb5PKX5zAqJ9fJq5n0o zuul-build-sshkey 2025-11-25 15:41:10.214567 | controller -> localhost | The key's randomart image is: 2025-11-25 15:41:10.214586 | controller -> localhost | +---[RSA 3072]----+ 2025-11-25 15:41:10.214603 | controller -> localhost | | | 2025-11-25 15:41:10.214620 | controller -> localhost | | . | 2025-11-25 15:41:10.214638 | controller -> localhost | |o . . | 2025-11-25 15:41:10.214655 | controller -> localhost | |+ +. . . | 2025-11-25 15:41:10.214672 | controller -> localhost | |.O .* + S | 2025-11-25 15:41:10.214688 | controller -> localhost | |*+=+.B . | 2025-11-25 15:41:10.214705 | controller -> localhost | |B*+=E + | 2025-11-25 15:41:10.214724 | controller -> localhost | |=o=*o*.o | 2025-11-25 15:41:10.214740 | controller -> localhost | |o+ooX*+ | 2025-11-25 15:41:10.214757 | controller -> localhost | +----[SHA256]-----+ 2025-11-25 15:41:10.214800 | controller -> localhost | ok: Runtime: 0:00:00.522104 2025-11-25 15:41:10.221006 | 2025-11-25 15:41:10.221088 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-25 15:41:10.252329 | controller | ok 2025-11-25 15:41:10.266140 | controller | included: /var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-25 15:41:10.278420 | 2025-11-25 15:41:10.278543 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-25 15:41:10.304145 | controller | skipping: Conditional result was False 2025-11-25 15:41:10.312884 | 2025-11-25 15:41:10.312980 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-25 15:41:12.779391 | controller | changed 2025-11-25 15:41:12.793904 | 2025-11-25 15:41:12.794154 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-25 15:41:13.102802 | controller | ok 2025-11-25 15:41:13.117737 | 2025-11-25 15:41:13.118139 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-25 15:41:13.932084 | controller | changed 2025-11-25 15:41:13.939684 | 2025-11-25 15:41:13.939801 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-25 15:41:14.716868 | controller | changed 2025-11-25 15:41:14.729895 | 2025-11-25 15:41:14.730115 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-25 15:41:14.778815 | controller | skipping: Conditional result was False 2025-11-25 15:41:14.792545 | 2025-11-25 15:41:14.792744 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-25 15:41:15.187240 | controller -> localhost | changed 2025-11-25 15:41:15.197460 | 2025-11-25 15:41:15.197532 | TASK [add-build-sshkey : Add back temp key] 2025-11-25 15:41:15.538433 | controller -> localhost | Identity added: /var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/ac6d664ac2e44e9585d5941fd3c6ee96_id_rsa (zuul-build-sshkey) 2025-11-25 15:41:15.538965 | controller -> localhost | ok: Runtime: 0:00:00.014051 2025-11-25 15:41:15.552571 | 2025-11-25 15:41:15.552717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-25 15:41:15.932107 | controller | ok 2025-11-25 15:41:15.945300 | 2025-11-25 15:41:15.945471 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-25 15:41:15.984854 | controller | skipping: Conditional result was False 2025-11-25 15:41:15.996986 | 2025-11-25 15:41:15.997101 | TASK [include_role : validate-host] 2025-11-25 15:41:16.055898 | controller | ok 2025-11-25 15:41:16.076086 | 2025-11-25 15:41:16.076225 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-25 15:41:16.127462 | controller | ok 2025-11-25 15:41:16.132753 | 2025-11-25 15:41:16.132829 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-25 15:41:16.411256 | controller -> localhost | ok 2025-11-25 15:41:16.418520 | 2025-11-25 15:41:16.418590 | TASK [validate-host : Collect information about the host] 2025-11-25 15:41:17.198642 | controller | ok 2025-11-25 15:41:17.218661 | 2025-11-25 15:41:17.218850 | TASK [validate-host : Sanitize hostname] 2025-11-25 15:41:17.292992 | controller | ok 2025-11-25 15:41:17.298271 | 2025-11-25 15:41:17.298385 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-25 15:41:17.784303 | controller -> localhost | changed 2025-11-25 15:41:17.797680 | 2025-11-25 15:41:17.797859 | TASK [validate-host : Collect information about zuul worker] 2025-11-25 15:41:18.173862 | controller | ok 2025-11-25 15:41:18.180204 | 2025-11-25 15:41:18.180298 | TASK [validate-host : Write out all zuul information for each host] 2025-11-25 15:41:18.770437 | controller -> localhost | changed 2025-11-25 15:41:18.790800 | 2025-11-25 15:41:18.790955 | TASK [include_role : prepare-workspace-openshift] 2025-11-25 15:41:18.818156 | controller | skipping: Conditional result was False 2025-11-25 15:41:18.831351 | 2025-11-25 15:41:18.831484 | TASK [include_role : remove-zuul-sshkey] 2025-11-25 15:41:18.858570 | controller | skipping: Conditional result was False 2025-11-25 15:41:18.872259 | 2025-11-25 15:41:18.872405 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-25 15:41:19.147435 | controller | ok: "logs" 2025-11-25 15:41:19.147869 | controller | ok: All items complete 2025-11-25 15:41:19.147980 | 2025-11-25 15:41:19.355113 | controller | ok: "artifacts" 2025-11-25 15:41:19.581519 | controller | ok: "docs" 2025-11-25 15:41:19.598256 | 2025-11-25 15:41:19.598421 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-25 15:41:19.848169 | controller | changed: "logs" 2025-11-25 15:41:20.054562 | controller | changed: "artifacts" 2025-11-25 15:41:20.284165 | controller | changed: "docs" 2025-11-25 15:41:20.319249 | 2025-11-25 15:41:20.319390 | PLAY RECAP 2025-11-25 15:41:20.319476 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-11-25 15:41:20.319520 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-25 15:41:20.319547 | 2025-11-25 15:41:20.468569 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-11-25 15:41:20.470087 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-11-25 15:41:21.152809 | 2025-11-25 15:41:21.152980 | PLAY [all] 2025-11-25 15:41:21.173891 | 2025-11-25 15:41:21.174094 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-11-25 15:41:21.225476 | controller | ok 2025-11-25 15:41:21.230889 | 2025-11-25 15:41:21.230970 | TASK [mirror-info-fork : Create /etc/ci] 2025-11-25 15:41:21.707675 | controller | changed 2025-11-25 15:41:21.720253 | 2025-11-25 15:41:21.720391 | TASK [mirror-info-fork : Install ci_mirror script] 2025-11-25 15:41:22.786320 | controller | changed 2025-11-25 15:41:22.810495 | 2025-11-25 15:41:22.810719 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-11-25 15:41:23.304313 | controller | changed: 2025-11-25 15:41:23.305093 | controller | { 2025-11-25 15:41:23.305184 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-11-25 15:41:23.305248 | controller | } 2025-11-25 15:41:23.581919 | controller | changed: 2025-11-25 15:41:23.582117 | controller | { 2025-11-25 15:41:23.582174 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-11-25 15:41:23.582217 | controller | } 2025-11-25 15:41:23.852573 | controller | changed: 2025-11-25 15:41:23.852770 | controller | { 2025-11-25 15:41:23.852830 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-11-25 15:41:23.852875 | controller | } 2025-11-25 15:41:24.138404 | controller | changed: 2025-11-25 15:41:24.138561 | controller | { 2025-11-25 15:41:24.138612 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-11-25 15:41:24.138651 | controller | } 2025-11-25 15:41:24.408046 | controller | changed: 2025-11-25 15:41:24.409801 | controller | { 2025-11-25 15:41:24.409894 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-11-25 15:41:24.409942 | controller | } 2025-11-25 15:41:24.691895 | controller | changed: 2025-11-25 15:41:24.692092 | controller | { 2025-11-25 15:41:24.692145 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-11-25 15:41:24.692185 | controller | } 2025-11-25 15:41:24.957160 | controller | changed: 2025-11-25 15:41:24.957303 | controller | { 2025-11-25 15:41:24.957333 | 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-11-25 15:41:24.957359 | controller | } 2025-11-25 15:41:25.225551 | controller | changed: 2025-11-25 15:41:25.226666 | controller | { 2025-11-25 15:41:25.226800 | 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-11-25 15:41:25.226853 | controller | } 2025-11-25 15:41:25.499523 | controller | changed: 2025-11-25 15:41:25.499721 | controller | { 2025-11-25 15:41:25.499770 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-11-25 15:41:25.499808 | controller | } 2025-11-25 15:41:25.883892 | controller | changed: 2025-11-25 15:41:25.884041 | controller | { 2025-11-25 15:41:25.884078 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-11-25 15:41:25.884106 | controller | } 2025-11-25 15:41:26.103134 | controller | changed: 2025-11-25 15:41:26.103298 | controller | { 2025-11-25 15:41:26.103348 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-11-25 15:41:26.103390 | controller | } 2025-11-25 15:41:26.372394 | controller | changed: 2025-11-25 15:41:26.372560 | controller | { 2025-11-25 15:41:26.372610 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-11-25 15:41:26.372649 | controller | } 2025-11-25 15:41:26.664983 | controller | changed: 2025-11-25 15:41:26.665648 | controller | { 2025-11-25 15:41:26.665720 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-11-25 15:41:26.665775 | controller | } 2025-11-25 15:41:26.940691 | controller | changed: 2025-11-25 15:41:26.941076 | controller | { 2025-11-25 15:41:26.941150 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-11-25 15:41:26.941194 | controller | } 2025-11-25 15:41:27.218197 | controller | changed: 2025-11-25 15:41:27.219208 | controller | { 2025-11-25 15:41:27.219332 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-11-25 15:41:27.219399 | controller | } 2025-11-25 15:41:27.544771 | controller | changed: 2025-11-25 15:41:27.544936 | controller | { 2025-11-25 15:41:27.544986 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-11-25 15:41:27.545059 | controller | } 2025-11-25 15:41:27.852183 | controller | changed: 2025-11-25 15:41:27.852676 | controller | { 2025-11-25 15:41:27.852769 | 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-11-25 15:41:27.852831 | controller | } 2025-11-25 15:41:28.123980 | controller | changed: 2025-11-25 15:41:28.124222 | controller | { 2025-11-25 15:41:28.124260 | 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-11-25 15:41:28.124450 | controller | } 2025-11-25 15:41:28.397735 | controller | changed: 2025-11-25 15:41:28.398076 | controller | { 2025-11-25 15:41:28.398152 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-11-25 15:41:28.398196 | controller | } 2025-11-25 15:41:28.681238 | controller | changed: 2025-11-25 15:41:28.681383 | controller | { 2025-11-25 15:41:28.681418 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-11-25 15:41:28.681449 | controller | } 2025-11-25 15:41:28.960448 | controller | changed: 2025-11-25 15:41:28.960609 | controller | { 2025-11-25 15:41:28.960660 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-11-25 15:41:28.960699 | controller | } 2025-11-25 15:41:29.245254 | controller | changed: 2025-11-25 15:41:29.245389 | controller | { 2025-11-25 15:41:29.245427 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-11-25 15:41:29.245459 | controller | } 2025-11-25 15:41:29.529253 | controller | changed: 2025-11-25 15:41:29.529461 | controller | { 2025-11-25 15:41:29.529502 | 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-11-25 15:41:29.529538 | controller | } 2025-11-25 15:41:29.829976 | controller | changed: 2025-11-25 15:41:29.830513 | controller | { 2025-11-25 15:41:29.830637 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-11-25 15:41:29.830704 | controller | } 2025-11-25 15:41:30.104858 | controller | changed: 2025-11-25 15:41:30.105048 | controller | { 2025-11-25 15:41:30.105104 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-11-25 15:41:30.105144 | controller | } 2025-11-25 15:41:30.383733 | controller | changed: 2025-11-25 15:41:30.384098 | controller | { 2025-11-25 15:41:30.384171 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-11-25 15:41:30.384221 | controller | } 2025-11-25 15:41:30.436316 | 2025-11-25 15:41:30.436527 | TASK [Set timezone to UTC] 2025-11-25 15:41:32.075001 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-11-25 15:41:32.086131 | 2025-11-25 15:41:32.086232 | TASK [Create nodepool directory] 2025-11-25 15:41:32.382462 | controller | changed 2025-11-25 15:41:32.388047 | 2025-11-25 15:41:32.388109 | TASK [Create nodepool sub_nodes file] 2025-11-25 15:41:33.087207 | controller | changed 2025-11-25 15:41:33.098960 | 2025-11-25 15:41:33.099170 | TASK [Create nodepool sub_nodes_private file] 2025-11-25 15:41:33.907815 | controller | changed 2025-11-25 15:41:33.921203 | 2025-11-25 15:41:33.921374 | LOOP [Populate nodepool sub_nodes file] 2025-11-25 15:41:33.963533 | 2025-11-25 15:41:33.963908 | LOOP [Populate nodepool sub_nodes_private file] 2025-11-25 15:41:34.006310 | 2025-11-25 15:41:34.006607 | TASK [Create nodepool primary file] 2025-11-25 15:41:34.055566 | controller | skipping: Conditional result was False 2025-11-25 15:41:34.069802 | 2025-11-25 15:41:34.069997 | TASK [Create nodepool node_private for this node] 2025-11-25 15:41:34.884527 | controller | changed 2025-11-25 15:41:34.900866 | 2025-11-25 15:41:34.901085 | LOOP [Copy ssh keys to nodepool directory] 2025-11-25 15:41:35.364080 | controller | ok: Item: id_rsa Runtime: 0:00:00.009892 2025-11-25 15:41:35.365082 | 2025-11-25 15:41:35.616984 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.033352 2025-11-25 15:41:35.637874 | 2025-11-25 15:41:35.638082 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-11-25 15:41:36.372697 | controller | changed 2025-11-25 15:41:36.380355 | 2025-11-25 15:41:36.380445 | TASK [Validate sudoers config after edits] 2025-11-25 15:41:36.709443 | controller | /etc/sudoers: parsed OK 2025-11-25 15:41:36.709531 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-11-25 15:41:36.709553 | controller | /etc/sudoers.d/zuul: parsed OK 2025-11-25 15:41:36.709560 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-11-25 15:41:36.923526 | controller | ok: Runtime: 0:00:00.009750 2025-11-25 15:41:36.936973 | 2025-11-25 15:41:36.937154 | TASK [Show the environment passed in to job shell scripts] 2025-11-25 15:41:37.256603 | controller | SHELL=/bin/bash 2025-11-25 15:41:37.256685 | controller | ZUUL_PROJECT=openstack-k8s-operators/architecture 2025-11-25 15:41:37.256706 | controller | ZUUL_SHORT_PROJECT_NAME=architecture 2025-11-25 15:41:37.256733 | controller | ZUUL_CHANGES=openstack-k8s-operators/architecture:main:refs/changes/61/661/06f3b7424d748b94125a0517fb09ee2728c52997 2025-11-25 15:41:37.256747 | controller | PWD=/home/zuul 2025-11-25 15:41:37.256761 | controller | ZUUL_PIPELINE=github-check 2025-11-25 15:41:37.256775 | controller | LOGNAME=zuul 2025-11-25 15:41:37.256788 | controller | XDG_SESSION_TYPE=tty 2025-11-25 15:41:37.256801 | controller | _=/usr/bin/env 2025-11-25 15:41:37.256814 | controller | MOTD_SHOWN=pam 2025-11-25 15:41:37.256903 | controller | HOME=/home/zuul 2025-11-25 15:41:37.256920 | controller | LANG=en_US.UTF-8 2025-11-25 15:41:37.256933 | controller | SSH_CONNECTION=38.102.83.114 59994 38.129.56.60 22 2025-11-25 15:41:37.256947 | 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-11-25 15:41:37.256968 | controller | ZUUL_CHANGE_IDS=661,06f3b7424d748b94125a0517fb09ee2728c52997 2025-11-25 15:41:37.256982 | controller | WORKSPACE=/home/zuul/workspace 2025-11-25 15:41:37.256996 | controller | XDG_SESSION_CLASS=user 2025-11-25 15:41:37.257013 | controller | SELINUX_ROLE_REQUESTED= 2025-11-25 15:41:37.257030 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-11-25 15:41:37.257045 | controller | USER=zuul 2025-11-25 15:41:37.257058 | controller | ZUUL_VOTING=True 2025-11-25 15:41:37.257071 | controller | BUILD_TIMEOUT=1800000 2025-11-25 15:41:37.257084 | controller | SELINUX_USE_CURRENT_RANGE= 2025-11-25 15:41:37.257097 | controller | SHLVL=1 2025-11-25 15:41:37.257110 | controller | ZUUL_PATCHSET=06f3b7424d748b94125a0517fb09ee2728c52997 2025-11-25 15:41:37.257124 | controller | XDG_SESSION_ID=1 2025-11-25 15:41:37.257137 | controller | ZUUL_BRANCH=main 2025-11-25 15:41:37.257150 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-11-25 15:41:37.257163 | controller | SSH_CLIENT=38.102.83.114 59994 22 2025-11-25 15:41:37.257176 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-11-25 15:41:37.257189 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-11-25 15:41:37.257207 | controller | which_declare=declare -f 2025-11-25 15:41:37.257221 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-11-25 15:41:37.257234 | controller | SELINUX_LEVEL_REQUESTED= 2025-11-25 15:41:37.257247 | controller | ZUUL_CHANGE=661 2025-11-25 15:41:37.257260 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-11-25 15:41:37.257274 | controller | ZUUL_UUID=ac6d664ac2e44e9585d5941fd3c6ee96 2025-11-25 15:41:37.257287 | controller | BASH_FUNC_which%%=() { ( alias; 2025-11-25 15:41:37.257301 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-11-25 15:41:37.257314 | controller | } 2025-11-25 15:41:37.492614 | controller | ok: Runtime: 0:00:00.011994 2025-11-25 15:41:37.501407 | 2025-11-25 15:41:37.501505 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-11-25 15:41:37.527922 | controller | skipping: Conditional result was False 2025-11-25 15:41:37.534705 | 2025-11-25 15:41:37.534790 | TASK [Symlink /home/zuul-worker/workspace] 2025-11-25 15:41:38.069688 | controller | skipping: Conditional result was False 2025-11-25 15:41:38.141227 | 2025-11-25 15:41:38.141420 | TASK [Ensure legacy workspace directory] 2025-11-25 15:41:38.446533 | controller | changed 2025-11-25 15:41:38.466880 | 2025-11-25 15:41:38.466954 | PLAY RECAP 2025-11-25 15:41:38.466999 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-11-25 15:41:38.467042 | 2025-11-25 15:41:38.600945 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-11-25 15:41:38.601902 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-11-25 15:41:39.402195 | 2025-11-25 15:41:39.402341 | PLAY [Run ci/playbooks/e2e-prepare.yml] 2025-11-25 15:41:39.439509 | 2025-11-25 15:41:39.439598 | TASK [Clone repos in the job workspace] 2025-11-25 15:41:39.470575 | controller | ok 2025-11-25 15:41:39.488067 | 2025-11-25 15:41:39.488147 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-25 15:41:39.926461 | controller | ok 2025-11-25 15:41:39.934033 | 2025-11-25 15:41:39.934118 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-25 15:41:44.062308 | controller | Output suppressed because no_log was given 2025-11-25 15:41:44.084373 | 2025-11-25 15:41:44.084612 | TASK [Create zuul-output directory] 2025-11-25 15:41:44.478211 | controller | ok 2025-11-25 15:41:44.492793 | 2025-11-25 15:41:44.492942 | TASK [Install required packages] 2025-11-25 15:43:12.839294 | controller | changed 2025-11-25 15:43:12.852338 | 2025-11-25 15:43:12.852478 | TASK [Output pip related things] 2025-11-25 15:43:13.917285 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9) 2025-11-25 15:43:14.404165 | controller | changed 2025-11-25 15:43:14.415766 | 2025-11-25 15:43:14.415900 | TASK [Install requirements] 2025-11-25 15:45:04.552717 | controller | changed 2025-11-25 15:45:04.577124 | 2025-11-25 15:45:04.577225 | TASK [Add cronjob to trigger job stats] 2025-11-25 15:45:04.644833 | controller | skipping: Conditional result was False 2025-11-25 15:45:04.654297 | 2025-11-25 15:45:04.654388 | LOOP [Construct project change list] 2025-11-25 15:45:04.727712 | controller | ok: 2025-11-25 15:45:04.727965 | controller | { 2025-11-25 15:45:04.727991 | controller | "branch": "main", 2025-11-25 15:45:04.728010 | controller | "change": "661", 2025-11-25 15:45:04.728052 | controller | "change_message": "nova04/vfio: fix storage class overriding\n\nThe storage lib component relies on network-values data for setting\r\ncontrol plane SC values, historically. The replacement of telemetry\r\ndata overrides this in the nova04delta and vfio DT/VA.\r\n\r\nFix that by re-applying the storage component logic locally in the\r\nDT/VA as well, while repurposing it to control-plane data instead of\r\nnetwork-values. The downside if that the same SC must be specified\r\nin two places now - network-values and service-values, but this\r\ngives us full flexibility to configure the telemetry service template\r\nspec.\r\n\r\nWe would not have to do that, if T-O had been taking the top scope\r\nstorageClass for its metricStorage template.", 2025-11-25 15:45:04.728077 | controller | "change_url": "https://github.com/openstack-k8s-operators/architecture/pull/661", 2025-11-25 15:45:04.728111 | controller | "commit_id": "06f3b7424d748b94125a0517fb09ee2728c52997", 2025-11-25 15:45:04.728128 | controller | "patchset": "06f3b7424d748b94125a0517fb09ee2728c52997", 2025-11-25 15:45:04.728144 | controller | "project": { 2025-11-25 15:45:04.728160 | controller | "canonical_hostname": "github.com", 2025-11-25 15:45:04.728176 | controller | "canonical_name": "github.com/openstack-k8s-operators/architecture", 2025-11-25 15:45:04.728191 | controller | "name": "openstack-k8s-operators/architecture", 2025-11-25 15:45:04.728206 | controller | "short_name": "architecture", 2025-11-25 15:45:04.728220 | controller | "src_dir": "src/github.com/openstack-k8s-operators/architecture" 2025-11-25 15:45:04.728236 | controller | }, 2025-11-25 15:45:04.728252 | controller | "topic": null 2025-11-25 15:45:04.728267 | controller | } 2025-11-25 15:45:04.790206 | 2025-11-25 15:45:04.790356 | PLAY [Run ci/playbooks/build_runner_image.yml] 2025-11-25 15:45:04.810090 | 2025-11-25 15:45:04.810155 | TASK [Filter out host if needed] 2025-11-25 15:45:04.821467 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-11-25 15:45:04.827482 | 2025-11-25 15:45:04.827551 | TASK [Get git tag for image tagging] 2025-11-25 15:45:05.357673 | controller | skipping: Conditional result was False 2025-11-25 15:45:05.371803 | 2025-11-25 15:45:05.371944 | TASK [Set openstack-runner image] 2025-11-25 15:45:05.491693 | controller | skipping: Conditional result was False 2025-11-25 15:45:05.499915 | 2025-11-25 15:45:05.500000 | TASK [Build openstack-runner image] 2025-11-25 15:45:05.537172 | controller | skipping: Conditional result was False 2025-11-25 15:45:05.546462 | 2025-11-25 15:45:05.546557 | TASK [Push openstack-runner image] 2025-11-25 15:45:05.575713 | controller | skipping: Conditional result was False 2025-11-25 15:45:05.584632 | 2025-11-25 15:45:05.584700 | TASK [Make sure ci-framework directory exists] 2025-11-25 15:45:05.610360 | controller | skipping: Conditional result was False 2025-11-25 15:45:05.617229 | 2025-11-25 15:45:05.617299 | TASK [Create EDPM ansible var file] 2025-11-25 15:45:05.643139 | controller | skipping: Conditional result was False 2025-11-25 15:45:05.666829 | 2025-11-25 15:45:05.666897 | PLAY RECAP 2025-11-25 15:45:05.666945 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-11-25 15:45:05.666965 | 2025-11-25 15:45:05.853811 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-11-25 15:45:05.855173 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-11-25 15:45:06.442361 | 2025-11-25 15:45:06.442494 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-11-25 15:45:06.463327 | 2025-11-25 15:45:06.463405 | TASK [Create zuul-output directory] 2025-11-25 15:45:06.960201 | controller | changed 2025-11-25 15:45:06.972011 | 2025-11-25 15:45:06.972240 | TASK [Slurp Zuul inventory test] 2025-11-25 15:45:07.314895 | controller -> localhost | ok 2025-11-25 15:45:07.321689 | 2025-11-25 15:45:07.321780 | TASK [Save zuul inventory] 2025-11-25 15:45:09.107165 | controller | changed 2025-11-25 15:45:09.121862 | 2025-11-25 15:45:09.122067 | TASK [Save zuul vars without the change_message] 2025-11-25 15:45:10.269920 | controller | changed 2025-11-25 15:45:10.301227 | 2025-11-25 15:45:10.301352 | PLAY RECAP 2025-11-25 15:45:10.301413 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-25 15:45:10.301441 | 2025-11-25 15:45:10.397891 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-11-25 15:45:10.398874 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/architecture/run.yml@main] 2025-11-25 15:45:10.987199 | 2025-11-25 15:45:10.987308 | PLAY [Run ci/playbooks/architecture/validate-architecture.yml] 2025-11-25 15:45:11.008185 | 2025-11-25 15:45:11.008270 | TASK [Filter out host if needed] 2025-11-25 15:45:11.017144 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-11-25 15:45:11.022075 | 2025-11-25 15:45:11.022140 | TASK [Run playbook] 2025-11-25 15:45:12.067255 | controller | 2025-11-25 15:45:13.022896 | controller | PLAY [Test architecture automations] ******************************************* 2025-11-25 15:45:13.022967 | controller | 2025-11-25 15:45:13.022982 | controller | TASK [Gathering Facts ] ******************************************************** 2025-11-25 15:45:13.022994 | controller | Tuesday 25 November 2025 15:45:12 +0000 (0:00:00.045) 0:00:00.045 ****** 2025-11-25 15:45:13.023006 | controller | Tuesday 25 November 2025 15:45:12 +0000 (0:00:00.043) 0:00:00.043 ****** 2025-11-25 15:45:13.023028 | controller | ok: [localhost] 2025-11-25 15:45:13.069673 | controller | 2025-11-25 15:45:13.069739 | controller | TASK [Assert we have the bare minimum to run quiet=True, that=['cifmw_architecture_repo is defined', 'cifmw_architecture_scenario is defined', 'cifmw_networking_mapper_networking_env_def_path is defined']] *** 2025-11-25 15:45:13.069759 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.956) 0:00:01.001 ****** 2025-11-25 15:45:13.069768 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.956) 0:00:00.999 ****** 2025-11-25 15:45:13.069786 | controller | ok: [localhost] 2025-11-25 15:45:13.105135 | controller | 2025-11-25 15:45:13.105183 | controller | TASK [ci_setup : Gather variables for each operating system _raw_params={{ item }}] *** 2025-11-25 15:45:13.105194 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.046) 0:00:01.048 ****** 2025-11-25 15:45:13.105204 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.046) 0:00:01.046 ****** 2025-11-25 15:45:13.105220 | controller | ok: [localhost] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml) 2025-11-25 15:45:13.124033 | controller | 2025-11-25 15:45:13.124066 | controller | TASK [ci_setup : List packages to install var=cifmw_ci_setup_packages] ********* 2025-11-25 15:45:13.124076 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.035) 0:00:01.084 ****** 2025-11-25 15:45:13.124085 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.035) 0:00:01.082 ****** 2025-11-25 15:45:13.124100 | controller | ok: [localhost] => 2025-11-25 15:45:19.150492 | controller | cifmw_ci_setup_packages: 2025-11-25 15:45:19.150531 | controller | - bash-completion 2025-11-25 15:45:19.150538 | controller | - ca-certificates 2025-11-25 15:45:19.150558 | controller | - git-core 2025-11-25 15:45:19.150564 | controller | - make 2025-11-25 15:45:19.150570 | controller | - tar 2025-11-25 15:45:19.150579 | controller | - tmux 2025-11-25 15:45:19.150585 | controller | - python3-pip 2025-11-25 15:45:19.150592 | controller | 2025-11-25 15:45:19.150599 | controller | TASK [ci_setup : Install needed packages name={{ cifmw_ci_setup_packages }}, state=latest] *** 2025-11-25 15:45:19.150615 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.018) 0:00:01.103 ****** 2025-11-25 15:45:19.150623 | controller | Tuesday 25 November 2025 15:45:13 +0000 (0:00:00.018) 0:00:01.101 ****** 2025-11-25 15:45:19.150636 | controller | changed: [localhost] 2025-11-25 15:45:19.436018 | controller | 2025-11-25 15:45:19.436080 | controller | TASK [ci_setup : Gather version of openshift client _raw_params=oc version --client -o yaml] *** 2025-11-25 15:45:19.436088 | controller | Tuesday 25 November 2025 15:45:19 +0000 (0:00:06.025) 0:00:07.129 ****** 2025-11-25 15:45:19.436095 | controller | Tuesday 25 November 2025 15:45:19 +0000 (0:00:06.026) 0:00:07.127 ****** 2025-11-25 15:45:19.436109 | controller | ok: [localhost] 2025-11-25 15:45:19.751025 | controller | 2025-11-25 15:45:19.751099 | controller | TASK [ci_setup : Ensure openshift client install path is present path={{ cifmw_ci_setup_oc_install_path }}, state=directory, mode=0755] *** 2025-11-25 15:45:19.751116 | controller | Tuesday 25 November 2025 15:45:19 +0000 (0:00:00.285) 0:00:07.414 ****** 2025-11-25 15:45:19.751130 | controller | Tuesday 25 November 2025 15:45:19 +0000 (0:00:00.285) 0:00:07.412 ****** 2025-11-25 15:45:19.751153 | controller | changed: [localhost] 2025-11-25 15:45:25.348896 | controller | 2025-11-25 15:45:25.348936 | controller | TASK [ci_setup : Install openshift client src={{ cifmw_ci_setup_openshift_client_download_uri }}/{{ cifmw_ci_setup_openshift_client_version }}/openshift-client-linux.tar.gz, dest={{ cifmw_ci_setup_oc_install_path }}, remote_src=True, mode=0755, creates={{ cifmw_ci_setup_oc_install_path }}/oc] *** 2025-11-25 15:45:25.348946 | controller | Tuesday 25 November 2025 15:45:19 +0000 (0:00:00.314) 0:00:07.729 ****** 2025-11-25 15:45:25.348965 | controller | Tuesday 25 November 2025 15:45:19 +0000 (0:00:00.314) 0:00:07.727 ****** 2025-11-25 15:45:25.348976 | controller | changed: [localhost] 2025-11-25 15:45:25.383191 | controller | 2025-11-25 15:45:25.383226 | controller | TASK [ci_setup : Add the OC path to cifmw_path if needed cifmw_path={{ cifmw_ci_setup_oc_install_path }}:{{ ansible_env.PATH }}, cacheable=True] *** 2025-11-25 15:45:25.383235 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:05.597) 0:00:13.326 ****** 2025-11-25 15:45:25.383242 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:05.597) 0:00:13.325 ****** 2025-11-25 15:45:25.383253 | controller | skipping: [localhost] 2025-11-25 15:45:25.683926 | controller | 2025-11-25 15:45:25.684016 | controller | TASK [ci_setup : Create completion file] *************************************** 2025-11-25 15:45:25.684028 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:00.034) 0:00:13.361 ****** 2025-11-25 15:45:25.684036 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:00.034) 0:00:13.359 ****** 2025-11-25 15:45:25.684065 | controller | changed: [localhost] 2025-11-25 15:45:25.998469 | controller | 2025-11-25 15:45:25.998579 | controller | TASK [ci_setup : Source completion from within .bashrc create=True, mode=0644, path={{ ansible_user_dir }}/.bashrc, block=if [ -f ~/.oc_completion ]; then 2025-11-25 15:45:25.998594 | controller | source ~/.oc_completion 2025-11-25 15:45:25.998602 | controller | fi] *** 2025-11-25 15:45:25.998626 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:00.300) 0:00:13.662 ****** 2025-11-25 15:45:25.998633 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:00.300) 0:00:13.660 ****** 2025-11-25 15:45:25.998652 | controller | changed: [localhost] 2025-11-25 15:45:26.018438 | controller | 2025-11-25 15:45:26.018483 | controller | TASK [ci_setup : Check rhsm status _raw_params=subscription-manager status] **** 2025-11-25 15:45:26.018493 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:00.314) 0:00:13.977 ****** 2025-11-25 15:45:26.018500 | controller | Tuesday 25 November 2025 15:45:25 +0000 (0:00:00.314) 0:00:13.975 ****** 2025-11-25 15:45:26.018515 | controller | skipping: [localhost] 2025-11-25 15:45:26.066519 | controller | 2025-11-25 15:45:26.066586 | controller | TASK [ci_setup : Gather the repos to be enabled _repos={{ 2025-11-25 15:45:26.066596 | controller | cifmw_ci_setup_rhel_rhsm_default_repos + 2025-11-25 15:45:26.066604 | controller | (cifmw_ci_setup_rhel_rhsm_extra_repos | default([])) 2025-11-25 15:45:26.066612 | controller | }}] *** 2025-11-25 15:45:26.066619 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.020) 0:00:13.997 ****** 2025-11-25 15:45:26.066627 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.020) 0:00:13.995 ****** 2025-11-25 15:45:26.066640 | controller | skipping: [localhost] 2025-11-25 15:45:26.086859 | controller | 2025-11-25 15:45:26.086939 | controller | TASK [ci_setup : Enabling the required repositories. name={{ item }}, state={{ rhsm_repo_state | default('enabled') }}] *** 2025-11-25 15:45:26.086948 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.047) 0:00:14.045 ****** 2025-11-25 15:45:26.086956 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.047) 0:00:14.043 ****** 2025-11-25 15:45:26.086978 | controller | skipping: [localhost] 2025-11-25 15:45:26.111372 | controller | 2025-11-25 15:45:26.111457 | controller | TASK [ci_setup : Get current /etc/redhat-release _raw_params=cat /etc/redhat-release] *** 2025-11-25 15:45:26.111466 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.020) 0:00:14.065 ****** 2025-11-25 15:45:26.111474 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.020) 0:00:14.063 ****** 2025-11-25 15:45:26.111495 | controller | skipping: [localhost] 2025-11-25 15:45:26.130415 | controller | 2025-11-25 15:45:26.130495 | controller | TASK [ci_setup : Print current /etc/redhat-release msg={{ _current_rh_release.stdout }}] *** 2025-11-25 15:45:26.130505 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.024) 0:00:14.090 ****** 2025-11-25 15:45:26.130513 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.024) 0:00:14.088 ****** 2025-11-25 15:45:26.130533 | controller | skipping: [localhost] 2025-11-25 15:45:26.154997 | controller | 2025-11-25 15:45:26.155079 | controller | TASK [ci_setup : Ensure the repos are enabled in the system using yum name={{ item.name }}, baseurl={{ item.baseurl }}, description={{ item.description | default(item.name) }}, gpgcheck={{ item.gpgcheck | default(false) }}, enabled=True, state={{ yum_repo_state | default('present') }}] *** 2025-11-25 15:45:26.155111 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.018) 0:00:14.109 ****** 2025-11-25 15:45:26.155122 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.019) 0:00:14.107 ****** 2025-11-25 15:45:26.155141 | controller | skipping: [localhost] 2025-11-25 15:45:27.274465 | controller | 2025-11-25 15:45:27.274513 | controller | TASK [ci_setup : Manage directories path={{ item }}, state={{ directory_state }}, mode=0755, owner={{ ansible_user_id }}, group={{ ansible_user_id }}] *** 2025-11-25 15:45:27.274522 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.024) 0:00:14.134 ****** 2025-11-25 15:45:27.274529 | controller | Tuesday 25 November 2025 15:45:26 +0000 (0:00:00.024) 0:00:14.131 ****** 2025-11-25 15:45:27.274562 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr) 2025-11-25 15:45:27.687229 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/logs) 2025-11-25 15:45:27.687323 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/tmp) 2025-11-25 15:45:27.687331 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/volumes) 2025-11-25 15:45:27.687341 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/parameters) 2025-11-25 15:45:27.687348 | controller | 2025-11-25 15:45:27.687354 | controller | TASK [Create needed directories path={{ item }}, state=directory, mode=0755] *** 2025-11-25 15:45:27.687360 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:01.119) 0:00:15.253 ****** 2025-11-25 15:45:27.687366 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:01.119) 0:00:15.251 ****** 2025-11-25 15:45:27.687386 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/logs) 2025-11-25 15:45:27.897023 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts) 2025-11-25 15:45:27.897074 | controller | 2025-11-25 15:45:27.897081 | controller | TASK [Check if we have a mock file path={{ _mock_file }}] ********************** 2025-11-25 15:45:27.897088 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.412) 0:00:15.665 ****** 2025-11-25 15:45:27.897094 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.412) 0:00:15.663 ****** 2025-11-25 15:45:27.897106 | controller | ok: [localhost] 2025-11-25 15:45:27.924055 | controller | 2025-11-25 15:45:27.924114 | controller | TASK [Slurp file from remote src={{ _mock_file }}] ***************************** 2025-11-25 15:45:27.924122 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.209) 0:00:15.875 ****** 2025-11-25 15:45:27.924127 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.209) 0:00:15.873 ****** 2025-11-25 15:45:27.924142 | controller | skipping: [localhost] 2025-11-25 15:45:27.946741 | controller | 2025-11-25 15:45:27.946808 | controller | TASK [Copy file on localhost dest={{ lookup('env', 'HOME') ~ '/' ~ cifmw_architecture_scenario ~ '.yml' }}, mode=0644, content={{ _mock_content.content | b64decode }}] *** 2025-11-25 15:45:27.946826 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.027) 0:00:15.902 ****** 2025-11-25 15:45:27.946837 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.027) 0:00:15.900 ****** 2025-11-25 15:45:27.946856 | controller | skipping: [localhost] 2025-11-25 15:45:27.967428 | controller | 2025-11-25 15:45:27.967496 | controller | TASK [Include var file file={{ lookup('env', 'HOME') ~ '/' ~ cifmw_architecture_scenario ~ '.yml' }}] *** 2025-11-25 15:45:27.967507 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.022) 0:00:15.925 ****** 2025-11-25 15:45:27.967515 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.022) 0:00:15.923 ****** 2025-11-25 15:45:27.967533 | controller | skipping: [localhost] 2025-11-25 15:45:28.341730 | controller | 2025-11-25 15:45:28.341781 | controller | TASK [kustomize_deploy : Ensure that architecture repo exists repo={{ cifmw_kustomize_deploy_architecture_repo_url }}, dest={{ cifmw_kustomize_deploy_architecture_repo_dest_dir }}, update=False, version={{ cifmw_kustomize_deploy_architecture_repo_version }}] *** 2025-11-25 15:45:28.341789 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.020) 0:00:15.946 ****** 2025-11-25 15:45:28.341807 | controller | Tuesday 25 November 2025 15:45:27 +0000 (0:00:00.020) 0:00:15.944 ****** 2025-11-25 15:45:28.341819 | controller | ok: [localhost] 2025-11-25 15:45:28.727866 | controller | 2025-11-25 15:45:28.727911 | controller | TASK [kustomize_deploy : Gather the list of scenario folders paths={{ _va_scenario_dir }}, patterns=kustomization.y*ml, recurse=True] *** 2025-11-25 15:45:28.727921 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.374) 0:00:16.320 ****** 2025-11-25 15:45:28.727929 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.374) 0:00:16.318 ****** 2025-11-25 15:45:28.727944 | controller | ok: [localhost] 2025-11-25 15:45:28.751726 | controller | 2025-11-25 15:45:28.751790 | controller | TASK [kustomize_deploy : Check if scenario is in the list msg=You need to properly set the `cifmw_architecture_scenario` variable in order to select the architecture-based scenario to deploy. You can take a list of scenario in the `examples/va` folder in the architecture repo. 2025-11-25 15:45:28.751803 | controller | ] *** 2025-11-25 15:45:28.751811 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.385) 0:00:16.706 ****** 2025-11-25 15:45:28.751818 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.385) 0:00:16.704 ****** 2025-11-25 15:45:28.751829 | controller | skipping: [localhost] 2025-11-25 15:45:28.990668 | controller | 2025-11-25 15:45:28.990714 | controller | TASK [kustomize_deploy : Ensure that destination directory exists path={{ cifmw_kustomize_deploy_kustomizations_dest_dir }}, mode=0755, state=directory] *** 2025-11-25 15:45:28.990724 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.024) 0:00:16.730 ****** 2025-11-25 15:45:28.990732 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.024) 0:00:16.728 ****** 2025-11-25 15:45:28.990745 | controller | changed: [localhost] 2025-11-25 15:45:29.055596 | controller | 2025-11-25 15:45:29.055670 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize based on its patches _cifmw_kustomize_deploy_user_kustomize={{ 2025-11-25 15:45:29.055681 | controller | _cifmw_kustomize_deploy_user_kustomize | 2025-11-25 15:45:29.055695 | controller | default({}) | 2025-11-25 15:45:29.055709 | controller | combine(item.value, recursive=True) 2025-11-25 15:45:29.055796 | controller | }}] *** 2025-11-25 15:45:29.055806 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.238) 0:00:16.969 ****** 2025-11-25 15:45:29.055814 | controller | Tuesday 25 November 2025 15:45:28 +0000 (0:00:00.238) 0:00:16.967 ****** 2025-11-25 15:45:29.055836 | controller | ok: [localhost] => (item=cifmw_architecture_user_kustomize) 2025-11-25 15:45:29.129598 | controller | 2025-11-25 15:45:29.129664 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize_base64 based on its patches _cifmw_kustomize_deploy_user_base64_kustomize={{ 2025-11-25 15:45:29.129673 | controller | _b64_kustomize_user_patches | 2025-11-25 15:45:29.129680 | controller | ci_kustomize_deploy_combine_base64_patch_dict 2025-11-25 15:45:29.129686 | controller | }}] *** 2025-11-25 15:45:29.129693 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.064) 0:00:17.034 ****** 2025-11-25 15:45:29.129699 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.064) 0:00:17.032 ****** 2025-11-25 15:45:29.129717 | controller | ok: [localhost] 2025-11-25 15:45:29.426253 | controller | 2025-11-25 15:45:29.426333 | controller | TASK [networking_mapper : Check for Networking Environment Definition file existence path={{ cifmw_networking_mapper_networking_env_def_path }}] *** 2025-11-25 15:45:29.426345 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.074) 0:00:17.108 ****** 2025-11-25 15:45:29.426354 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.074) 0:00:17.106 ****** 2025-11-25 15:45:29.426377 | controller | ok: [localhost] 2025-11-25 15:45:29.466805 | controller | 2025-11-25 15:45:29.466891 | controller | TASK [networking_mapper : Check for Networking Definition file existance that=['_net_env_def_stat.stat.exists'], msg=Ensure that the Networking Environment Definition file exists in {{ cifmw_networking_mapper_networking_env_def_path }}, quiet=True] *** 2025-11-25 15:45:29.466900 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.296) 0:00:17.405 ****** 2025-11-25 15:45:29.466907 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.296) 0:00:17.402 ****** 2025-11-25 15:45:29.466938 | controller | ok: [localhost] 2025-11-25 15:45:29.817475 | controller | 2025-11-25 15:45:29.817579 | controller | TASK [networking_mapper : Load the Networking Definition from file path={{ cifmw_networking_mapper_networking_env_def_path }}] *** 2025-11-25 15:45:29.817608 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.040) 0:00:17.445 ****** 2025-11-25 15:45:29.817626 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.040) 0:00:17.443 ****** 2025-11-25 15:45:29.817656 | controller | ok: [localhost] 2025-11-25 15:45:29.894141 | controller | 2025-11-25 15:45:29.894214 | controller | TASK [networking_mapper : Set cifmw_networking_env_definition is present cifmw_networking_env_definition={{ 2025-11-25 15:45:29.894222 | controller | _net_env_def_slurp['content'] | 2025-11-25 15:45:29.894230 | controller | b64decode | 2025-11-25 15:45:29.894236 | controller | from_yaml 2025-11-25 15:45:29.894242 | controller | }}, cacheable=True] *** 2025-11-25 15:45:29.894249 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.350) 0:00:17.796 ****** 2025-11-25 15:45:29.894255 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.350) 0:00:17.794 ****** 2025-11-25 15:45:29.894272 | controller | ok: [localhost] 2025-11-25 15:45:30.298668 | controller | 2025-11-25 15:45:30.298713 | controller | TASK [Discover automation files paths={{ 2025-11-25 15:45:30.298723 | controller | [cifmw_architecture_repo, _automation_relative] | 2025-11-25 15:45:30.298732 | controller | path_join 2025-11-25 15:45:30.298740 | controller | }}, patterns=*.yaml] *** 2025-11-25 15:45:30.298748 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.076) 0:00:17.873 ****** 2025-11-25 15:45:30.298756 | controller | Tuesday 25 November 2025 15:45:29 +0000 (0:00:00.076) 0:00:17.871 ****** 2025-11-25 15:45:30.298769 | controller | ok: [localhost] 2025-11-25 15:45:38.904993 | controller | 2025-11-25 15:45:38.905076 | controller | TASK [Get automation contents path={{ item.path }}] **************************** 2025-11-25 15:45:38.905089 | controller | Tuesday 25 November 2025 15:45:30 +0000 (0:00:00.404) 0:00:18.277 ****** 2025-11-25 15:45:38.905097 | controller | Tuesday 25 November 2025 15:45:30 +0000 (0:00:00.404) 0:00:18.275 ****** 2025-11-25 15:45:38.905118 | controller | ok: [localhost] => (item=bgp-l3-xl.yaml) 2025-11-25 15:45:40.380398 | controller | ok: [localhost] => (item=bgp_dt01.yaml) 2025-11-25 15:45:40.380467 | controller | ok: [localhost] => (item=bgp_dt04_ipv6.yaml) 2025-11-25 15:45:40.380474 | controller | ok: [localhost] => (item=bmo01.yaml) 2025-11-25 15:45:40.380480 | controller | ok: [localhost] => (item=dcn.yaml) 2025-11-25 15:45:40.380486 | controller | ok: [localhost] => (item=dz-storage.yaml) 2025-11-25 15:45:40.380492 | controller | ok: [localhost] => (item=hci-adoption.yaml) 2025-11-25 15:45:40.380498 | controller | ok: [localhost] => (item=hci.yaml) 2025-11-25 15:45:40.380504 | controller | ok: [localhost] => (item=multi-namespace.yaml) 2025-11-25 15:45:40.380511 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-adoption.yaml) 2025-11-25 15:45:40.380526 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-hci.yaml) 2025-11-25 15:45:40.380604 | controller | ok: [localhost] => (item=nova-three-cells.yaml) 2025-11-25 15:45:40.380622 | controller | ok: [localhost] => (item=nova01alpha.yaml) 2025-11-25 15:45:40.380630 | controller | ok: [localhost] => (item=nova02beta.yaml) 2025-11-25 15:45:40.380636 | controller | ok: [localhost] => (item=nova04delta-adoption.yaml) 2025-11-25 15:45:40.380643 | controller | ok: [localhost] => (item=nova04delta.yaml) 2025-11-25 15:45:40.380650 | controller | ok: [localhost] => (item=nvidia-mdev.yaml) 2025-11-25 15:45:40.380656 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough-adoption.yaml) 2025-11-25 15:45:40.380663 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough.yaml) 2025-11-25 15:45:40.380668 | controller | ok: [localhost] => (item=osasinfra-ipv6.yaml) 2025-11-25 15:45:40.380674 | controller | ok: [localhost] => (item=osasinfra.yaml) 2025-11-25 15:45:40.380680 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-2nodesets.yaml) 2025-11-25 15:45:40.380686 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-networker.yaml) 2025-11-25 15:45:40.380693 | controller | ok: [localhost] => (item=ovs-dpdk-sriov.yaml) 2025-11-25 15:45:40.380700 | controller | ok: [localhost] => (item=ovs-dpdk.yaml) 2025-11-25 15:45:40.380706 | controller | ok: [localhost] => (item=pidone.yaml) 2025-11-25 15:45:40.380712 | controller | ok: [localhost] => (item=sriov.yaml) 2025-11-25 15:45:40.380734 | controller | ok: [localhost] => (item=uni01alpha-adoption.yaml) 2025-11-25 15:45:40.380740 | controller | ok: [localhost] => (item=uni01alpha.yaml) 2025-11-25 15:45:40.380746 | controller | ok: [localhost] => (item=uni02beta-adoption.yaml) 2025-11-25 15:45:40.380752 | controller | ok: [localhost] => (item=uni02beta.yaml) 2025-11-25 15:45:40.380758 | controller | ok: [localhost] => (item=uni04delta-adoption.yaml) 2025-11-25 15:45:40.380764 | controller | ok: [localhost] => (item=uni04delta-ipv6-adoption.yaml) 2025-11-25 15:45:40.380769 | controller | ok: [localhost] => (item=uni04delta-ipv6.yaml) 2025-11-25 15:45:40.380775 | controller | ok: [localhost] => (item=uni04delta.yaml) 2025-11-25 15:45:40.380781 | controller | ok: [localhost] => (item=uni05epsilon-adoption.yaml) 2025-11-25 15:45:40.380787 | controller | ok: [localhost] => (item=uni05epsilon.yaml) 2025-11-25 15:45:40.380793 | controller | ok: [localhost] => (item=uni06zeta-adoption.yaml) 2025-11-25 15:45:40.380798 | controller | ok: [localhost] => (item=uni06zeta.yaml) 2025-11-25 15:45:40.380804 | controller | ok: [localhost] => (item=uni07eta-adoption.yaml) 2025-11-25 15:45:40.380810 | controller | ok: [localhost] => (item=uni07eta.yaml) 2025-11-25 15:45:40.380816 | controller | ok: [localhost] => (item=uni09iota-adoption.yaml) 2025-11-25 15:45:40.380821 | controller | ok: [localhost] => (item=uni09iota.yaml) 2025-11-25 15:45:40.380827 | controller | 2025-11-25 15:45:40.380834 | controller | TASK [Load automation files as fact vas={{ 2025-11-25 15:45:40.380839 | controller | vas | default({}) | 2025-11-25 15:45:40.380846 | controller | combine(item.content | b64decode | from_yaml, recursive=true) 2025-11-25 15:45:40.380851 | controller | }}] *** 2025-11-25 15:45:40.380857 | controller | Tuesday 25 November 2025 15:45:38 +0000 (0:00:08.606) 0:00:26.883 ****** 2025-11-25 15:45:40.380864 | controller | Tuesday 25 November 2025 15:45:38 +0000 (0:00:08.606) 0:00:26.881 ****** 2025-11-25 15:45:40.380881 | controller | ok: [localhost] => (item=bgp-l3-xl.yaml) 2025-11-25 15:45:40.414647 | controller | ok: [localhost] => (item=bgp_dt01.yaml) 2025-11-25 15:45:40.414704 | controller | ok: [localhost] => (item=bgp_dt04_ipv6.yaml) 2025-11-25 15:45:40.414713 | controller | ok: [localhost] => (item=bmo01.yaml) 2025-11-25 15:45:40.414721 | controller | ok: [localhost] => (item=dcn.yaml) 2025-11-25 15:45:40.414728 | controller | ok: [localhost] => (item=dz-storage.yaml) 2025-11-25 15:45:40.414736 | controller | ok: [localhost] => (item=hci-adoption.yaml) 2025-11-25 15:45:40.414743 | controller | ok: [localhost] => (item=hci.yaml) 2025-11-25 15:45:40.414751 | controller | ok: [localhost] => (item=multi-namespace.yaml) 2025-11-25 15:45:40.414759 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-adoption.yaml) 2025-11-25 15:45:40.414767 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-hci.yaml) 2025-11-25 15:45:40.414775 | controller | ok: [localhost] => (item=nova-three-cells.yaml) 2025-11-25 15:45:40.414782 | controller | ok: [localhost] => (item=nova01alpha.yaml) 2025-11-25 15:45:40.414789 | controller | ok: [localhost] => (item=nova02beta.yaml) 2025-11-25 15:45:40.414796 | controller | ok: [localhost] => (item=nova04delta-adoption.yaml) 2025-11-25 15:45:40.414802 | controller | ok: [localhost] => (item=nova04delta.yaml) 2025-11-25 15:45:40.414808 | controller | ok: [localhost] => (item=nvidia-mdev.yaml) 2025-11-25 15:45:40.414814 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough-adoption.yaml) 2025-11-25 15:45:40.414820 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough.yaml) 2025-11-25 15:45:40.414826 | controller | ok: [localhost] => (item=osasinfra-ipv6.yaml) 2025-11-25 15:45:40.414831 | controller | ok: [localhost] => (item=osasinfra.yaml) 2025-11-25 15:45:40.414838 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-2nodesets.yaml) 2025-11-25 15:45:40.414849 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-networker.yaml) 2025-11-25 15:45:40.414857 | controller | ok: [localhost] => (item=ovs-dpdk-sriov.yaml) 2025-11-25 15:45:40.414865 | controller | ok: [localhost] => (item=ovs-dpdk.yaml) 2025-11-25 15:45:40.414872 | controller | ok: [localhost] => (item=pidone.yaml) 2025-11-25 15:45:40.414886 | controller | ok: [localhost] => (item=sriov.yaml) 2025-11-25 15:45:40.414893 | controller | ok: [localhost] => (item=uni01alpha-adoption.yaml) 2025-11-25 15:45:40.414901 | controller | ok: [localhost] => (item=uni01alpha.yaml) 2025-11-25 15:45:40.414909 | controller | ok: [localhost] => (item=uni02beta-adoption.yaml) 2025-11-25 15:45:40.414916 | controller | ok: [localhost] => (item=uni02beta.yaml) 2025-11-25 15:45:40.414924 | controller | ok: [localhost] => (item=uni04delta-adoption.yaml) 2025-11-25 15:45:40.414940 | controller | ok: [localhost] => (item=uni04delta-ipv6-adoption.yaml) 2025-11-25 15:45:40.414947 | controller | ok: [localhost] => (item=uni04delta-ipv6.yaml) 2025-11-25 15:45:40.414954 | controller | ok: [localhost] => (item=uni04delta.yaml) 2025-11-25 15:45:40.414961 | controller | ok: [localhost] => (item=uni05epsilon-adoption.yaml) 2025-11-25 15:45:40.414969 | controller | ok: [localhost] => (item=uni05epsilon.yaml) 2025-11-25 15:45:40.414975 | controller | ok: [localhost] => (item=uni06zeta-adoption.yaml) 2025-11-25 15:45:40.414981 | controller | ok: [localhost] => (item=uni06zeta.yaml) 2025-11-25 15:45:40.414987 | controller | ok: [localhost] => (item=uni07eta-adoption.yaml) 2025-11-25 15:45:40.414995 | controller | ok: [localhost] => (item=uni07eta.yaml) 2025-11-25 15:45:40.415002 | controller | ok: [localhost] => (item=uni09iota-adoption.yaml) 2025-11-25 15:45:40.415010 | controller | ok: [localhost] => (item=uni09iota.yaml) 2025-11-25 15:45:40.415017 | controller | 2025-11-25 15:45:40.415025 | controller | TASK [Prepare automation data cifmw_deploy_architecture_steps={{ vas['vas'][cifmw_architecture_scenario] }}] *** 2025-11-25 15:45:40.415033 | controller | Tuesday 25 November 2025 15:45:40 +0000 (0:00:01.475) 0:00:28.359 ****** 2025-11-25 15:45:40.415041 | controller | Tuesday 25 November 2025 15:45:40 +0000 (0:00:01.475) 0:00:28.357 ****** 2025-11-25 15:45:40.415055 | controller | ok: [localhost] 2025-11-25 15:45:41.130392 | controller | 2025-11-25 15:45:41.130432 | controller | TASK [Create needed SSH keypairs comment={{ item.comment }}, path={{ item.path }}, type=ecdsa, size=521] *** 2025-11-25 15:45:41.130439 | controller | Tuesday 25 November 2025 15:45:40 +0000 (0:00:00.034) 0:00:28.393 ****** 2025-11-25 15:45:41.130445 | controller | Tuesday 25 November 2025 15:45:40 +0000 (0:00:00.034) 0:00:28.391 ****** 2025-11-25 15:45:41.130457 | controller | changed: [localhost] => (item={'comment': 'Nova migration', 'path': '/home/zuul/ci-framework-data/artifacts/ecdsa_nova_migration'}) 2025-11-25 15:45:41.538287 | controller | changed: [localhost] => (item={'comment': 'EDPM deploy key', 'path': '/home/zuul/ci-framework-data/artifacts/ecdsa_deploy'}) 2025-11-25 15:45:41.538364 | controller | 2025-11-25 15:45:41.538374 | controller | TASK [Load public SSH keys path={{ item }}] ************************************ 2025-11-25 15:45:41.538383 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.715) 0:00:29.109 ****** 2025-11-25 15:45:41.538391 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.715) 0:00:29.107 ****** 2025-11-25 15:45:41.538412 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_nova_migration.pub) 2025-11-25 15:45:41.951138 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_deploy.pub) 2025-11-25 15:45:41.951185 | controller | 2025-11-25 15:45:41.951195 | controller | TASK [Load private SSH keys path={{ item }}] *********************************** 2025-11-25 15:45:41.951204 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.408) 0:00:29.517 ****** 2025-11-25 15:45:41.951213 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.408) 0:00:29.515 ****** 2025-11-25 15:45:41.951228 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_nova_migration) 2025-11-25 15:45:41.987692 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_deploy) 2025-11-25 15:45:41.987736 | controller | 2025-11-25 15:45:41.987745 | controller | TASK [Generate needed facts out of local files cifmw_ci_gen_kustomize_values_ssh_authorizedkeys={{ 2025-11-25 15:45:41.987754 | controller | _pub_keys.results[1].content | b64decode 2025-11-25 15:45:41.987762 | controller | }}, cifmw_ci_gen_kustomize_values_ssh_private_key={{ 2025-11-25 15:45:41.987770 | controller | _priv_keys.results[1].content | b64decode 2025-11-25 15:45:41.987778 | controller | }}, cifmw_ci_gen_kustomize_values_ssh_public_key={{ 2025-11-25 15:45:41.987785 | controller | _pub_keys.results[1].content | b64decode 2025-11-25 15:45:41.987793 | controller | }}, cifmw_ci_gen_kustomize_values_migration_pub_key={{ 2025-11-25 15:45:41.987800 | controller | _pub_keys.results[0].content | b64decode 2025-11-25 15:45:41.987808 | controller | }}, cifmw_ci_gen_kustomize_values_migration_priv_key={{ 2025-11-25 15:45:41.987816 | controller | _priv_keys.results[0].content | b64decode 2025-11-25 15:45:41.987823 | controller | }}, cifmw_ci_gen_kustomize_values_sshd_ranges={{ 2025-11-25 15:45:41.987842 | controller | [ 2025-11-25 15:45:41.987850 | controller | cifmw_networking_env_definition.networks.ctlplane.network_v4 | default (none), 2025-11-25 15:45:41.987858 | controller | cifmw_networking_env_definition.networks.ctlplane.network_v6 | default (none) 2025-11-25 15:45:41.987865 | controller | ] | select() 2025-11-25 15:45:41.987873 | controller | }}] *** 2025-11-25 15:45:41.987881 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.412) 0:00:29.929 ****** 2025-11-25 15:45:41.987894 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.412) 0:00:29.927 ****** 2025-11-25 15:45:41.987909 | controller | ok: [localhost] 2025-11-25 15:45:42.063885 | controller | 2025-11-25 15:45:42.063924 | controller | TASK [Execute deployment steps name=kustomize_deploy, tasks_from=execute_step.yml, apply={'tags': ['edpm_deploy']}] *** 2025-11-25 15:45:42.063935 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.037) 0:00:29.966 ****** 2025-11-25 15:45:42.063943 | controller | Tuesday 25 November 2025 15:45:41 +0000 (0:00:00.036) 0:00:29.964 ****** 2025-11-25 15:45:42.063956 | controller | 2025-11-25 15:45:42.110613 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined that=['stage is defined', 'stage_id is defined', "stage['path'] is defined", "stage['wait_conditions'] is defined", "stage['wait_conditions'] | length > 0", "stage['values'] is defined", "stage['values'] | length > 0", "stage['build_output'] is defined", "stage['build_output'] | length > 0"]] *** 2025-11-25 15:45:42.110661 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.076) 0:00:30.042 ****** 2025-11-25 15:45:42.110673 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.076) 0:00:30.040 ****** 2025-11-25 15:45:42.110689 | controller | ok: [localhost] => 2025-11-25 15:45:42.138025 | controller | changed: false 2025-11-25 15:45:42.138067 | controller | msg: All assertions passed 2025-11-25 15:45:42.138077 | controller | 2025-11-25 15:45:42.138084 | controller | TASK [kustomize_deploy : Check custom wait conditions that=item is match(_pattern), msg=The following custom condition is invalid: {{ item }}, quiet=True] *** 2025-11-25 15:45:42.138092 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.046) 0:00:30.089 ****** 2025-11-25 15:45:42.138100 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.046) 0:00:30.087 ****** 2025-11-25 15:45:42.138113 | controller | skipping: [localhost] 2025-11-25 15:45:42.173187 | controller | 2025-11-25 15:45:42.173265 | controller | TASK [kustomize_deploy : Check builtin wait conditions that=item is match(_pattern), msg=The following builtin condition is invalid: {{ item }}, quiet=True] *** 2025-11-25 15:45:42.173286 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.027) 0:00:30.117 ****** 2025-11-25 15:45:42.173303 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.027) 0:00:30.114 ****** 2025-11-25 15:45:42.173332 | controller | ok: [localhost] => (item=oc -n openstack wait nncp -l osp/nncm-config-type=standard --for jsonpath='{.status.conditions[0].reason}'=SuccessfullyConfigured --timeout=5m) 2025-11-25 15:45:42.205157 | controller | 2025-11-25 15:45:42.205218 | controller | TASK [kustomize_deploy : Check wait_conditions validation result msg=Review and correct the faulty wait_conditions listed above.] *** 2025-11-25 15:45:42.205235 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.035) 0:00:30.152 ****** 2025-11-25 15:45:42.205249 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.035) 0:00:30.150 ****** 2025-11-25 15:45:42.205271 | controller | skipping: [localhost] 2025-11-25 15:45:42.253245 | controller | 2025-11-25 15:45:42.253304 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact _wait_conditions={{ stage.wait_conditions + _custom_conditions }}] *** 2025-11-25 15:45:42.253315 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.031) 0:00:30.184 ****** 2025-11-25 15:45:42.253324 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.031) 0:00:30.182 ****** 2025-11-25 15:45:42.253341 | controller | ok: [localhost] 2025-11-25 15:45:42.521807 | controller | 2025-11-25 15:45:42.521868 | controller | TASK [kustomize_deploy : Ensure source files exists path={{ 2025-11-25 15:45:42.521876 | controller | (cifmw_kustomize_deploy_architecture_repo_dest_dir, 2025-11-25 15:45:42.521882 | controller | stage['path'], item.src_file) | path_join 2025-11-25 15:45:42.521902 | controller | }}, get_attributes=False, get_checksum=False, get_mime=False] *** 2025-11-25 15:45:42.521909 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.048) 0:00:30.232 ****** 2025-11-25 15:45:42.521915 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.048) 0:00:30.230 ****** 2025-11-25 15:45:42.521931 | controller | ok: [localhost] => (item={'name': 'network-values', 'src_file': 'values.yaml'}) 2025-11-25 15:45:42.588412 | controller | 2025-11-25 15:45:42.588480 | controller | TASK [kustomize_deploy : Assert source files exist that=['(item.stat is defined and item.stat.exists) or item.skipped'], quiet=True] *** 2025-11-25 15:45:42.588489 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.268) 0:00:30.500 ****** 2025-11-25 15:45:42.588496 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.268) 0:00:30.498 ****** 2025-11-25 15:45:42.588513 | controller | ok: [localhost] => (item=values.yaml) 2025-11-25 15:45:42.641107 | controller | 2025-11-25 15:45:42.641188 | controller | TASK [Executing pre_stage hooks for examples/dt/nova/nova04delta/control-plane/networking/nncp name=run_hook] *** 2025-11-25 15:45:42.641198 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.066) 0:00:30.567 ****** 2025-11-25 15:45:42.641206 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.066) 0:00:30.565 ****** 2025-11-25 15:45:42.641227 | controller | skipping: [localhost] 2025-11-25 15:45:42.730350 | controller | 2025-11-25 15:45:42.730426 | controller | TASK [Generate values.yaml for examples/dt/nova/nova04delta/control-plane/networking/nncp name=ci_gen_kustomize_values] *** 2025-11-25 15:45:42.730435 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.052) 0:00:30.619 ****** 2025-11-25 15:45:42.730444 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.052) 0:00:30.617 ****** 2025-11-25 15:45:42.730464 | controller | 2025-11-25 15:45:42.799385 | controller | TASK [ci_gen_kustomize_values : Generate snippets files _raw_params=generate_snippets.yml] *** 2025-11-25 15:45:42.799430 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.089) 0:00:30.709 ****** 2025-11-25 15:45:42.799439 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.089) 0:00:30.707 ****** 2025-11-25 15:45:42.799452 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for localhost 2025-11-25 15:45:42.869662 | controller | 2025-11-25 15:45:42.869726 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set that=['cifmw_architecture_scenario is defined', 'cifmw_architecture_scenario is not none'], msg=cifmw_architecture_scenario must be provided.] *** 2025-11-25 15:45:42.869743 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.069) 0:00:30.778 ****** 2025-11-25 15:45:42.869757 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.069) 0:00:30.776 ****** 2025-11-25 15:45:42.869779 | controller | ok: [localhost] => 2025-11-25 15:45:43.153610 | controller | changed: false 2025-11-25 15:45:43.153683 | controller | msg: All assertions passed 2025-11-25 15:45:43.153697 | controller | 2025-11-25 15:45:43.153708 | controller | TASK [ci_gen_kustomize_values : Stat original source file path={{ cifmw_ci_gen_kustomize_values_src_file }}, get_attributes=False, get_checksum=False, get_mime=False] *** 2025-11-25 15:45:43.153720 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.069) 0:00:30.848 ****** 2025-11-25 15:45:43.153728 | controller | Tuesday 25 November 2025 15:45:42 +0000 (0:00:00.069) 0:00:30.846 ****** 2025-11-25 15:45:43.153752 | controller | ok: [localhost] 2025-11-25 15:45:43.215405 | controller | 2025-11-25 15:45:43.215480 | controller | TASK [ci_gen_kustomize_values : Assert source file exists that=['_src_stat.stat.exists'], msg={{ cifmw_ci_gen_kustomize_values_src_file }} doesn't exist.] *** 2025-11-25 15:45:43.215489 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.284) 0:00:31.132 ****** 2025-11-25 15:45:43.215496 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.284) 0:00:31.130 ****** 2025-11-25 15:45:43.215529 | controller | ok: [localhost] => 2025-11-25 15:45:43.443908 | controller | changed: false 2025-11-25 15:45:43.443971 | controller | msg: All assertions passed 2025-11-25 15:45:43.443993 | controller | 2025-11-25 15:45:43.444000 | controller | TASK [ci_gen_kustomize_values : Load original values file src={{ cifmw_ci_gen_kustomize_values_src_file }}] *** 2025-11-25 15:45:43.444007 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.061) 0:00:31.194 ****** 2025-11-25 15:45:43.444013 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.061) 0:00:31.192 ****** 2025-11-25 15:45:43.444028 | controller | ok: [localhost] 2025-11-25 15:45:43.692732 | controller | 2025-11-25 15:45:43.692803 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage values_datatype={{ _datatype }}, snippet_datadir={{ _dest_dir }}, original_content={{ _config_map_content }}, _cifmw_gen_kustomize_values_extra_manifests={{ 2025-11-25 15:45:43.692812 | controller | _raw_manifests | reject('equalto', _config_map_content) 2025-11-25 15:45:43.692818 | controller | }}, _cifmw_gen_kustomize_values_base_cm_content={{ 2025-11-25 15:45:43.692824 | controller | _config_map_content | 2025-11-25 15:45:43.692831 | controller | ansible.utils.remove_keys( 2025-11-25 15:45:43.692837 | controller | target=_cifmw_gen_kustomize_values_reject_expressions, 2025-11-25 15:45:43.692844 | controller | matching_parameter='regex') 2025-11-25 15:45:43.692856 | controller | }}, cacheable=False] *** 2025-11-25 15:45:43.692869 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.228) 0:00:31.422 ****** 2025-11-25 15:45:43.692877 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.228) 0:00:31.420 ****** 2025-11-25 15:45:43.692897 | controller | ok: [localhost] 2025-11-25 15:45:43.753607 | controller | 2025-11-25 15:45:43.753650 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type _raw_params={{ _tasks }}] *** 2025-11-25 15:45:43.753659 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.248) 0:00:31.671 ****** 2025-11-25 15:45:43.753667 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.248) 0:00:31.669 ****** 2025-11-25 15:45:43.753681 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for localhost 2025-11-25 15:45:43.804575 | controller | 2025-11-25 15:45:43.804648 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters that=['cifmw_networking_env_definition is defined']] *** 2025-11-25 15:45:43.804657 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.060) 0:00:31.732 ****** 2025-11-25 15:45:43.804665 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.060) 0:00:31.730 ****** 2025-11-25 15:45:43.804684 | controller | ok: [localhost] => 2025-11-25 15:45:44.056263 | controller | changed: false 2025-11-25 15:45:44.056332 | controller | msg: All assertions passed 2025-11-25 15:45:44.056340 | controller | 2025-11-25 15:45:44.056348 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists path={{ snippet_datadir }}, state=directory, mode=0755] *** 2025-11-25 15:45:44.056354 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.050) 0:00:31.783 ****** 2025-11-25 15:45:44.056361 | controller | Tuesday 25 November 2025 15:45:43 +0000 (0:00:00.050) 0:00:31.781 ****** 2025-11-25 15:45:44.056379 | controller | changed: [localhost] 2025-11-25 15:45:44.830956 | controller | 2025-11-25 15:45:44.831043 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet backup=True, dest={{ 2025-11-25 15:45:44.831061 | controller | (snippet_datadir, 2025-11-25 15:45:44.831077 | controller | '02_ci_data.yaml') | path_join 2025-11-25 15:45:44.831092 | controller | }}, src={{ _tmpl_check_path | first }}, mode=0644] *** 2025-11-25 15:45:44.831106 | controller | Tuesday 25 November 2025 15:45:44 +0000 (0:00:00.251) 0:00:32.035 ****** 2025-11-25 15:45:44.831121 | controller | Tuesday 25 November 2025 15:45:44 +0000 (0:00:00.251) 0:00:32.033 ****** 2025-11-25 15:45:44.831145 | controller | changed: [localhost] 2025-11-25 15:45:44.903513 | controller | 2025-11-25 15:45:44.903568 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches _base64_patch={{ _patches_tuple[0] }}, _cifmw_gen_kustomize_values_extra_manifests={{ _patches_tuple[1] }}] *** 2025-11-25 15:45:44.903580 | controller | Tuesday 25 November 2025 15:45:44 +0000 (0:00:00.773) 0:00:32.809 ****** 2025-11-25 15:45:44.903587 | controller | Tuesday 25 November 2025 15:45:44 +0000 (0:00:00.774) 0:00:32.807 ****** 2025-11-25 15:45:44.903609 | controller | ok: [localhost] 2025-11-25 15:45:45.432143 | controller | 2025-11-25 15:45:45.432271 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches backup=True, dest={{ 2025-11-25 15:45:45.432280 | controller | (snippet_datadir, 2025-11-25 15:45:45.432287 | controller | '03_user_data_b64.yaml') | path_join 2025-11-25 15:45:45.432295 | controller | }}, content={{ 2025-11-25 15:45:45.432302 | controller | _base64_patch | 2025-11-25 15:45:45.432308 | controller | default({}) | 2025-11-25 15:45:45.432314 | controller | to_nice_yaml 2025-11-25 15:45:45.432320 | controller | }}, mode=0644] *** 2025-11-25 15:45:45.432326 | controller | Tuesday 25 November 2025 15:45:44 +0000 (0:00:00.073) 0:00:32.882 ****** 2025-11-25 15:45:45.432333 | controller | Tuesday 25 November 2025 15:45:44 +0000 (0:00:00.073) 0:00:32.880 ****** 2025-11-25 15:45:45.432358 | controller | changed: [localhost] 2025-11-25 15:45:45.916597 | controller | 2025-11-25 15:45:45.916640 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset backup=True, dest={{ 2025-11-25 15:45:45.916649 | controller | (snippet_datadir, 2025-11-25 15:45:45.916657 | controller | '04_user_data.yaml') | path_join 2025-11-25 15:45:45.916665 | controller | }}, content={{ 2025-11-25 15:45:45.916672 | controller | cifmw_ci_gen_kustomize_values_userdata | 2025-11-25 15:45:45.916679 | controller | default({}) | 2025-11-25 15:45:45.916686 | controller | to_nice_yaml 2025-11-25 15:45:45.916693 | controller | }}, mode=0644] *** 2025-11-25 15:45:45.916700 | controller | Tuesday 25 November 2025 15:45:45 +0000 (0:00:00.528) 0:00:33.411 ****** 2025-11-25 15:45:45.916706 | controller | Tuesday 25 November 2025 15:45:45 +0000 (0:00:00.528) 0:00:33.408 ****** 2025-11-25 15:45:45.916720 | controller | changed: [localhost] 2025-11-25 15:45:46.351841 | controller | 2025-11-25 15:45:46.351912 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml backup=True, content={{ _cifmw_gen_kustomize_values_base_cm_content |to_nice_yaml }}, dest={{ 2025-11-25 15:45:46.351922 | controller | ( 2025-11-25 15:45:46.351928 | controller | snippet_datadir, 2025-11-25 15:45:46.351935 | controller | cifmw_ci_gen_kustomize_values_original_cm_content_file_name 2025-11-25 15:45:46.351941 | controller | ) | path_join 2025-11-25 15:45:46.351947 | controller | }}, mode=0644] *** 2025-11-25 15:45:46.351953 | controller | Tuesday 25 November 2025 15:45:45 +0000 (0:00:00.484) 0:00:33.895 ****** 2025-11-25 15:45:46.351959 | controller | Tuesday 25 November 2025 15:45:45 +0000 (0:00:00.484) 0:00:33.893 ****** 2025-11-25 15:45:46.351975 | controller | changed: [localhost] 2025-11-25 15:45:46.428947 | controller | 2025-11-25 15:45:46.429019 | controller | TASK [ci_gen_kustomize_values : Generate values file _raw_params=generate_values.yml] *** 2025-11-25 15:45:46.429029 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.434) 0:00:34.330 ****** 2025-11-25 15:45:46.429035 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.434) 0:00:34.328 ****** 2025-11-25 15:45:46.429052 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for localhost 2025-11-25 15:45:46.488297 | controller | 2025-11-25 15:45:46.488376 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter that=['values_datatype is defined', "values_datatype != ''"], msg=Please do not call this tasks file without calling the generate_snippet.yml first!] *** 2025-11-25 15:45:46.488387 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.077) 0:00:34.407 ****** 2025-11-25 15:45:46.488396 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.077) 0:00:34.405 ****** 2025-11-25 15:45:46.488417 | controller | ok: [localhost] => 2025-11-25 15:45:46.719359 | controller | changed: false 2025-11-25 15:45:46.719399 | controller | msg: All assertions passed 2025-11-25 15:45:46.719407 | controller | 2025-11-25 15:45:46.719421 | controller | TASK [ci_gen_kustomize_values : List snippets paths={{ _dir_path }}, patterns=*.yml,*.yaml, excludes={{ cifmw_ci_gen_kustomize_values_original_cm_content_file_name }}, recurse=False] *** 2025-11-25 15:45:46.719428 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.059) 0:00:34.467 ****** 2025-11-25 15:45:46.719435 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.059) 0:00:34.465 ****** 2025-11-25 15:45:46.719446 | controller | ok: [localhost] 2025-11-25 15:45:46.770409 | controller | 2025-11-25 15:45:46.770451 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty _content={}] ********** 2025-11-25 15:45:46.770469 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.231) 0:00:34.698 ****** 2025-11-25 15:45:46.770476 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.231) 0:00:34.696 ****** 2025-11-25 15:45:46.770494 | controller | ok: [localhost] 2025-11-25 15:45:47.409271 | controller | 2025-11-25 15:45:47.409350 | controller | TASK [ci_gen_kustomize_values : Load various snippet files path={{ file.path }}] *** 2025-11-25 15:45:47.409359 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.050) 0:00:34.749 ****** 2025-11-25 15:45:47.409366 | controller | Tuesday 25 November 2025 15:45:46 +0000 (0:00:00.050) 0:00:34.747 ****** 2025-11-25 15:45:47.409385 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml) 2025-11-25 15:45:47.572240 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml) 2025-11-25 15:45:47.572288 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml) 2025-11-25 15:45:47.572299 | controller | 2025-11-25 15:45:47.572308 | controller | TASK [ci_gen_kustomize_values : Combine snippets _content={{ 2025-11-25 15:45:47.572316 | controller | _content | 2025-11-25 15:45:47.572323 | controller | default(_cifmw_gen_kustomize_values_base_cm_content, true) | 2025-11-25 15:45:47.572330 | controller | combine(_parsed, recursive=true) 2025-11-25 15:45:47.572338 | controller | }} 2025-11-25 15:45:47.572345 | controller | ] *** 2025-11-25 15:45:47.572353 | controller | Tuesday 25 November 2025 15:45:47 +0000 (0:00:00.638) 0:00:35.388 ****** 2025-11-25 15:45:47.572359 | controller | Tuesday 25 November 2025 15:45:47 +0000 (0:00:00.638) 0:00:35.386 ****** 2025-11-25 15:45:47.572372 | controller | ok: [localhost] => (item=02_ci_data.yaml) 2025-11-25 15:45:47.815655 | controller | ok: [localhost] => (item=03_user_data_b64.yaml) 2025-11-25 15:45:47.815734 | controller | ok: [localhost] => (item=04_user_data.yaml) 2025-11-25 15:45:47.815746 | controller | 2025-11-25 15:45:47.815753 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist path={{ _destdir }}, state=directory, mode=0755] *** 2025-11-25 15:45:47.815760 | controller | Tuesday 25 November 2025 15:45:47 +0000 (0:00:00.162) 0:00:35.550 ****** 2025-11-25 15:45:47.815767 | controller | Tuesday 25 November 2025 15:45:47 +0000 (0:00:00.162) 0:00:35.548 ****** 2025-11-25 15:45:47.815785 | controller | changed: [localhost] 2025-11-25 15:45:48.372384 | controller | 2025-11-25 15:45:48.372455 | controller | TASK [ci_gen_kustomize_values : Output values file backup=True, dest={{ 2025-11-25 15:45:48.372463 | controller | (_destdir, 2025-11-25 15:45:48.372470 | controller | cifmw_ci_gen_kustomize_values_dest_filename) | path_join 2025-11-25 15:45:48.372481 | controller | }}, content={{ 2025-11-25 15:45:48.372519 | controller | ( 2025-11-25 15:45:48.372533 | controller | [ _content ] + _cifmw_gen_kustomize_values_extra_manifests 2025-11-25 15:45:48.372539 | controller | ) | cifmw.general.to_nice_yaml_all 2025-11-25 15:45:48.372567 | controller | }}, mode=0644] *** 2025-11-25 15:45:48.372574 | controller | Tuesday 25 November 2025 15:45:47 +0000 (0:00:00.243) 0:00:35.794 ****** 2025-11-25 15:45:48.372580 | controller | Tuesday 25 November 2025 15:45:47 +0000 (0:00:00.243) 0:00:35.792 ****** 2025-11-25 15:45:48.372597 | controller | changed: [localhost] 2025-11-25 15:45:48.710329 | controller | 2025-11-25 15:45:48.710372 | controller | TASK [kustomize_deploy : Copy generated values for examples/dt/nova/nova04delta/control-plane/networking/nncp mode=0644, backup=True, remote_src=True, src={{ 2025-11-25 15:45:48.710381 | controller | (cifmw_kustomize_deploy_basedir, 2025-11-25 15:45:48.710387 | controller | 'artifacts', 'ci_gen_kustomize_values', 2025-11-25 15:45:48.710393 | controller | _val['name'], 'values.yaml') | path_join 2025-11-25 15:45:48.710399 | controller | }}, dest={{ 2025-11-25 15:45:48.710410 | controller | (cifmw_kustomize_deploy_architecture_repo_dest_dir, 2025-11-25 15:45:48.710416 | controller | stage['path'], _val.src_file 2025-11-25 15:45:48.710422 | controller | ) | 2025-11-25 15:45:48.710430 | controller | path_join 2025-11-25 15:45:48.710436 | controller | }}] *** 2025-11-25 15:45:48.710442 | controller | Tuesday 25 November 2025 15:45:48 +0000 (0:00:00.556) 0:00:36.351 ****** 2025-11-25 15:45:48.710448 | controller | Tuesday 25 November 2025 15:45:48 +0000 (0:00:00.556) 0:00:36.349 ****** 2025-11-25 15:45:48.710481 | controller | changed: [localhost] => (item=network-values) 2025-11-25 15:45:48.755720 | controller | 2025-11-25 15:45:48.755757 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-11-25 15:45:48.755766 | controller | Tuesday 25 November 2025 15:45:48 +0000 (0:00:00.337) 0:00:36.689 ****** 2025-11-25 15:45:48.755773 | controller | Tuesday 25 November 2025 15:45:48 +0000 (0:00:00.338) 0:00:36.687 ****** 2025-11-25 15:45:48.755785 | controller | skipping: [localhost] 2025-11-25 15:45:49.210329 | controller | 2025-11-25 15:45:49.210393 | controller | TASK [kustomize_deploy : Build kustomized content for examples/dt/nova/nova04delta/control-plane/networking/nncp chdir={{ _chdir }}, _raw_params=oc kustomize] *** 2025-11-25 15:45:49.210402 | controller | Tuesday 25 November 2025 15:45:48 +0000 (0:00:00.045) 0:00:36.734 ****** 2025-11-25 15:45:49.210409 | controller | Tuesday 25 November 2025 15:45:48 +0000 (0:00:00.045) 0:00:36.732 ****** 2025-11-25 15:45:49.210425 | controller | changed: [localhost] 2025-11-25 15:45:49.844162 | controller | 2025-11-25 15:45:49.844237 | controller | TASK [kustomize_deploy : Output kustomize build in final file backup=True, dest={{ _output }}, content={{ _kustomize_output.stdout }}, mode=0644] *** 2025-11-25 15:45:49.844248 | controller | Tuesday 25 November 2025 15:45:49 +0000 (0:00:00.454) 0:00:37.189 ****** 2025-11-25 15:45:49.844257 | controller | Tuesday 25 November 2025 15:45:49 +0000 (0:00:00.454) 0:00:37.187 ****** 2025-11-25 15:45:49.844278 | controller | changed: [localhost] 2025-11-25 15:45:50.221406 | controller | 2025-11-25 15:45:50.221516 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/dt/nova/nova04delta/control-plane/networking/nncp remote_src=True, src={{ _output }}, dest={{ 2025-11-25 15:45:50.221530 | controller | (cifmw_kustomize_deploy_kustomizations_dest_dir, 2025-11-25 15:45:50.221564 | controller | stage['build_output'] | basename) | path_join 2025-11-25 15:45:50.221578 | controller | }}, mode=0644] *** 2025-11-25 15:45:50.221586 | controller | Tuesday 25 November 2025 15:45:49 +0000 (0:00:00.633) 0:00:37.823 ****** 2025-11-25 15:45:50.221594 | controller | Tuesday 25 November 2025 15:45:49 +0000 (0:00:00.633) 0:00:37.821 ****** 2025-11-25 15:45:50.221614 | controller | changed: [localhost] 2025-11-25 15:45:50.272538 | controller | 2025-11-25 15:45:50.272600 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-11-25 15:45:50.272609 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.377) 0:00:38.200 ****** 2025-11-25 15:45:50.272616 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.377) 0:00:38.198 ****** 2025-11-25 15:45:50.272627 | controller | skipping: [localhost] 2025-11-25 15:45:50.323059 | controller | 2025-11-25 15:45:50.323137 | controller | TASK [kustomize_deploy : Apply generated content for examples/dt/nova/nova04delta/control-plane/networking/nncp _raw_params=oc apply -f {{ _cr }}] *** 2025-11-25 15:45:50.323149 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.050) 0:00:38.251 ****** 2025-11-25 15:45:50.323157 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.050) 0:00:38.249 ****** 2025-11-25 15:45:50.323179 | controller | skipping: [localhost] 2025-11-25 15:45:50.372184 | controller | 2025-11-25 15:45:50.372271 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/dt/nova/nova04delta/control-plane/networking/nncp _raw_params={{ wait_condition }}] *** 2025-11-25 15:45:50.372286 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.050) 0:00:38.302 ****** 2025-11-25 15:45:50.372294 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.050) 0:00:38.299 ****** 2025-11-25 15:45:50.372313 | controller | skipping: [localhost] => (item=oc -n openstack wait nncp -l osp/nncm-config-type=standard --for jsonpath='{.status.conditions[0].reason}'=SuccessfullyConfigured --timeout=5m) 2025-11-25 15:45:50.417755 | controller | skipping: [localhost] 2025-11-25 15:45:50.417833 | controller | 2025-11-25 15:45:50.417842 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-11-25 15:45:50.417868 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.048) 0:00:38.350 ****** 2025-11-25 15:45:50.417875 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.048) 0:00:38.348 ****** 2025-11-25 15:45:50.417894 | controller | skipping: [localhost] 2025-11-25 15:45:50.471046 | controller | 2025-11-25 15:45:50.471124 | controller | TASK [Executing post_stage hooks for examples/dt/nova/nova04delta/control-plane/networking/nncp name=run_hook] *** 2025-11-25 15:45:50.471134 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.045) 0:00:38.396 ****** 2025-11-25 15:45:50.471142 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.045) 0:00:38.394 ****** 2025-11-25 15:45:50.471162 | controller | skipping: [localhost] 2025-11-25 15:45:50.520521 | controller | 2025-11-25 15:45:50.520644 | controller | TASK [kustomize_deploy : Assert mandatory bits are defined that=['stage is defined', 'stage_id is defined', "stage['path'] is defined", "stage['wait_conditions'] is defined", "stage['wait_conditions'] | length > 0", "stage['values'] is defined", "stage['values'] | length > 0", "stage['build_output'] is defined", "stage['build_output'] | length > 0"]] *** 2025-11-25 15:45:50.520662 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.052) 0:00:38.449 ****** 2025-11-25 15:45:50.520677 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.052) 0:00:38.447 ****** 2025-11-25 15:45:50.520725 | controller | ok: [localhost] => 2025-11-25 15:45:50.559963 | controller | changed: false 2025-11-25 15:45:50.560055 | controller | msg: All assertions passed 2025-11-25 15:45:50.560071 | controller | 2025-11-25 15:45:50.560085 | controller | TASK [kustomize_deploy : Check custom wait conditions that=item is match(_pattern), msg=The following custom condition is invalid: {{ item }}, quiet=True] *** 2025-11-25 15:45:50.560099 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.050) 0:00:38.499 ****** 2025-11-25 15:45:50.560113 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.050) 0:00:38.497 ****** 2025-11-25 15:45:50.560141 | controller | skipping: [localhost] 2025-11-25 15:45:50.603015 | controller | 2025-11-25 15:45:50.603096 | controller | TASK [kustomize_deploy : Check builtin wait conditions that=item is match(_pattern), msg=The following builtin condition is invalid: {{ item }}, quiet=True] *** 2025-11-25 15:45:50.603108 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.039) 0:00:38.538 ****** 2025-11-25 15:45:50.603117 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.039) 0:00:38.536 ****** 2025-11-25 15:45:50.603139 | controller | ok: [localhost] => (item=oc -n metallb-system wait pod -l app=metallb -l component=speaker --for condition=Ready --timeout=5min) 2025-11-25 15:45:50.633914 | controller | 2025-11-25 15:45:50.633997 | controller | TASK [kustomize_deploy : Check wait_conditions validation result msg=Review and correct the faulty wait_conditions listed above.] *** 2025-11-25 15:45:50.634007 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.043) 0:00:38.581 ****** 2025-11-25 15:45:50.634014 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.043) 0:00:38.579 ****** 2025-11-25 15:45:50.634032 | controller | skipping: [localhost] 2025-11-25 15:45:50.676721 | controller | 2025-11-25 15:45:50.676803 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact _wait_conditions={{ stage.wait_conditions + _custom_conditions }}] *** 2025-11-25 15:45:50.676812 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.030) 0:00:38.612 ****** 2025-11-25 15:45:50.676820 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.030) 0:00:38.610 ****** 2025-11-25 15:45:50.676841 | controller | ok: [localhost] 2025-11-25 15:45:50.953948 | controller | 2025-11-25 15:45:50.953990 | controller | TASK [kustomize_deploy : Ensure source files exists path={{ 2025-11-25 15:45:50.953999 | controller | (cifmw_kustomize_deploy_architecture_repo_dest_dir, 2025-11-25 15:45:50.954007 | controller | stage['path'], item.src_file) | path_join 2025-11-25 15:45:50.954014 | controller | }}, get_attributes=False, get_checksum=False, get_mime=False] *** 2025-11-25 15:45:50.954021 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.042) 0:00:38.655 ****** 2025-11-25 15:45:50.954029 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.042) 0:00:38.653 ****** 2025-11-25 15:45:50.954051 | controller | ok: [localhost] => (item={'name': 'network-values', 'src_file': 'nncp/values.yaml'}) 2025-11-25 15:45:51.021627 | controller | 2025-11-25 15:45:51.021717 | controller | TASK [kustomize_deploy : Assert source files exist that=['(item.stat is defined and item.stat.exists) or item.skipped'], quiet=True] *** 2025-11-25 15:45:51.021734 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.277) 0:00:38.932 ****** 2025-11-25 15:45:51.021749 | controller | Tuesday 25 November 2025 15:45:50 +0000 (0:00:00.277) 0:00:38.930 ****** 2025-11-25 15:45:51.021777 | controller | ok: [localhost] => (item=values.yaml) 2025-11-25 15:45:51.071144 | controller | 2025-11-25 15:45:51.071188 | controller | TASK [Executing pre_stage hooks for examples/dt/nova/nova04delta/control-plane/networking name=run_hook] *** 2025-11-25 15:45:51.071198 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.067) 0:00:39.000 ****** 2025-11-25 15:45:51.071207 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.067) 0:00:38.998 ****** 2025-11-25 15:45:51.071221 | controller | skipping: [localhost] 2025-11-25 15:45:51.153330 | controller | 2025-11-25 15:45:51.153403 | controller | TASK [Generate values.yaml for examples/dt/nova/nova04delta/control-plane/networking name=ci_gen_kustomize_values] *** 2025-11-25 15:45:51.153411 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.049) 0:00:39.050 ****** 2025-11-25 15:45:51.153419 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.049) 0:00:39.048 ****** 2025-11-25 15:45:51.153437 | controller | 2025-11-25 15:45:51.221309 | controller | TASK [ci_gen_kustomize_values : Generate snippets files _raw_params=generate_snippets.yml] *** 2025-11-25 15:45:51.221346 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.082) 0:00:39.132 ****** 2025-11-25 15:45:51.221354 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.082) 0:00:39.130 ****** 2025-11-25 15:45:51.221366 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for localhost 2025-11-25 15:45:51.295502 | controller | 2025-11-25 15:45:51.295609 | controller | TASK [ci_gen_kustomize_values : Ensure needed parameter is properly set that=['cifmw_architecture_scenario is defined', 'cifmw_architecture_scenario is not none'], msg=cifmw_architecture_scenario must be provided.] *** 2025-11-25 15:45:51.295625 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.068) 0:00:39.200 ****** 2025-11-25 15:45:51.295634 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.068) 0:00:39.198 ****** 2025-11-25 15:45:51.295649 | controller | ok: [localhost] => 2025-11-25 15:45:51.533150 | controller | changed: false 2025-11-25 15:45:51.533195 | controller | msg: All assertions passed 2025-11-25 15:45:51.533206 | controller | 2025-11-25 15:45:51.533215 | controller | TASK [ci_gen_kustomize_values : Stat original source file path={{ cifmw_ci_gen_kustomize_values_src_file }}, get_attributes=False, get_checksum=False, get_mime=False] *** 2025-11-25 15:45:51.533224 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.073) 0:00:39.274 ****** 2025-11-25 15:45:51.533232 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.073) 0:00:39.272 ****** 2025-11-25 15:45:51.533246 | controller | ok: [localhost] 2025-11-25 15:45:51.593032 | controller | 2025-11-25 15:45:51.593073 | controller | TASK [ci_gen_kustomize_values : Assert source file exists that=['_src_stat.stat.exists'], msg={{ cifmw_ci_gen_kustomize_values_src_file }} doesn't exist.] *** 2025-11-25 15:45:51.593083 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.238) 0:00:39.512 ****** 2025-11-25 15:45:51.593092 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.238) 0:00:39.510 ****** 2025-11-25 15:45:51.593106 | controller | ok: [localhost] => 2025-11-25 15:45:51.815517 | controller | changed: false 2025-11-25 15:45:51.815575 | controller | msg: All assertions passed 2025-11-25 15:45:51.815585 | controller | 2025-11-25 15:45:51.815592 | controller | TASK [ci_gen_kustomize_values : Load original values file src={{ cifmw_ci_gen_kustomize_values_src_file }}] *** 2025-11-25 15:45:51.815599 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.059) 0:00:39.571 ****** 2025-11-25 15:45:51.815605 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.059) 0:00:39.569 ****** 2025-11-25 15:45:51.815625 | controller | ok: [localhost] 2025-11-25 15:45:52.092449 | controller | 2025-11-25 15:45:52.092490 | controller | TASK [ci_gen_kustomize_values : Expose common data for future usage values_datatype={{ _datatype }}, snippet_datadir={{ _dest_dir }}, original_content={{ _config_map_content }}, _cifmw_gen_kustomize_values_extra_manifests={{ 2025-11-25 15:45:52.092498 | controller | _raw_manifests | reject('equalto', _config_map_content) 2025-11-25 15:45:52.092505 | controller | }}, _cifmw_gen_kustomize_values_base_cm_content={{ 2025-11-25 15:45:52.092511 | controller | _config_map_content | 2025-11-25 15:45:52.092518 | controller | ansible.utils.remove_keys( 2025-11-25 15:45:52.092524 | controller | target=_cifmw_gen_kustomize_values_reject_expressions, 2025-11-25 15:45:52.092530 | controller | matching_parameter='regex') 2025-11-25 15:45:52.092536 | controller | }}, cacheable=False] *** 2025-11-25 15:45:52.092564 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.222) 0:00:39.794 ****** 2025-11-25 15:45:52.092573 | controller | Tuesday 25 November 2025 15:45:51 +0000 (0:00:00.222) 0:00:39.792 ****** 2025-11-25 15:45:52.092586 | controller | ok: [localhost] 2025-11-25 15:45:52.165620 | controller | 2025-11-25 15:45:52.165700 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type _raw_params={{ _tasks }}] *** 2025-11-25 15:45:52.165714 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.276) 0:00:40.071 ****** 2025-11-25 15:45:52.165740 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.276) 0:00:40.069 ****** 2025-11-25 15:45:52.165763 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for localhost 2025-11-25 15:45:52.217173 | controller | 2025-11-25 15:45:52.217256 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters that=['cifmw_networking_env_definition is defined']] *** 2025-11-25 15:45:52.217267 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.073) 0:00:40.144 ****** 2025-11-25 15:45:52.217278 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.073) 0:00:40.142 ****** 2025-11-25 15:45:52.217301 | controller | ok: [localhost] => 2025-11-25 15:45:52.462597 | controller | changed: false 2025-11-25 15:45:52.462636 | controller | msg: All assertions passed 2025-11-25 15:45:52.462644 | controller | 2025-11-25 15:45:52.462651 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists path={{ snippet_datadir }}, state=directory, mode=0755] *** 2025-11-25 15:45:52.462657 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.051) 0:00:40.195 ****** 2025-11-25 15:45:52.462664 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.051) 0:00:40.193 ****** 2025-11-25 15:45:52.462676 | controller | ok: [localhost] 2025-11-25 15:45:53.097456 | controller | 2025-11-25 15:45:53.097501 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet backup=True, dest={{ 2025-11-25 15:45:53.097512 | controller | (snippet_datadir, 2025-11-25 15:45:53.097520 | controller | '02_ci_data.yaml') | path_join 2025-11-25 15:45:53.097528 | controller | }}, src={{ _tmpl_check_path | first }}, mode=0644] *** 2025-11-25 15:45:53.097536 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.245) 0:00:40.441 ****** 2025-11-25 15:45:53.097581 | controller | Tuesday 25 November 2025 15:45:52 +0000 (0:00:00.245) 0:00:40.439 ****** 2025-11-25 15:45:53.097597 | controller | ok: [localhost] 2025-11-25 15:45:53.173932 | controller | 2025-11-25 15:45:53.174004 | controller | TASK [ci_gen_kustomize_values : Generate the base64 CI ConfigMap patches _base64_patch={{ _patches_tuple[0] }}, _cifmw_gen_kustomize_values_extra_manifests={{ _patches_tuple[1] }}] *** 2025-11-25 15:45:53.174013 | controller | Tuesday 25 November 2025 15:45:53 +0000 (0:00:00.634) 0:00:41.076 ****** 2025-11-25 15:45:53.174019 | controller | Tuesday 25 November 2025 15:45:53 +0000 (0:00:00.634) 0:00:41.074 ****** 2025-11-25 15:45:53.174037 | controller | ok: [localhost] 2025-11-25 15:45:53.656379 | controller | 2025-11-25 15:45:53.656420 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches backup=True, dest={{ 2025-11-25 15:45:53.656428 | controller | (snippet_datadir, 2025-11-25 15:45:53.656434 | controller | '03_user_data_b64.yaml') | path_join 2025-11-25 15:45:53.656441 | controller | }}, content={{ 2025-11-25 15:45:53.656459 | controller | _base64_patch | 2025-11-25 15:45:53.656466 | controller | default({}) | 2025-11-25 15:45:53.656471 | controller | to_nice_yaml 2025-11-25 15:45:53.656477 | controller | }}, mode=0644] *** 2025-11-25 15:45:53.656483 | controller | Tuesday 25 November 2025 15:45:53 +0000 (0:00:00.076) 0:00:41.152 ****** 2025-11-25 15:45:53.656489 | controller | Tuesday 25 November 2025 15:45:53 +0000 (0:00:00.076) 0:00:41.150 ****** 2025-11-25 15:45:53.656501 | controller | ok: [localhost] 2025-11-25 15:45:54.214257 | controller | 2025-11-25 15:45:54.214331 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset backup=True, dest={{ 2025-11-25 15:45:54.214339 | controller | (snippet_datadir, 2025-11-25 15:45:54.214347 | controller | '04_user_data.yaml') | path_join 2025-11-25 15:45:54.214357 | controller | }}, content={{ 2025-11-25 15:45:54.214365 | controller | cifmw_ci_gen_kustomize_values_userdata | 2025-11-25 15:45:54.214373 | controller | default({}) | 2025-11-25 15:45:54.214380 | controller | to_nice_yaml 2025-11-25 15:45:54.214597 | controller | }}, mode=0644] *** 2025-11-25 15:45:54.214605 | controller | Tuesday 25 November 2025 15:45:53 +0000 (0:00:00.482) 0:00:41.635 ****** 2025-11-25 15:45:54.214613 | controller | Tuesday 25 November 2025 15:45:53 +0000 (0:00:00.482) 0:00:41.633 ****** 2025-11-25 15:45:54.214634 | controller | ok: [localhost] 2025-11-25 15:45:54.705431 | controller | 2025-11-25 15:45:54.705479 | controller | TASK [ci_gen_kustomize_values : Copy the base values.yaml backup=True, content={{ _cifmw_gen_kustomize_values_base_cm_content |to_nice_yaml }}, dest={{ 2025-11-25 15:45:54.705491 | controller | ( 2025-11-25 15:45:54.705499 | controller | snippet_datadir, 2025-11-25 15:45:54.705509 | controller | cifmw_ci_gen_kustomize_values_original_cm_content_file_name 2025-11-25 15:45:54.705518 | controller | ) | path_join 2025-11-25 15:45:54.705526 | controller | }}, mode=0644] *** 2025-11-25 15:45:54.705535 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.557) 0:00:42.192 ****** 2025-11-25 15:45:54.705574 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.557) 0:00:42.190 ****** 2025-11-25 15:45:54.705593 | controller | changed: [localhost] 2025-11-25 15:45:54.773519 | controller | 2025-11-25 15:45:54.773612 | controller | TASK [ci_gen_kustomize_values : Generate values file _raw_params=generate_values.yml] *** 2025-11-25 15:45:54.773629 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.491) 0:00:42.684 ****** 2025-11-25 15:45:54.773637 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.491) 0:00:42.682 ****** 2025-11-25 15:45:54.773663 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for localhost 2025-11-25 15:45:54.843921 | controller | 2025-11-25 15:45:54.843970 | controller | TASK [ci_gen_kustomize_values : Ensure we have needed parameter that=['values_datatype is defined', "values_datatype != ''"], msg=Please do not call this tasks file without calling the generate_snippet.yml first!] *** 2025-11-25 15:45:54.843984 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.068) 0:00:42.752 ****** 2025-11-25 15:45:54.843993 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.068) 0:00:42.750 ****** 2025-11-25 15:45:54.844008 | controller | ok: [localhost] => 2025-11-25 15:45:55.086126 | controller | changed: false 2025-11-25 15:45:55.086208 | controller | msg: All assertions passed 2025-11-25 15:45:55.086236 | controller | 2025-11-25 15:45:55.086244 | controller | TASK [ci_gen_kustomize_values : List snippets paths={{ _dir_path }}, patterns=*.yml,*.yaml, excludes={{ cifmw_ci_gen_kustomize_values_original_cm_content_file_name }}, recurse=False] *** 2025-11-25 15:45:55.086252 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.070) 0:00:42.822 ****** 2025-11-25 15:45:55.086260 | controller | Tuesday 25 November 2025 15:45:54 +0000 (0:00:00.070) 0:00:42.820 ****** 2025-11-25 15:45:55.086280 | controller | ok: [localhost] 2025-11-25 15:45:55.138204 | controller | 2025-11-25 15:45:55.138280 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty _content={}] ********** 2025-11-25 15:45:55.138289 | controller | Tuesday 25 November 2025 15:45:55 +0000 (0:00:00.242) 0:00:43.064 ****** 2025-11-25 15:45:55.138297 | controller | Tuesday 25 November 2025 15:45:55 +0000 (0:00:00.242) 0:00:43.062 ****** 2025-11-25 15:45:55.138318 | controller | ok: [localhost] 2025-11-25 15:45:55.910195 | controller | 2025-11-25 15:45:55.910348 | controller | TASK [ci_gen_kustomize_values : Load various snippet files path={{ file.path }}] *** 2025-11-25 15:45:55.910358 | controller | Tuesday 25 November 2025 15:45:55 +0000 (0:00:00.052) 0:00:43.117 ****** 2025-11-25 15:45:55.910365 | controller | Tuesday 25 November 2025 15:45:55 +0000 (0:00:00.052) 0:00:43.114 ****** 2025-11-25 15:45:55.910391 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml) 2025-11-25 15:45:56.056399 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml) 2025-11-25 15:45:56.056445 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml) 2025-11-25 15:45:56.056455 | controller | 2025-11-25 15:45:56.056463 | controller | TASK [ci_gen_kustomize_values : Combine snippets _content={{ 2025-11-25 15:45:56.056471 | controller | _content | 2025-11-25 15:45:56.056478 | controller | default(_cifmw_gen_kustomize_values_base_cm_content, true) | 2025-11-25 15:45:56.056485 | controller | combine(_parsed, recursive=true) 2025-11-25 15:45:56.056492 | controller | }} 2025-11-25 15:45:56.056499 | controller | ] *** 2025-11-25 15:45:56.056506 | controller | Tuesday 25 November 2025 15:45:55 +0000 (0:00:00.772) 0:00:43.889 ****** 2025-11-25 15:45:56.056514 | controller | Tuesday 25 November 2025 15:45:55 +0000 (0:00:00.772) 0:00:43.887 ****** 2025-11-25 15:45:56.056536 | controller | ok: [localhost] => (item=02_ci_data.yaml) 2025-11-25 15:45:56.295646 | controller | ok: [localhost] => (item=03_user_data_b64.yaml) 2025-11-25 15:45:56.295723 | controller | ok: [localhost] => (item=04_user_data.yaml) 2025-11-25 15:45:56.295734 | controller | 2025-11-25 15:45:56.295743 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist path={{ _destdir }}, state=directory, mode=0755] *** 2025-11-25 15:45:56.295751 | controller | Tuesday 25 November 2025 15:45:56 +0000 (0:00:00.146) 0:00:44.035 ****** 2025-11-25 15:45:56.295758 | controller | Tuesday 25 November 2025 15:45:56 +0000 (0:00:00.146) 0:00:44.033 ****** 2025-11-25 15:45:56.295777 | controller | ok: [localhost] 2025-11-25 15:45:56.811520 | controller | 2025-11-25 15:45:56.811574 | controller | TASK [ci_gen_kustomize_values : Output values file backup=True, dest={{ 2025-11-25 15:45:56.811582 | controller | (_destdir, 2025-11-25 15:45:56.811589 | controller | cifmw_ci_gen_kustomize_values_dest_filename) | path_join 2025-11-25 15:45:56.811595 | controller | }}, content={{ 2025-11-25 15:45:56.811601 | controller | ( 2025-11-25 15:45:56.811607 | controller | [ _content ] + _cifmw_gen_kustomize_values_extra_manifests 2025-11-25 15:45:56.811613 | controller | ) | cifmw.general.to_nice_yaml_all 2025-11-25 15:45:56.811619 | controller | }}, mode=0644] *** 2025-11-25 15:45:56.811625 | controller | Tuesday 25 November 2025 15:45:56 +0000 (0:00:00.239) 0:00:44.274 ****** 2025-11-25 15:45:56.811631 | controller | Tuesday 25 November 2025 15:45:56 +0000 (0:00:00.239) 0:00:44.272 ****** 2025-11-25 15:45:56.811642 | controller | ok: [localhost] 2025-11-25 15:45:57.108066 | controller | 2025-11-25 15:45:57.108191 | controller | TASK [kustomize_deploy : Copy generated values for examples/dt/nova/nova04delta/control-plane/networking mode=0644, backup=True, remote_src=True, src={{ 2025-11-25 15:45:57.108200 | controller | (cifmw_kustomize_deploy_basedir, 2025-11-25 15:45:57.108208 | controller | 'artifacts', 'ci_gen_kustomize_values', 2025-11-25 15:45:57.108214 | controller | _val['name'], 'values.yaml') | path_join 2025-11-25 15:45:57.108220 | controller | }}, dest={{ 2025-11-25 15:45:57.108228 | controller | (cifmw_kustomize_deploy_architecture_repo_dest_dir, 2025-11-25 15:45:57.108235 | controller | stage['path'], _val.src_file 2025-11-25 15:45:57.108241 | controller | ) | 2025-11-25 15:45:57.108248 | controller | path_join 2025-11-25 15:45:57.108254 | controller | }}] *** 2025-11-25 15:45:57.108260 | controller | Tuesday 25 November 2025 15:45:56 +0000 (0:00:00.515) 0:00:44.790 ****** 2025-11-25 15:45:57.108267 | controller | Tuesday 25 November 2025 15:45:56 +0000 (0:00:00.515) 0:00:44.788 ****** 2025-11-25 15:45:57.108293 | controller | ok: [localhost] => (item=network-values) 2025-11-25 15:45:57.156108 | controller | 2025-11-25 15:45:57.156183 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-11-25 15:45:57.156195 | controller | Tuesday 25 November 2025 15:45:57 +0000 (0:00:00.296) 0:00:45.086 ****** 2025-11-25 15:45:57.156216 | controller | Tuesday 25 November 2025 15:45:57 +0000 (0:00:00.296) 0:00:45.084 ****** 2025-11-25 15:45:57.156234 | controller | skipping: [localhost] 2025-11-25 15:45:57.631602 | controller | 2025-11-25 15:45:57.631677 | controller | TASK [kustomize_deploy : Build kustomized content for examples/dt/nova/nova04delta/control-plane/networking chdir={{ _chdir }}, _raw_params=oc kustomize] *** 2025-11-25 15:45:57.631688 | controller | Tuesday 25 November 2025 15:45:57 +0000 (0:00:00.048) 0:00:45.135 ****** 2025-11-25 15:45:57.631697 | controller | Tuesday 25 November 2025 15:45:57 +0000 (0:00:00.048) 0:00:45.133 ****** 2025-11-25 15:45:57.631717 | controller | changed: [localhost] 2025-11-25 15:45:58.134845 | controller | 2025-11-25 15:45:58.134919 | controller | TASK [kustomize_deploy : Output kustomize build in final file backup=True, dest={{ _output }}, content={{ _kustomize_output.stdout }}, mode=0644] *** 2025-11-25 15:45:58.134927 | controller | Tuesday 25 November 2025 15:45:57 +0000 (0:00:00.475) 0:00:45.610 ****** 2025-11-25 15:45:58.134934 | controller | Tuesday 25 November 2025 15:45:57 +0000 (0:00:00.475) 0:00:45.608 ****** 2025-11-25 15:45:58.134951 | controller | changed: [localhost] 2025-11-25 15:45:58.426882 | controller | 2025-11-25 15:45:58.426928 | controller | TASK [kustomize_deploy : Store kustomized content in artifacts for examples/dt/nova/nova04delta/control-plane/networking remote_src=True, src={{ _output }}, dest={{ 2025-11-25 15:45:58.426938 | controller | (cifmw_kustomize_deploy_kustomizations_dest_dir, 2025-11-25 15:45:58.426946 | controller | stage['build_output'] | basename) | path_join 2025-11-25 15:45:58.426953 | controller | }}, mode=0644] *** 2025-11-25 15:45:58.426961 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.503) 0:00:46.113 ****** 2025-11-25 15:45:58.426969 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.503) 0:00:46.111 ****** 2025-11-25 15:45:58.426983 | controller | changed: [localhost] 2025-11-25 15:45:58.480105 | controller | 2025-11-25 15:45:58.480177 | controller | TASK [kustomize_deploy : Stop after building kustomization if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-11-25 15:45:58.480186 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.292) 0:00:46.405 ****** 2025-11-25 15:45:58.480192 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.292) 0:00:46.403 ****** 2025-11-25 15:45:58.480210 | controller | skipping: [localhost] 2025-11-25 15:45:58.535500 | controller | 2025-11-25 15:45:58.535595 | controller | TASK [kustomize_deploy : Apply generated content for examples/dt/nova/nova04delta/control-plane/networking _raw_params=oc apply -f {{ _cr }}] *** 2025-11-25 15:45:58.535607 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.053) 0:00:46.459 ****** 2025-11-25 15:45:58.535615 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.053) 0:00:46.457 ****** 2025-11-25 15:45:58.535635 | controller | skipping: [localhost] 2025-11-25 15:45:58.589268 | controller | 2025-11-25 15:45:58.589319 | controller | TASK [kustomize_deploy : Run Wait Conditions for examples/dt/nova/nova04delta/control-plane/networking _raw_params={{ wait_condition }}] *** 2025-11-25 15:45:58.589330 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.055) 0:00:46.514 ****** 2025-11-25 15:45:58.589338 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.055) 0:00:46.512 ****** 2025-11-25 15:45:58.589353 | controller | skipping: [localhost] => (item=oc -n metallb-system wait pod -l app=metallb -l component=speaker --for condition=Ready --timeout=5min) 2025-11-25 15:45:58.637865 | controller | skipping: [localhost] 2025-11-25 15:45:58.637933 | controller | 2025-11-25 15:45:58.637941 | controller | TASK [kustomize_deploy : Stop after applying CRs if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-11-25 15:45:58.637949 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.053) 0:00:46.568 ****** 2025-11-25 15:45:58.637956 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.053) 0:00:46.566 ****** 2025-11-25 15:45:58.637973 | controller | skipping: [localhost] 2025-11-25 15:45:58.709345 | controller | 2025-11-25 15:45:58.709397 | controller | TASK [Executing post_stage hooks for examples/dt/nova/nova04delta/control-plane/networking name=run_hook] *** 2025-11-25 15:45:58.709420 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.048) 0:00:46.616 ****** 2025-11-25 15:45:58.709433 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.048) 0:00:46.614 ****** 2025-11-25 15:45:58.709450 | controller | skipping: [localhost] 2025-11-25 15:45:58.816148 | controller | 2025-11-25 15:45:58.816216 | controller | PLAY RECAP ********************************************************************* 2025-11-25 15:45:58.816224 | controller | localhost : ok=92 changed=23 unreachable=0 failed=0 skipped=29 rescued=0 ignored=0 2025-11-25 15:45:58.816231 | controller | 2025-11-25 15:45:58.816237 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.070) 0:00:46.687 ****** 2025-11-25 15:45:58.816243 | controller | =============================================================================== 2025-11-25 15:45:58.816248 | controller | Get automation contents ------------------------------------------------- 8.61s 2025-11-25 15:45:58.816254 | controller | ci_setup : Install needed packages -------------------------------------- 6.03s 2025-11-25 15:45:58.816260 | controller | ci_setup : Install openshift client ------------------------------------- 5.60s 2025-11-25 15:45:58.816266 | controller | Load automation files as fact ------------------------------------------- 1.48s 2025-11-25 15:45:58.816285 | controller | ci_setup : Manage directories ------------------------------------------- 1.12s 2025-11-25 15:45:58.816301 | controller | Gathering Facts --------------------------------------------------------- 0.96s 2025-11-25 15:45:58.816307 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.77s 2025-11-25 15:45:58.816313 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.77s 2025-11-25 15:45:58.816422 | controller | Create needed SSH keypairs ---------------------------------------------- 0.72s 2025-11-25 15:45:58.816430 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.64s 2025-11-25 15:45:58.816436 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.63s 2025-11-25 15:45:58.816442 | controller | kustomize_deploy : Output kustomize build in final file ----------------- 0.63s 2025-11-25 15:45:58.816448 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.56s 2025-11-25 15:45:58.816454 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.56s 2025-11-25 15:45:58.816459 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.53s 2025-11-25 15:45:58.816465 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.52s 2025-11-25 15:45:58.816471 | controller | kustomize_deploy : Output kustomize build in final file ----------------- 0.50s 2025-11-25 15:45:58.816477 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.49s 2025-11-25 15:45:58.816483 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.48s 2025-11-25 15:45:58.816488 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.48s 2025-11-25 15:45:58.816494 | controller | Tuesday 25 November 2025 15:45:58 +0000 (0:00:00.071) 0:00:46.686 ****** 2025-11-25 15:45:58.816500 | controller | =============================================================================== 2025-11-25 15:45:58.816506 | controller | ci_setup --------------------------------------------------------------- 14.20s 2025-11-25 15:45:58.816512 | controller | ci_gen_kustomize_values ------------------------------------------------ 11.30s 2025-11-25 15:45:58.816518 | controller | ansible.builtin.slurp --------------------------------------------------- 9.45s 2025-11-25 15:45:58.816523 | controller | kustomize_deploy -------------------------------------------------------- 6.51s 2025-11-25 15:45:58.816529 | controller | ansible.builtin.set_fact ------------------------------------------------ 1.55s 2025-11-25 15:45:58.816535 | controller | gather_facts ------------------------------------------------------------ 0.96s 2025-11-25 15:45:58.816556 | controller | networking_mapper ------------------------------------------------------- 0.76s 2025-11-25 15:45:58.816562 | controller | community.crypto.openssh_keypair ---------------------------------------- 0.72s 2025-11-25 15:45:58.816577 | controller | ansible.builtin.file ---------------------------------------------------- 0.41s 2025-11-25 15:45:58.816583 | controller | ansible.builtin.find ---------------------------------------------------- 0.40s 2025-11-25 15:45:58.816589 | controller | ansible.builtin.stat ---------------------------------------------------- 0.21s 2025-11-25 15:45:58.816595 | controller | ansible.builtin.include_role -------------------------------------------- 0.08s 2025-11-25 15:45:58.816601 | controller | ansible.builtin.assert -------------------------------------------------- 0.05s 2025-11-25 15:45:58.816610 | controller | ansible.builtin.copy ---------------------------------------------------- 0.02s 2025-11-25 15:45:58.816616 | controller | ansible.builtin.include_vars -------------------------------------------- 0.02s 2025-11-25 15:45:58.816622 | controller | ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~ 2025-11-25 15:45:58.816628 | controller | total ------------------------------------------------------------------ 46.64s 2025-11-25 15:45:59.113807 | controller | changed 2025-11-25 15:45:59.174706 | 2025-11-25 15:45:59.174857 | PLAY RECAP 2025-11-25 15:45:59.175003 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-25 15:45:59.175063 | 2025-11-25 15:45:59.291488 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/architecture/run.yml@main] 2025-11-25 15:45:59.292585 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-11-25 15:45:59.966054 | 2025-11-25 15:45:59.966187 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-11-25 15:45:59.989331 | 2025-11-25 15:45:59.989484 | TASK [Filter out host if needed] 2025-11-25 15:45:59.999884 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-11-25 15:46:00.009193 | 2025-11-25 15:46:00.009451 | TASK [Ensure file is present] 2025-11-25 15:46:00.439111 | controller | ok 2025-11-25 15:46:00.448710 | 2025-11-25 15:46:00.448807 | TASK [Manage molecule report file] 2025-11-25 15:46:00.988136 | controller | skipping: Conditional result was False 2025-11-25 15:46:01.001220 | 2025-11-25 15:46:01.001363 | TASK [Check if we get ci-framework-data basedir] 2025-11-25 15:46:01.253200 | controller | ok 2025-11-25 15:46:01.265333 | 2025-11-25 15:46:01.265464 | TASK [Create ci-framework-data log directory for zuul] 2025-11-25 15:46:01.705835 | controller | changed 2025-11-25 15:46:01.720193 | 2025-11-25 15:46:01.720433 | TASK [Copy ci-framework interesting files] 2025-11-25 15:46:02.240631 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-11-25 15:46:02.281395 | controller | changed 2025-11-25 15:46:02.293608 | 2025-11-25 15:46:02.293749 | TASK [Get SELinux listing] 2025-11-25 15:46:02.843429 | controller | changed 2025-11-25 15:46:02.856294 | 2025-11-25 15:46:02.856447 | TASK [Generate log index] 2025-11-25 15:46:03.805498 | controller | changed 2025-11-25 15:46:03.817130 | 2025-11-25 15:46:03.817283 | TASK [Get some env related data] 2025-11-25 15:46:04.565402 | controller | /home/zuul/.local/bin/ansible 2025-11-25 15:46:05.368223 | controller | changed 2025-11-25 15:46:05.374175 | 2025-11-25 15:46:05.374260 | TASK [Generate list of logs to collect in home directory] 2025-11-25 15:46:05.770964 | controller | ok: All paths examined 2025-11-25 15:46:05.776921 | 2025-11-25 15:46:05.777012 | LOOP [Copy logs from home directory] 2025-11-25 15:46:06.245741 | controller | changed: 2025-11-25 15:46:06.245957 | controller | { 2025-11-25 15:46:06.246011 | controller | "atime": 1764085484.4812799, 2025-11-25 15:46:06.246093 | controller | "ctime": 1764085558.7082622, 2025-11-25 15:46:06.246132 | controller | "dev": 64513, 2025-11-25 15:46:06.246168 | controller | "gid": 1000, 2025-11-25 15:46:06.246204 | controller | "gr_name": "zuul", 2025-11-25 15:46:06.246240 | controller | "inode": 4445500, 2025-11-25 15:46:06.246275 | controller | "isblk": false, 2025-11-25 15:46:06.246310 | controller | "ischr": false, 2025-11-25 15:46:06.246486 | controller | "isdir": false, 2025-11-25 15:46:06.246544 | controller | "isfifo": false, 2025-11-25 15:46:06.246588 | controller | "isgid": false, 2025-11-25 15:46:06.246640 | controller | "islnk": false, 2025-11-25 15:46:06.246691 | controller | "isreg": true, 2025-11-25 15:46:06.246728 | controller | "issock": false, 2025-11-25 15:46:06.246762 | controller | "isuid": false, 2025-11-25 15:46:06.246795 | controller | "mode": "0644", 2025-11-25 15:46:06.246828 | controller | "mtime": 1764085558.7082622, 2025-11-25 15:46:06.246862 | controller | "nlink": 1, 2025-11-25 15:46:06.246896 | controller | "path": "/home/zuul/ansible.log", 2025-11-25 15:46:06.246933 | controller | "pw_name": "zuul", 2025-11-25 15:46:06.246968 | controller | "rgrp": true, 2025-11-25 15:46:06.247002 | controller | "roth": true, 2025-11-25 15:46:06.247124 | controller | "rusr": true, 2025-11-25 15:46:06.247167 | controller | "size": 94749, 2025-11-25 15:46:06.247202 | controller | "uid": 1000, 2025-11-25 15:46:06.247237 | controller | "wgrp": false, 2025-11-25 15:46:06.247270 | controller | "woth": false, 2025-11-25 15:46:06.247323 | controller | "wusr": true, 2025-11-25 15:46:06.247378 | controller | "xgrp": false, 2025-11-25 15:46:06.247417 | controller | "xoth": false, 2025-11-25 15:46:06.247451 | controller | "xusr": false 2025-11-25 15:46:06.247484 | controller | } 2025-11-25 15:46:06.259634 | 2025-11-25 15:46:06.259774 | TASK [Copy crio stats log file] 2025-11-25 15:46:06.295515 | controller | skipping: Conditional result was False 2025-11-25 15:46:06.302001 | 2025-11-25 15:46:06.302115 | TASK [Get SELinux related data] 2025-11-25 15:46:06.614156 | controller | 2025-11-25 15:46:06.835231 | controller | ERROR 2025-11-25 15:46:06.835611 | controller | { 2025-11-25 15:46:06.835702 | controller | "delta": "0:00:00.017382", 2025-11-25 15:46:06.835769 | controller | "end": "2025-11-25 15:46:06.615980", 2025-11-25 15:46:06.835829 | controller | "msg": "non-zero return code", 2025-11-25 15:46:06.835886 | controller | "rc": 1, 2025-11-25 15:46:06.835926 | controller | "start": "2025-11-25 15:46:06.598598" 2025-11-25 15:46:06.835961 | controller | } 2025-11-25 15:46:06.836046 | controller | ERROR: Ignoring Errors 2025-11-25 15:46:06.849902 | 2025-11-25 15:46:06.850306 | TASK [Create system configuration directory] 2025-11-25 15:46:07.125768 | controller | changed 2025-11-25 15:46:07.137996 | 2025-11-25 15:46:07.138158 | TASK [Get some of the system configurations] 2025-11-25 15:46:07.687427 | controller | changed 2025-11-25 15:46:07.700579 | 2025-11-25 15:46:07.700750 | TASK [Copy generated documentation if available] 2025-11-25 15:46:07.728934 | controller | skipping: Conditional result was False 2025-11-25 15:46:07.744873 | 2025-11-25 15:46:07.745081 | TASK [Copy generated AsciiDoc documentation if available] 2025-11-25 15:46:07.774134 | controller | skipping: Conditional result was False 2025-11-25 15:46:07.789802 | 2025-11-25 15:46:07.789985 | TASK [Compress logs bigger than 2MB] 2025-11-25 15:46:08.342064 | controller | changed 2025-11-25 15:46:08.351255 | 2025-11-25 15:46:08.351353 | TASK [Copy files from workspace on node] 2025-11-25 15:46:08.376960 | controller | ok 2025-11-25 15:46:08.414228 | 2025-11-25 15:46:08.414389 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-25 15:46:08.452321 | controller | skipping: Conditional result was False 2025-11-25 15:46:08.463149 | 2025-11-25 15:46:08.463292 | TASK [fetch-output : Set log path for single node] 2025-11-25 15:46:08.508162 | controller | ok 2025-11-25 15:46:08.516193 | 2025-11-25 15:46:08.516303 | LOOP [fetch-output : Ensure local output dirs] 2025-11-25 15:46:08.849731 | controller -> localhost | ok: "/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/logs" 2025-11-25 15:46:08.850202 | controller -> localhost | changed: All items complete 2025-11-25 15:46:08.850274 | 2025-11-25 15:46:09.090271 | controller -> localhost | changed: "/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/artifacts" 2025-11-25 15:46:09.335352 | controller -> localhost | changed: "/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/docs" 2025-11-25 15:46:09.355976 | 2025-11-25 15:46:09.356192 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-25 15:46:10.161409 | controller | changed: 2025-11-25 15:46:10.161779 | controller | .d..t...... ./ 2025-11-25 15:46:10.161853 | controller | >f+++++++++ README.html 2025-11-25 15:46:10.161911 | controller | >f+++++++++ ansible.log 2025-11-25 15:46:10.161968 | controller | >f+++++++++ dmesg.log 2025-11-25 15:46:10.162175 | controller | >f+++++++++ installed-pkgs.log 2025-11-25 15:46:10.162270 | controller | >f+++++++++ python.log 2025-11-25 15:46:10.162334 | controller | >f+++++++++ registries.conf 2025-11-25 15:46:10.162388 | controller | >f+++++++++ selinux-denials.log 2025-11-25 15:46:10.162438 | controller | >f+++++++++ selinux-listing.log 2025-11-25 15:46:10.162492 | controller | cd+++++++++ ci-framework-data/ 2025-11-25 15:46:10.162540 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-11-25 15:46:10.162589 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_deploy 2025-11-25 15:46:10.162637 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_deploy.pub 2025-11-25 15:46:10.162687 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_nova_migration 2025-11-25 15:46:10.162737 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_nova_migration.pub 2025-11-25 15:46:10.162784 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-11-25 15:46:10.162832 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/ 2025-11-25 15:46:10.162879 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/ 2025-11-25 15:46:10.162925 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml 2025-11-25 15:46:10.162972 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/ 2025-11-25 15:46:10.163229 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/ 2025-11-25 15:46:10.163299 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml 2025-11-25 15:46:10.163344 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml.29817.2025-11-25@15:45:54~ 2025-11-25 15:46:10.163385 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml 2025-11-25 15:46:10.163425 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml 2025-11-25 15:46:10.163463 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml 2025-11-25 15:46:10.163502 | controller | cd+++++++++ ci-framework-data/artifacts/kustomize_deploy/ 2025-11-25 15:46:10.163541 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/networking.yaml 2025-11-25 15:46:10.163578 | controller | >f+++++++++ ci-framework-data/artifacts/kustomize_deploy/nncp.yaml 2025-11-25 15:46:10.163617 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/ 2025-11-25 15:46:10.163656 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/ 2025-11-25 15:46:10.163693 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/ 2025-11-25 15:46:10.163730 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-11-25 15:46:10.163768 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-11-25 15:46:10.163806 | controller | cd+++++++++ ci-framework-data/logs/ 2025-11-25 15:46:10.163842 | controller | cd+++++++++ registries.conf.d/ 2025-11-25 15:46:10.163879 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-11-25 15:46:10.163920 | controller | cd+++++++++ system-config/ 2025-11-25 15:46:10.163955 | controller | cd+++++++++ system-config/libvirt/ 2025-11-25 15:46:10.163992 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-11-25 15:46:10.164089 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-11-25 15:46:10.700281 | controller | changed: .d..t...... ./ 2025-11-25 15:46:11.225288 | controller | changed: .d..t...... ./ 2025-11-25 15:46:11.264189 | 2025-11-25 15:46:11.264430 | TASK [Return artifact to Zuul] 2025-11-25 15:46:11.302991 | controller | skipping: Conditional result was False 2025-11-25 15:46:11.348654 | 2025-11-25 15:46:11.348767 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-11-25 15:46:11.348895 | 2025-11-25 15:46:11.348932 | PLAY RECAP 2025-11-25 15:46:11.348982 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-11-25 15:46:11.349009 | 2025-11-25 15:46:11.546166 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-11-25 15:46:11.547790 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-11-25 15:46:12.211316 | 2025-11-25 15:46:12.211497 | PLAY [all] 2025-11-25 15:46:12.230780 | 2025-11-25 15:46:12.230857 | TASK [include_role : fetch-output] 2025-11-25 15:46:12.272787 | controller | ok 2025-11-25 15:46:12.290725 | 2025-11-25 15:46:12.290803 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-25 15:46:12.356432 | controller | skipping: Conditional result was False 2025-11-25 15:46:12.363107 | 2025-11-25 15:46:12.363202 | TASK [fetch-output : Set log path for single node] 2025-11-25 15:46:12.403366 | controller | ok 2025-11-25 15:46:12.408483 | 2025-11-25 15:46:12.408549 | LOOP [fetch-output : Ensure local output dirs] 2025-11-25 15:46:12.903210 | controller -> localhost | ok: "/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/logs" 2025-11-25 15:46:13.174922 | controller -> localhost | ok: "/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/artifacts" 2025-11-25 15:46:13.413894 | controller -> localhost | ok: "/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/docs" 2025-11-25 15:46:13.424182 | 2025-11-25 15:46:13.424309 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-25 15:46:14.166118 | controller | ok 2025-11-25 15:46:14.166591 | controller | ok: All items complete 2025-11-25 15:46:14.166650 | 2025-11-25 15:46:14.747785 | controller | ok 2025-11-25 15:46:15.508364 | controller | ok 2025-11-25 15:46:15.544156 | 2025-11-25 15:46:15.544475 | TASK [include_role : fetch-output-openshift] 2025-11-25 15:46:15.574153 | controller | skipping: Conditional result was False 2025-11-25 15:46:15.589852 | 2025-11-25 15:46:15.590105 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-25 15:46:16.104988 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.010477 2025-11-25 15:46:16.347166 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.011310 2025-11-25 15:46:16.404127 | 2025-11-25 15:46:16.404252 | PLAY [all] 2025-11-25 15:46:16.426468 | 2025-11-25 15:46:16.426571 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-25 15:46:17.027904 | controller | changed 2025-11-25 15:46:17.084452 | 2025-11-25 15:46:17.084679 | PLAY RECAP 2025-11-25 15:46:17.084771 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-11-25 15:46:17.084816 | 2025-11-25 15:46:17.255792 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-11-25 15:46:17.256654 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-11-25 15:46:17.965491 | 2025-11-25 15:46:17.965637 | PLAY [localhost] 2025-11-25 15:46:17.986305 | 2025-11-25 15:46:17.986445 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-25 15:46:18.453446 | localhost | changed 2025-11-25 15:46:18.458452 | 2025-11-25 15:46:18.458532 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-25 15:46:18.487546 | localhost | ok 2025-11-25 15:46:18.497164 | 2025-11-25 15:46:18.497236 | TASK [add-fileserver : Create SSH private key tempfile] 2025-11-25 15:46:18.922920 | localhost | changed 2025-11-25 15:46:18.928069 | 2025-11-25 15:46:18.928144 | TASK [add-fileserver : Create SSH private key from secret] 2025-11-25 15:46:19.727263 | localhost | changed 2025-11-25 15:46:19.738944 | 2025-11-25 15:46:19.739112 | TASK [add-fileserver : Add fileserver ssh key] 2025-11-25 15:46:20.200617 | localhost | Identity added: /var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/tmp/ansible.jal5c7u0 (/var/lib/zuul/builds/ac6d664ac2e44e9585d5941fd3c6ee96/work/tmp/ansible.jal5c7u0) 2025-11-25 15:46:20.200857 | localhost | ok: Runtime: 0:00:00.009613 2025-11-25 15:46:20.207288 | 2025-11-25 15:46:20.207412 | TASK [add-fileserver : Remove SSH private key from disk] 2025-11-25 15:46:20.533617 | localhost | ok: Runtime: 0:00:00.007071 2025-11-25 15:46:20.538479 | 2025-11-25 15:46:20.538547 | TASK [add-fileserver : Add fileserver to inventory] 2025-11-25 15:46:20.608036 | localhost | changed 2025-11-25 15:46:20.612375 | 2025-11-25 15:46:20.612441 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-11-25 15:46:21.006970 | localhost | changed 2025-11-25 15:46:21.028542 | 2025-11-25 15:46:21.028625 | PLAY [localhost] 2025-11-25 15:46:21.041558 | 2025-11-25 15:46:21.041645 | TASK [Generate bulk log download script] 2025-11-25 15:46:21.062163 | localhost | ok 2025-11-25 15:46:21.074893 | 2025-11-25 15:46:21.074989 | TASK [local-log-download : Check API endpoint is defined] 2025-11-25 15:46:21.125082 | localhost | ok: All assertions passed 2025-11-25 15:46:21.132101 | 2025-11-25 15:46:21.132175 | TASK [local-log-download : Create download script] 2025-11-25 15:46:21.583666 | localhost -> localhost | changed 2025-11-25 15:46:21.595332 | 2025-11-25 15:46:21.595408 | TASK [Register quick-download link] 2025-11-25 15:46:21.653867 | localhost | ok 2025-11-25 15:46:21.670779 | 2025-11-25 15:46:21.670881 | PLAY [logserver.rdoproject.org] 2025-11-25 15:46:21.681578 | 2025-11-25 15:46:21.681645 | TASK [Set zuul-log-path fact] 2025-11-25 15:46:21.709088 | logserver.rdoproject.org | ok 2025-11-25 15:46:21.719107 | 2025-11-25 15:46:21.719179 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-25 15:46:21.758998 | logserver.rdoproject.org | ok 2025-11-25 15:46:21.766824 | 2025-11-25 15:46:21.766914 | TASK [upload-logs : Create log directories] 2025-11-25 15:46:22.474748 | logserver.rdoproject.org | changed 2025-11-25 15:46:22.482599 | 2025-11-25 15:46:22.482749 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-25 15:46:22.789935 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.010571 2025-11-25 15:46:22.801258 | 2025-11-25 15:46:22.801422 | TASK [upload-logs : Upload logs to log server] 2025-11-25 15:46:28.732566 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-11-25 15:46:28.737558 | 2025-11-25 15:46:28.737650 | LOOP [upload-logs : Compress console log and json output] 2025-11-25 15:46:28.780868 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-25 15:46:28.791273 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-25 15:46:28.802920 | 2025-11-25 15:46:28.803137 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-25 15:46:28.841243 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-25 15:46:28.841499 | 2025-11-25 15:46:28.846585 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-25 15:46:28.854960 | 2025-11-25 15:46:28.855150 | LOOP [upload-logs : Upload console log and json output]