2025-10-03 07:52:11.385585 | Job console starting... 2025-10-03 07:52:11.394729 | Updating repositories 2025-10-03 07:52:11.440885 | Preparing job workspace 2025-10-03 07:52:16.824769 | Running Ansible setup... 2025-10-03 07:52:20.748030 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-03 07:52:21.326565 | 2025-10-03 07:52:21.326728 | PLAY [localhost] 2025-10-03 07:52:21.337478 | 2025-10-03 07:52:21.337596 | TASK [Gathering Facts] 2025-10-03 07:52:22.332036 | localhost | ok 2025-10-03 07:52:22.365016 | 2025-10-03 07:52:22.365534 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-03 07:52:22.799332 | localhost -> localhost | changed 2025-10-03 07:52:22.805080 | 2025-10-03 07:52:22.805151 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-03 07:52:23.673905 | localhost -> localhost | changed 2025-10-03 07:52:23.681964 | 2025-10-03 07:52:23.682026 | TASK [Setup log path fact] 2025-10-03 07:52:23.700490 | localhost | ok 2025-10-03 07:52:23.711303 | 2025-10-03 07:52:23.711368 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 07:52:23.728467 | localhost | ok 2025-10-03 07:52:23.737036 | 2025-10-03 07:52:23.737109 | TASK [emit-job-header : Print job information] 2025-10-03 07:52:23.766365 | # Job Information 2025-10-03 07:52:23.766535 | Ansible Version: 2.15.12 2025-10-03 07:52:23.766562 | Job: rhoso-architecture-validate-nvidia-vfio-passthrough-adoption 2025-10-03 07:52:23.766583 | Pipeline: github-check 2025-10-03 07:52:23.766602 | Executor: ze02.softwarefactory-project.io 2025-10-03 07:52:23.766621 | Triggered by: https://github.com/openstack-k8s-operators/architecture/pull/602 2025-10-03 07:52:23.766640 | Log URL (when completed): https://logserver.rdoproject.org/5f1/rdoproject.org/5f192751283a40b09616edcf44fb77e5/ 2025-10-03 07:52:23.766659 | Event ID: bd4fc720-a02d-11f0-8d13-496c12e5deac 2025-10-03 07:52:23.770250 | 2025-10-03 07:52:23.770310 | LOOP [emit-job-header : Print node information] 2025-10-03 07:52:23.863183 | localhost | ok: 2025-10-03 07:52:23.863410 | localhost | # Node Information 2025-10-03 07:52:23.863441 | localhost | Inventory Hostname: controller 2025-10-03 07:52:23.863464 | localhost | Hostname: np0005468324 2025-10-03 07:52:23.863484 | localhost | Username: zuul 2025-10-03 07:52:23.863504 | localhost | Distro: CentOS 9 2025-10-03 07:52:23.863522 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-03 07:52:23.863539 | localhost | Region: RegionOne 2025-10-03 07:52:23.863555 | localhost | Label: cloud-centos-9-stream-tripleo 2025-10-03 07:52:23.863571 | localhost | Product Name: OpenStack Nova 2025-10-03 07:52:23.863587 | localhost | Interface IP: 38.102.83.194 2025-10-03 07:52:23.885749 | 2025-10-03 07:52:23.885838 | PLAY [all] 2025-10-03 07:52:23.891902 | 2025-10-03 07:52:23.891962 | TASK [Gather network facts] 2025-10-03 07:52:24.417464 | controller | ok 2025-10-03 07:52:24.434270 | 2025-10-03 07:52:24.434329 | TASK [include_role : start-zuul-console] 2025-10-03 07:52:24.452131 | controller | ok 2025-10-03 07:52:24.463390 | 2025-10-03 07:52:24.463448 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-03 07:52:24.916703 | controller | ok 2025-10-03 07:52:24.926833 | 2025-10-03 07:52:24.926956 | TASK [include_role : add-build-sshkey] 2025-10-03 07:52:24.955709 | controller | ok 2025-10-03 07:52:24.968790 | 2025-10-03 07:52:24.968853 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-03 07:52:25.238452 | controller -> localhost | ok 2025-10-03 07:52:25.244084 | 2025-10-03 07:52:25.244147 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-03 07:52:25.278285 | controller | ok 2025-10-03 07:52:25.307567 | controller | included: /var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-03 07:52:25.320494 | 2025-10-03 07:52:25.320601 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-03 07:52:25.820772 | controller -> localhost | Generating public/private rsa key pair. 2025-10-03 07:52:25.820999 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/5f192751283a40b09616edcf44fb77e5_id_rsa. 2025-10-03 07:52:25.821031 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/5f192751283a40b09616edcf44fb77e5_id_rsa.pub. 2025-10-03 07:52:25.821052 | controller -> localhost | The key fingerprint is: 2025-10-03 07:52:25.821072 | controller -> localhost | SHA256:NurvsjSU57ni8XXXAQ70slpTA0QsgzOpugSf2qOSRJo zuul-build-sshkey 2025-10-03 07:52:25.821090 | controller -> localhost | The key's randomart image is: 2025-10-03 07:52:25.821109 | controller -> localhost | +---[RSA 3072]----+ 2025-10-03 07:52:25.821126 | controller -> localhost | | o += | 2025-10-03 07:52:25.821145 | controller -> localhost | | = o..o | 2025-10-03 07:52:25.821163 | controller -> localhost | | . o oo = | 2025-10-03 07:52:25.821181 | controller -> localhost | | o . . * o | 2025-10-03 07:52:25.821198 | controller -> localhost | |o.o o o S + . . | 2025-10-03 07:52:25.821216 | controller -> localhost | |E. = . = oo . ..| 2025-10-03 07:52:25.821233 | controller -> localhost | |..+ . = o.. . . .| 2025-10-03 07:52:25.821250 | controller -> localhost | |o. + oo+ o . . | 2025-10-03 07:52:25.821267 | controller -> localhost | |... ..+*= | 2025-10-03 07:52:25.821284 | controller -> localhost | +----[SHA256]-----+ 2025-10-03 07:52:25.821328 | controller -> localhost | ok: Runtime: 0:00:00.055588 2025-10-03 07:52:25.827268 | 2025-10-03 07:52:25.827330 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-03 07:52:25.849491 | controller | ok 2025-10-03 07:52:25.859390 | controller | included: /var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-03 07:52:25.867349 | 2025-10-03 07:52:25.867413 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-03 07:52:25.891375 | controller | skipping: Conditional result was False 2025-10-03 07:52:25.897885 | 2025-10-03 07:52:25.897950 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-03 07:52:26.397884 | controller | changed 2025-10-03 07:52:26.405057 | 2025-10-03 07:52:26.405147 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-03 07:52:26.677620 | controller | ok 2025-10-03 07:52:26.682914 | 2025-10-03 07:52:26.682975 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-03 07:52:27.490036 | controller | changed 2025-10-03 07:52:27.518381 | 2025-10-03 07:52:27.518481 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-03 07:52:28.207759 | controller | changed 2025-10-03 07:52:28.219890 | 2025-10-03 07:52:28.219998 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-03 07:52:28.245068 | controller | skipping: Conditional result was False 2025-10-03 07:52:28.255427 | 2025-10-03 07:52:28.255513 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-03 07:52:28.639438 | controller -> localhost | changed 2025-10-03 07:52:28.649354 | 2025-10-03 07:52:28.649430 | TASK [add-build-sshkey : Add back temp key] 2025-10-03 07:52:28.887677 | controller -> localhost | Identity added: /var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/5f192751283a40b09616edcf44fb77e5_id_rsa (zuul-build-sshkey) 2025-10-03 07:52:28.887872 | controller -> localhost | ok: Runtime: 0:00:00.008092 2025-10-03 07:52:28.893478 | 2025-10-03 07:52:28.893545 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-03 07:52:29.242533 | controller | ok 2025-10-03 07:52:29.256148 | 2025-10-03 07:52:29.256292 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-03 07:52:29.284010 | controller | skipping: Conditional result was False 2025-10-03 07:52:29.305860 | 2025-10-03 07:52:29.306022 | TASK [include_role : validate-host] 2025-10-03 07:52:29.342756 | controller | ok 2025-10-03 07:52:29.382970 | 2025-10-03 07:52:29.383056 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-03 07:52:29.427187 | controller | ok 2025-10-03 07:52:29.437340 | 2025-10-03 07:52:29.437472 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-03 07:52:29.700976 | controller -> localhost | ok 2025-10-03 07:52:29.706583 | 2025-10-03 07:52:29.706642 | TASK [validate-host : Collect information about the host] 2025-10-03 07:52:30.538301 | controller | ok 2025-10-03 07:52:30.558179 | 2025-10-03 07:52:30.558345 | TASK [validate-host : Sanitize hostname] 2025-10-03 07:52:30.621752 | controller | ok 2025-10-03 07:52:30.628809 | 2025-10-03 07:52:30.628899 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-03 07:52:31.114318 | controller -> localhost | changed 2025-10-03 07:52:31.127656 | 2025-10-03 07:52:31.127827 | TASK [validate-host : Collect information about zuul worker] 2025-10-03 07:52:31.620879 | controller | ok 2025-10-03 07:52:31.631773 | 2025-10-03 07:52:31.631910 | TASK [validate-host : Write out all zuul information for each host] 2025-10-03 07:52:32.178552 | controller -> localhost | changed 2025-10-03 07:52:32.200283 | 2025-10-03 07:52:32.200402 | TASK [include_role : prepare-workspace-openshift] 2025-10-03 07:52:32.214926 | controller | skipping: Conditional result was False 2025-10-03 07:52:32.221910 | 2025-10-03 07:52:32.221992 | TASK [include_role : remove-zuul-sshkey] 2025-10-03 07:52:32.236256 | controller | skipping: Conditional result was False 2025-10-03 07:52:32.243302 | 2025-10-03 07:52:32.243404 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-03 07:52:32.500773 | controller | ok: "logs" 2025-10-03 07:52:32.500998 | controller | ok: All items complete 2025-10-03 07:52:32.501026 | 2025-10-03 07:52:32.716543 | controller | ok: "artifacts" 2025-10-03 07:52:32.925839 | controller | ok: "docs" 2025-10-03 07:52:32.934628 | 2025-10-03 07:52:32.934779 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-03 07:52:33.169617 | controller | changed: "logs" 2025-10-03 07:52:33.380479 | controller | changed: "artifacts" 2025-10-03 07:52:33.733795 | controller | changed: "docs" 2025-10-03 07:52:33.776236 | 2025-10-03 07:52:33.776613 | PLAY RECAP 2025-10-03 07:52:33.776780 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-03 07:52:33.776870 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-03 07:52:33.776916 | 2025-10-03 07:52:33.965635 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-03 07:52:33.966805 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-03 07:52:34.580396 | 2025-10-03 07:52:34.580516 | PLAY [all] 2025-10-03 07:52:34.600491 | 2025-10-03 07:52:34.600571 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-03 07:52:34.670315 | controller | ok 2025-10-03 07:52:34.675410 | 2025-10-03 07:52:34.675485 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-03 07:52:35.125070 | controller | changed 2025-10-03 07:52:35.132850 | 2025-10-03 07:52:35.132939 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-03 07:52:36.359326 | controller | changed 2025-10-03 07:52:36.379707 | 2025-10-03 07:52:36.379798 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-03 07:52:36.911657 | controller | changed: 2025-10-03 07:52:36.912003 | controller | { 2025-10-03 07:52:36.912061 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-03 07:52:36.912119 | controller | } 2025-10-03 07:52:37.183923 | controller | changed: 2025-10-03 07:52:37.184195 | controller | { 2025-10-03 07:52:37.184264 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-03 07:52:37.184319 | controller | } 2025-10-03 07:52:37.466850 | controller | changed: 2025-10-03 07:52:37.466984 | controller | { 2025-10-03 07:52:37.467036 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-10-03 07:52:37.467078 | controller | } 2025-10-03 07:52:37.743168 | controller | changed: 2025-10-03 07:52:37.743278 | controller | { 2025-10-03 07:52:37.743302 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-03 07:52:37.743320 | controller | } 2025-10-03 07:52:38.051428 | controller | changed: 2025-10-03 07:52:38.051595 | controller | { 2025-10-03 07:52:38.051647 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-03 07:52:38.051768 | controller | } 2025-10-03 07:52:38.351357 | controller | changed: 2025-10-03 07:52:38.351491 | controller | { 2025-10-03 07:52:38.351545 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-03 07:52:38.351589 | controller | } 2025-10-03 07:52:38.622991 | controller | changed: 2025-10-03 07:52:38.623164 | controller | { 2025-10-03 07:52:38.623216 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2025-10-03 07:52:38.623258 | controller | } 2025-10-03 07:52:38.938448 | controller | changed: 2025-10-03 07:52:38.938581 | controller | { 2025-10-03 07:52:38.938632 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2025-10-03 07:52:38.938712 | controller | } 2025-10-03 07:52:39.255265 | controller | changed: 2025-10-03 07:52:39.255376 | controller | { 2025-10-03 07:52:39.255426 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-03 07:52:39.255464 | controller | } 2025-10-03 07:52:39.565880 | controller | changed: 2025-10-03 07:52:39.566007 | controller | { 2025-10-03 07:52:39.566038 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-03 07:52:39.566062 | controller | } 2025-10-03 07:52:39.836015 | controller | changed: 2025-10-03 07:52:39.836152 | controller | { 2025-10-03 07:52:39.836202 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-03 07:52:39.836241 | controller | } 2025-10-03 07:52:40.109393 | controller | changed: 2025-10-03 07:52:40.109546 | controller | { 2025-10-03 07:52:40.109600 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-03 07:52:40.109642 | controller | } 2025-10-03 07:52:40.437598 | controller | changed: 2025-10-03 07:52:40.437794 | controller | { 2025-10-03 07:52:40.437849 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-03 07:52:40.437893 | controller | } 2025-10-03 07:52:40.730819 | controller | changed: 2025-10-03 07:52:40.731058 | controller | { 2025-10-03 07:52:40.731092 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-03 07:52:40.731112 | controller | } 2025-10-03 07:52:41.059226 | controller | changed: 2025-10-03 07:52:41.059317 | controller | { 2025-10-03 07:52:41.059340 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-03 07:52:41.059359 | controller | } 2025-10-03 07:52:41.344877 | controller | changed: 2025-10-03 07:52:41.344971 | controller | { 2025-10-03 07:52:41.344993 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-03 07:52:41.345012 | controller | } 2025-10-03 07:52:41.630157 | controller | changed: 2025-10-03 07:52:41.630250 | controller | { 2025-10-03 07:52:41.630273 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2025-10-03 07:52:41.630293 | controller | } 2025-10-03 07:52:41.921050 | controller | changed: 2025-10-03 07:52:41.921139 | controller | { 2025-10-03 07:52:41.921163 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2025-10-03 07:52:41.921190 | controller | } 2025-10-03 07:52:42.190132 | controller | changed: 2025-10-03 07:52:42.190224 | controller | { 2025-10-03 07:52:42.190247 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-03 07:52:42.190265 | controller | } 2025-10-03 07:52:42.530395 | controller | changed: 2025-10-03 07:52:42.530586 | controller | { 2025-10-03 07:52:42.530711 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-03 07:52:42.530797 | controller | } 2025-10-03 07:52:42.808703 | controller | changed: 2025-10-03 07:52:42.808834 | controller | { 2025-10-03 07:52:42.808875 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-03 07:52:42.808908 | controller | } 2025-10-03 07:52:43.131520 | controller | changed: 2025-10-03 07:52:43.131700 | controller | { 2025-10-03 07:52:43.131759 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-03 07:52:43.131801 | controller | } 2025-10-03 07:52:43.451572 | controller | changed: 2025-10-03 07:52:43.451886 | controller | { 2025-10-03 07:52:43.451964 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2025-10-03 07:52:43.452010 | controller | } 2025-10-03 07:52:43.715130 | controller | changed: 2025-10-03 07:52:43.715516 | controller | { 2025-10-03 07:52:43.715585 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-03 07:52:43.715626 | controller | } 2025-10-03 07:52:44.003524 | controller | changed: 2025-10-03 07:52:44.003740 | controller | { 2025-10-03 07:52:44.003813 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-03 07:52:44.003867 | controller | } 2025-10-03 07:52:44.295025 | controller | changed: 2025-10-03 07:52:44.295190 | controller | { 2025-10-03 07:52:44.295240 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-03 07:52:44.295279 | controller | } 2025-10-03 07:52:44.338113 | 2025-10-03 07:52:44.338305 | TASK [Set timezone to UTC] 2025-10-03 07:52:44.983746 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-03 07:52:44.996193 | 2025-10-03 07:52:44.996338 | TASK [Create nodepool directory] 2025-10-03 07:52:45.275525 | controller | changed 2025-10-03 07:52:45.282556 | 2025-10-03 07:52:45.282617 | TASK [Create nodepool sub_nodes file] 2025-10-03 07:52:46.126152 | controller | changed 2025-10-03 07:52:46.137737 | 2025-10-03 07:52:46.137890 | TASK [Create nodepool sub_nodes_private file] 2025-10-03 07:52:47.029255 | controller | changed 2025-10-03 07:52:47.042696 | 2025-10-03 07:52:47.042834 | LOOP [Populate nodepool sub_nodes file] 2025-10-03 07:52:47.093421 | 2025-10-03 07:52:47.093704 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-03 07:52:47.154731 | 2025-10-03 07:52:47.155018 | TASK [Create nodepool primary file] 2025-10-03 07:52:47.191428 | controller | skipping: Conditional result was False 2025-10-03 07:52:47.199738 | 2025-10-03 07:52:47.199848 | TASK [Create nodepool node_private for this node] 2025-10-03 07:52:48.125162 | controller | changed 2025-10-03 07:52:48.139879 | 2025-10-03 07:52:48.140043 | LOOP [Copy ssh keys to nodepool directory] 2025-10-03 07:52:48.618154 | controller | ok: Item: id_rsa Runtime: 0:00:00.010024 2025-10-03 07:52:48.618595 | 2025-10-03 07:52:48.872837 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.007297 2025-10-03 07:52:48.893203 | 2025-10-03 07:52:48.893398 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-03 07:52:49.766481 | controller | changed 2025-10-03 07:52:49.771424 | 2025-10-03 07:52:49.771485 | TASK [Validate sudoers config after edits] 2025-10-03 07:52:50.057965 | controller | /etc/sudoers: parsed OK 2025-10-03 07:52:50.058051 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-03 07:52:50.058063 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-03 07:52:50.058072 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-03 07:52:50.300876 | controller | ok: Runtime: 0:00:00.008745 2025-10-03 07:52:50.306622 | 2025-10-03 07:52:50.306696 | TASK [Show the environment passed in to job shell scripts] 2025-10-03 07:52:50.606355 | controller | SHELL=/bin/bash 2025-10-03 07:52:50.606457 | controller | ZUUL_PROJECT=openstack-k8s-operators/architecture 2025-10-03 07:52:50.606472 | controller | ZUUL_SHORT_PROJECT_NAME=architecture 2025-10-03 07:52:50.606481 | controller | ZUUL_CHANGES=openstack-k8s-operators/architecture:main:refs/changes/02/602/f8656f91296ca95daf6c7ba8ca5bf14633335f7a 2025-10-03 07:52:50.606490 | controller | PWD=/home/zuul 2025-10-03 07:52:50.606498 | controller | ZUUL_PIPELINE=github-check 2025-10-03 07:52:50.606507 | controller | LOGNAME=zuul 2025-10-03 07:52:50.606619 | controller | XDG_SESSION_TYPE=tty 2025-10-03 07:52:50.606634 | controller | _=/usr/bin/env 2025-10-03 07:52:50.606644 | controller | MOTD_SHOWN=pam 2025-10-03 07:52:50.606652 | controller | HOME=/home/zuul 2025-10-03 07:52:50.606661 | controller | LANG=en_US.UTF-8 2025-10-03 07:52:50.606669 | controller | SSH_CONNECTION=38.102.83.114 42540 38.102.83.194 22 2025-10-03 07:52:50.606678 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2025-10-03 07:52:50.606690 | controller | ZUUL_CHANGE_IDS=602,f8656f91296ca95daf6c7ba8ca5bf14633335f7a 2025-10-03 07:52:50.606699 | controller | WORKSPACE=/home/zuul/workspace 2025-10-03 07:52:50.606707 | controller | XDG_SESSION_CLASS=user 2025-10-03 07:52:50.606715 | controller | SELINUX_ROLE_REQUESTED= 2025-10-03 07:52:50.606723 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-03 07:52:50.606732 | controller | USER=zuul 2025-10-03 07:52:50.606740 | controller | ZUUL_VOTING=True 2025-10-03 07:52:50.606748 | controller | BUILD_TIMEOUT=1800000 2025-10-03 07:52:50.606755 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-03 07:52:50.606763 | controller | SHLVL=1 2025-10-03 07:52:50.606771 | controller | ZUUL_PATCHSET=f8656f91296ca95daf6c7ba8ca5bf14633335f7a 2025-10-03 07:52:50.606779 | controller | XDG_SESSION_ID=1 2025-10-03 07:52:50.606787 | controller | ZUUL_BRANCH=main 2025-10-03 07:52:50.606795 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-03 07:52:50.606824 | controller | SSH_CLIENT=38.102.83.114 42540 22 2025-10-03 07:52:50.606840 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-03 07:52:50.606848 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-03 07:52:50.606856 | controller | which_declare=declare -f 2025-10-03 07:52:50.606865 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-03 07:52:50.606873 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-03 07:52:50.606881 | controller | ZUUL_CHANGE=602 2025-10-03 07:52:50.606889 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-03 07:52:50.606896 | controller | ZUUL_UUID=5f192751283a40b09616edcf44fb77e5 2025-10-03 07:52:50.606904 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-03 07:52:50.606913 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-03 07:52:50.606921 | controller | } 2025-10-03 07:52:50.836733 | controller | ok: Runtime: 0:00:00.024170 2025-10-03 07:52:50.841937 | 2025-10-03 07:52:50.841998 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-03 07:52:50.855170 | controller | skipping: Conditional result was False 2025-10-03 07:52:50.860730 | 2025-10-03 07:52:50.860796 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-03 07:52:51.390779 | controller | skipping: Conditional result was False 2025-10-03 07:52:51.443128 | 2025-10-03 07:52:51.443283 | TASK [Ensure legacy workspace directory] 2025-10-03 07:52:51.718003 | controller | changed 2025-10-03 07:52:51.744778 | 2025-10-03 07:52:51.744852 | PLAY RECAP 2025-10-03 07:52:51.744906 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-03 07:52:51.744934 | 2025-10-03 07:52:51.847746 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-03 07:52:51.849404 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-03 07:52:52.540238 | 2025-10-03 07:52:52.540362 | PLAY [Run ci/playbooks/e2e-prepare.yml] 2025-10-03 07:52:52.573349 | 2025-10-03 07:52:52.573450 | TASK [Clone repos in the job workspace] 2025-10-03 07:52:52.596350 | controller | ok 2025-10-03 07:52:52.614800 | 2025-10-03 07:52:52.614892 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-03 07:52:52.990564 | controller | ok 2025-10-03 07:52:52.999597 | 2025-10-03 07:52:52.999861 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-03 07:52:56.083142 | controller | Output suppressed because no_log was given 2025-10-03 07:52:56.103327 | 2025-10-03 07:52:56.103465 | TASK [Create zuul-output directory] 2025-10-03 07:52:56.489049 | controller | ok 2025-10-03 07:52:56.500884 | 2025-10-03 07:52:56.501060 | TASK [Install required packages] 2025-10-03 07:54:05.414923 | controller | changed 2025-10-03 07:54:05.420856 | 2025-10-03 07:54:05.420918 | TASK [Output pip related things] 2025-10-03 07:54:06.159972 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9) 2025-10-03 07:54:06.451017 | controller | changed 2025-10-03 07:54:06.462209 | 2025-10-03 07:54:06.462341 | TASK [Install requirements] 2025-10-03 07:55:15.723729 | controller | changed 2025-10-03 07:55:15.749275 | 2025-10-03 07:55:15.749378 | TASK [Add cronjob to trigger job stats] 2025-10-03 07:55:15.794862 | controller | skipping: Conditional result was False 2025-10-03 07:55:15.801039 | 2025-10-03 07:55:15.801101 | LOOP [Construct project change list] 2025-10-03 07:55:15.864831 | controller | ok: 2025-10-03 07:55:15.865044 | controller | { 2025-10-03 07:55:15.865070 | controller | "branch": "main", 2025-10-03 07:55:15.865088 | controller | "change": "602", 2025-10-03 07:55:15.865105 | controller | "change_message": "Create a DT and VA for GPU full device PCI pass-through for GPU workloads testing\n\nAdd DT and related VA for full PCI device passthrough\r\nfor testing GPU workloads on RHOSO.\r\n\r\nThe VA is based on nvidia-mdev-passthrough, DT is based on\r\nnova02beta, plus bmo01 DT for provisioning outside of ci-framework stages\r\n\r\nJira: [OSPRH-18904](https://issues.redhat.com//browse/OSPRH-18904)", 2025-10-03 07:55:15.865125 | controller | "change_url": "https://github.com/openstack-k8s-operators/architecture/pull/602", 2025-10-03 07:55:15.865141 | controller | "commit_id": "f8656f91296ca95daf6c7ba8ca5bf14633335f7a", 2025-10-03 07:55:15.865157 | controller | "patchset": "f8656f91296ca95daf6c7ba8ca5bf14633335f7a", 2025-10-03 07:55:15.865182 | controller | "project": { 2025-10-03 07:55:15.865202 | controller | "canonical_hostname": "github.com", 2025-10-03 07:55:15.865402 | controller | "canonical_name": "github.com/openstack-k8s-operators/architecture", 2025-10-03 07:55:15.865436 | controller | "name": "openstack-k8s-operators/architecture", 2025-10-03 07:55:15.865455 | controller | "short_name": "architecture", 2025-10-03 07:55:15.865471 | controller | "src_dir": "src/github.com/openstack-k8s-operators/architecture" 2025-10-03 07:55:15.865488 | controller | }, 2025-10-03 07:55:15.865504 | controller | "topic": null 2025-10-03 07:55:15.865519 | controller | } 2025-10-03 07:55:15.914533 | 2025-10-03 07:55:15.914612 | PLAY [Run ci/playbooks/build_runner_image.yml] 2025-10-03 07:55:15.929301 | 2025-10-03 07:55:15.929384 | TASK [Filter out host if needed] 2025-10-03 07:55:15.942435 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-03 07:55:15.947813 | 2025-10-03 07:55:15.947868 | TASK [Get git tag for image tagging] 2025-10-03 07:55:16.475238 | controller | skipping: Conditional result was False 2025-10-03 07:55:16.480972 | 2025-10-03 07:55:16.481038 | TASK [Set openstack-runner image] 2025-10-03 07:55:16.505989 | controller | skipping: Conditional result was False 2025-10-03 07:55:16.512230 | 2025-10-03 07:55:16.512294 | TASK [Build openstack-runner image] 2025-10-03 07:55:16.547005 | controller | skipping: Conditional result was False 2025-10-03 07:55:16.553475 | 2025-10-03 07:55:16.553535 | TASK [Push openstack-runner image] 2025-10-03 07:55:16.587788 | controller | skipping: Conditional result was False 2025-10-03 07:55:16.593403 | 2025-10-03 07:55:16.593528 | TASK [Make sure ci-framework directory exists] 2025-10-03 07:55:16.618316 | controller | skipping: Conditional result was False 2025-10-03 07:55:16.624995 | 2025-10-03 07:55:16.625061 | TASK [Create EDPM ansible var file] 2025-10-03 07:55:16.649414 | controller | skipping: Conditional result was False 2025-10-03 07:55:16.674522 | 2025-10-03 07:55:16.674618 | PLAY RECAP 2025-10-03 07:55:16.674661 | controller | ok: 7 changed: 4 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-03 07:55:16.674700 | 2025-10-03 07:55:16.775354 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-03 07:55:16.776210 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-03 07:55:17.404643 | 2025-10-03 07:55:17.404758 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-03 07:55:17.426521 | 2025-10-03 07:55:17.426636 | TASK [Create zuul-output directory] 2025-10-03 07:55:17.813314 | controller | changed 2025-10-03 07:55:17.818455 | 2025-10-03 07:55:17.818531 | TASK [Slurp Zuul inventory test] 2025-10-03 07:55:18.189502 | controller -> localhost | ok 2025-10-03 07:55:18.196284 | 2025-10-03 07:55:18.196361 | TASK [Save zuul inventory] 2025-10-03 07:55:19.182406 | controller | changed 2025-10-03 07:55:19.187955 | 2025-10-03 07:55:19.188024 | TASK [Save zuul vars without the change_message] 2025-10-03 07:55:20.009195 | controller | changed 2025-10-03 07:55:20.048776 | 2025-10-03 07:55:20.048857 | PLAY RECAP 2025-10-03 07:55:20.048916 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-03 07:55:20.048945 | 2025-10-03 07:55:20.171589 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-03 07:55:20.173048 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/architecture/run.yml@main] 2025-10-03 07:55:20.875456 | 2025-10-03 07:55:20.875590 | PLAY [Run ci/playbooks/architecture/validate-architecture.yml] 2025-10-03 07:55:20.896327 | 2025-10-03 07:55:20.896408 | TASK [Filter out host if needed] 2025-10-03 07:55:20.904954 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-03 07:55:20.909993 | 2025-10-03 07:55:20.910057 | TASK [Run playbook] 2025-10-03 07:55:22.051007 | controller | 2025-10-03 07:55:23.006372 | controller | PLAY [Test architecture automations] ******************************************* 2025-10-03 07:55:23.006464 | controller | 2025-10-03 07:55:23.006480 | controller | TASK [Gathering Facts ] ******************************************************** 2025-10-03 07:55:23.006494 | controller | Friday 03 October 2025 07:55:22 +0000 (0:00:00.035) 0:00:00.035 ******** 2025-10-03 07:55:23.006518 | controller | ok: [localhost] 2025-10-03 07:55:23.044799 | controller | 2025-10-03 07:55:23.044913 | 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-10-03 07:55:23.044937 | controller | Friday 03 October 2025 07:55:23 +0000 (0:00:00.955) 0:00:00.991 ******** 2025-10-03 07:55:23.044961 | controller | ok: [localhost] 2025-10-03 07:55:23.081827 | controller | 2025-10-03 07:55:23.081880 | controller | TASK [ci_setup : Gather variables for each operating system _raw_params={{ item }}] *** 2025-10-03 07:55:23.081895 | controller | Friday 03 October 2025 07:55:23 +0000 (0:00:00.038) 0:00:01.030 ******** 2025-10-03 07:55:23.081916 | controller | ok: [localhost] => (item=/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_setup/vars/redhat.yml) 2025-10-03 07:55:23.109760 | controller | 2025-10-03 07:55:23.109848 | controller | TASK [ci_setup : List packages to install var=cifmw_ci_setup_packages] ********* 2025-10-03 07:55:23.109862 | controller | Friday 03 October 2025 07:55:23 +0000 (0:00:00.036) 0:00:01.067 ******** 2025-10-03 07:55:23.109880 | controller | ok: [localhost] => 2025-10-03 07:55:28.236415 | controller | cifmw_ci_setup_packages: 2025-10-03 07:55:28.236486 | controller | - bash-completion 2025-10-03 07:55:28.236494 | controller | - ca-certificates 2025-10-03 07:55:28.236500 | controller | - git-core 2025-10-03 07:55:28.236506 | controller | - make 2025-10-03 07:55:28.236512 | controller | - tar 2025-10-03 07:55:28.236519 | controller | - tmux 2025-10-03 07:55:28.236525 | controller | - python3-pip 2025-10-03 07:55:28.236531 | controller | 2025-10-03 07:55:28.236538 | controller | TASK [ci_setup : Install needed packages name={{ cifmw_ci_setup_packages }}, state=latest] *** 2025-10-03 07:55:28.236544 | controller | Friday 03 October 2025 07:55:23 +0000 (0:00:00.027) 0:00:01.094 ******** 2025-10-03 07:55:28.236559 | controller | changed: [localhost] 2025-10-03 07:55:28.548111 | controller | 2025-10-03 07:55:28.548207 | controller | TASK [ci_setup : Gather version of openshift client _raw_params=oc version --client -o yaml] *** 2025-10-03 07:55:28.548233 | controller | Friday 03 October 2025 07:55:28 +0000 (0:00:05.126) 0:00:06.221 ******** 2025-10-03 07:55:28.548256 | controller | ok: [localhost] 2025-10-03 07:55:28.937549 | controller | 2025-10-03 07:55:28.937620 | controller | TASK [ci_setup : Ensure openshift client install path is present path={{ cifmw_ci_setup_oc_install_path }}, state=directory, mode=0755] *** 2025-10-03 07:55:28.937628 | controller | Friday 03 October 2025 07:55:28 +0000 (0:00:00.311) 0:00:06.533 ******** 2025-10-03 07:55:28.937645 | controller | changed: [localhost] 2025-10-03 07:55:34.090164 | controller | 2025-10-03 07:55:34.090235 | 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-10-03 07:55:34.090249 | controller | Friday 03 October 2025 07:55:28 +0000 (0:00:00.389) 0:00:06.922 ******** 2025-10-03 07:55:34.090265 | controller | changed: [localhost] 2025-10-03 07:55:34.120534 | controller | 2025-10-03 07:55:34.120609 | 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-10-03 07:55:34.120625 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:05.152) 0:00:12.075 ******** 2025-10-03 07:55:34.120645 | controller | skipping: [localhost] 2025-10-03 07:55:34.464209 | controller | 2025-10-03 07:55:34.464245 | controller | TASK [ci_setup : Create completion file] *************************************** 2025-10-03 07:55:34.464253 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.030) 0:00:12.105 ******** 2025-10-03 07:55:34.464264 | controller | changed: [localhost] 2025-10-03 07:55:34.873919 | controller | 2025-10-03 07:55:34.873958 | 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-10-03 07:55:34.873966 | controller | source ~/.oc_completion 2025-10-03 07:55:34.873973 | controller | fi] *** 2025-10-03 07:55:34.873979 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.344) 0:00:12.449 ******** 2025-10-03 07:55:34.873991 | controller | changed: [localhost] 2025-10-03 07:55:34.892921 | controller | 2025-10-03 07:55:34.892957 | controller | TASK [ci_setup : Check rhsm status _raw_params=subscription-manager status] **** 2025-10-03 07:55:34.892967 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.409) 0:00:12.859 ******** 2025-10-03 07:55:34.892980 | controller | skipping: [localhost] 2025-10-03 07:55:34.912306 | controller | 2025-10-03 07:55:34.912340 | controller | TASK [ci_setup : Gather the repos to be enabled _repos={{ 2025-10-03 07:55:34.912348 | controller | cifmw_ci_setup_rhel_rhsm_default_repos + 2025-10-03 07:55:34.912354 | controller | (cifmw_ci_setup_rhel_rhsm_extra_repos | default([])) 2025-10-03 07:55:34.912366 | controller | }}] *** 2025-10-03 07:55:34.912372 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.019) 0:00:12.878 ******** 2025-10-03 07:55:34.912383 | controller | skipping: [localhost] 2025-10-03 07:55:34.931256 | controller | 2025-10-03 07:55:34.931288 | controller | TASK [ci_setup : Enabling the required repositories. name={{ item }}, state={{ rhsm_repo_state | default('enabled') }}] *** 2025-10-03 07:55:34.931296 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.019) 0:00:12.897 ******** 2025-10-03 07:55:34.931307 | controller | skipping: [localhost] 2025-10-03 07:55:34.950890 | controller | 2025-10-03 07:55:34.950926 | controller | TASK [ci_setup : Get current /etc/redhat-release _raw_params=cat /etc/redhat-release] *** 2025-10-03 07:55:34.950937 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.019) 0:00:12.916 ******** 2025-10-03 07:55:34.950949 | controller | skipping: [localhost] 2025-10-03 07:55:34.969312 | controller | 2025-10-03 07:55:34.969348 | controller | TASK [ci_setup : Print current /etc/redhat-release msg={{ _current_rh_release.stdout }}] *** 2025-10-03 07:55:34.969356 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.019) 0:00:12.936 ******** 2025-10-03 07:55:34.969368 | controller | skipping: [localhost] 2025-10-03 07:55:34.994088 | controller | 2025-10-03 07:55:34.994148 | 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-10-03 07:55:34.994156 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.018) 0:00:12.954 ******** 2025-10-03 07:55:34.994173 | controller | skipping: [localhost] 2025-10-03 07:55:36.049294 | controller | 2025-10-03 07:55:36.049380 | controller | TASK [ci_setup : Manage directories path={{ item }}, state={{ directory_state }}, mode=0755, owner={{ ansible_user_id }}, group={{ ansible_user_id }}] *** 2025-10-03 07:55:36.049389 | controller | Friday 03 October 2025 07:55:34 +0000 (0:00:00.024) 0:00:12.979 ******** 2025-10-03 07:55:36.049409 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/manifests/openstack/cr) 2025-10-03 07:55:36.405226 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/logs) 2025-10-03 07:55:36.405333 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/tmp) 2025-10-03 07:55:36.405355 | controller | changed: [localhost] => (item=/home/zuul/ci-framework-data/volumes) 2025-10-03 07:55:36.405413 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/parameters) 2025-10-03 07:55:36.405436 | controller | 2025-10-03 07:55:36.405457 | controller | TASK [Create needed directories path={{ item }}, state=directory, mode=0755] *** 2025-10-03 07:55:36.405476 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:01.054) 0:00:14.034 ******** 2025-10-03 07:55:36.405512 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/logs) 2025-10-03 07:55:36.568240 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts) 2025-10-03 07:55:36.568287 | controller | 2025-10-03 07:55:36.568296 | controller | TASK [Check if we have a mock file path={{ _mock_file }}] ********************** 2025-10-03 07:55:36.568312 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:00.354) 0:00:14.388 ******** 2025-10-03 07:55:36.568381 | controller | ok: [localhost] 2025-10-03 07:55:36.586270 | controller | 2025-10-03 07:55:36.586309 | controller | TASK [Slurp file from remote src={{ _mock_file }}] ***************************** 2025-10-03 07:55:36.586317 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:00.165) 0:00:14.553 ******** 2025-10-03 07:55:36.586328 | controller | skipping: [localhost] 2025-10-03 07:55:36.607099 | controller | 2025-10-03 07:55:36.607140 | controller | TASK [Copy file on localhost dest={{ lookup('env', 'HOME') ~ '/' ~ cifmw_architecture_scenario ~ '.yml' }}, mode=0644, content={{ _mock_content.content | b64decode }}] *** 2025-10-03 07:55:36.607152 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:00.018) 0:00:14.571 ******** 2025-10-03 07:55:36.607164 | controller | skipping: [localhost] 2025-10-03 07:55:36.624599 | controller | 2025-10-03 07:55:36.624647 | controller | TASK [Include var file file={{ lookup('env', 'HOME') ~ '/' ~ cifmw_architecture_scenario ~ '.yml' }}] *** 2025-10-03 07:55:36.624656 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:00.020) 0:00:14.592 ******** 2025-10-03 07:55:36.624670 | controller | skipping: [localhost] 2025-10-03 07:55:36.956677 | controller | 2025-10-03 07:55:36.956727 | 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-10-03 07:55:36.956738 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:00.017) 0:00:14.609 ******** 2025-10-03 07:55:36.956753 | controller | ok: [localhost] 2025-10-03 07:55:37.421572 | controller | 2025-10-03 07:55:37.421640 | controller | TASK [kustomize_deploy : Gather the list of scenario folders paths={{ _va_scenario_dir }}, patterns=kustomization.y*ml, recurse=True] *** 2025-10-03 07:55:37.421650 | controller | Friday 03 October 2025 07:55:36 +0000 (0:00:00.328) 0:00:14.938 ******** 2025-10-03 07:55:37.421666 | controller | ok: [localhost] 2025-10-03 07:55:37.448836 | controller | 2025-10-03 07:55:37.448874 | 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-10-03 07:55:37.448890 | controller | ] *** 2025-10-03 07:55:37.448898 | controller | Friday 03 October 2025 07:55:37 +0000 (0:00:00.467) 0:00:15.406 ******** 2025-10-03 07:55:37.448912 | controller | skipping: [localhost] 2025-10-03 07:55:37.670210 | controller | 2025-10-03 07:55:37.670296 | controller | TASK [kustomize_deploy : Ensure that destination directory exists path={{ cifmw_kustomize_deploy_kustomizations_dest_dir }}, mode=0755, state=directory] *** 2025-10-03 07:55:37.670304 | controller | Friday 03 October 2025 07:55:37 +0000 (0:00:00.028) 0:00:15.434 ******** 2025-10-03 07:55:37.670325 | controller | changed: [localhost] 2025-10-03 07:55:37.756386 | controller | 2025-10-03 07:55:37.756461 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize based on its patches _cifmw_kustomize_deploy_user_kustomize={{ 2025-10-03 07:55:37.756473 | controller | _cifmw_kustomize_deploy_user_kustomize | 2025-10-03 07:55:37.756483 | controller | default({}) | 2025-10-03 07:55:37.756492 | controller | combine(item.value, recursive=True) 2025-10-03 07:55:37.756507 | controller | }}] *** 2025-10-03 07:55:37.756517 | controller | Friday 03 October 2025 07:55:37 +0000 (0:00:00.220) 0:00:15.654 ******** 2025-10-03 07:55:37.756536 | controller | ok: [localhost] => (item=cifmw_architecture_user_kustomize) 2025-10-03 07:55:37.854591 | controller | 2025-10-03 07:55:37.854651 | controller | TASK [kustomize_deploy : Set the final cifmw_architecture_user_kustomize_base64 based on its patches _cifmw_kustomize_deploy_user_base64_kustomize={{ 2025-10-03 07:55:37.854670 | controller | _b64_kustomize_user_patches | 2025-10-03 07:55:37.854679 | controller | ci_kustomize_deploy_combine_base64_patch_dict 2025-10-03 07:55:37.854688 | controller | }}] *** 2025-10-03 07:55:37.854696 | controller | Friday 03 October 2025 07:55:37 +0000 (0:00:00.086) 0:00:15.740 ******** 2025-10-03 07:55:37.854714 | controller | ok: [localhost] 2025-10-03 07:55:38.135451 | controller | 2025-10-03 07:55:38.135540 | controller | TASK [networking_mapper : Check for Networking Environment Definition file existence path={{ cifmw_networking_mapper_networking_env_def_path }}] *** 2025-10-03 07:55:38.135550 | controller | Friday 03 October 2025 07:55:37 +0000 (0:00:00.098) 0:00:15.839 ******** 2025-10-03 07:55:38.135567 | controller | ok: [localhost] 2025-10-03 07:55:38.175787 | controller | 2025-10-03 07:55:38.175944 | 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-10-03 07:55:38.175974 | controller | Friday 03 October 2025 07:55:38 +0000 (0:00:00.281) 0:00:16.120 ******** 2025-10-03 07:55:38.176009 | controller | ok: [localhost] 2025-10-03 07:55:38.524517 | controller | 2025-10-03 07:55:38.524636 | controller | TASK [networking_mapper : Load the Networking Definition from file path={{ cifmw_networking_mapper_networking_env_def_path }}] *** 2025-10-03 07:55:38.524655 | controller | Friday 03 October 2025 07:55:38 +0000 (0:00:00.040) 0:00:16.161 ******** 2025-10-03 07:55:38.524687 | controller | ok: [localhost] 2025-10-03 07:55:38.583876 | controller | 2025-10-03 07:55:38.584017 | controller | TASK [networking_mapper : Set cifmw_networking_env_definition is present cifmw_networking_env_definition={{ 2025-10-03 07:55:38.584036 | controller | _net_env_def_slurp['content'] | 2025-10-03 07:55:38.584063 | controller | b64decode | 2025-10-03 07:55:38.584077 | controller | from_yaml 2025-10-03 07:55:38.584090 | controller | }}, cacheable=True] *** 2025-10-03 07:55:38.584105 | controller | Friday 03 October 2025 07:55:38 +0000 (0:00:00.346) 0:00:16.507 ******** 2025-10-03 07:55:38.584131 | controller | ok: [localhost] 2025-10-03 07:55:38.865174 | controller | 2025-10-03 07:55:38.865285 | controller | TASK [Discover automation files paths={{ 2025-10-03 07:55:38.865297 | controller | [cifmw_architecture_repo, _automation_relative] | 2025-10-03 07:55:38.865307 | controller | path_join 2025-10-03 07:55:38.865317 | controller | }}, patterns=*.yaml] *** 2025-10-03 07:55:38.865327 | controller | Friday 03 October 2025 07:55:38 +0000 (0:00:00.061) 0:00:16.569 ******** 2025-10-03 07:55:38.865352 | controller | ok: [localhost] 2025-10-03 07:55:46.254920 | controller | 2025-10-03 07:55:46.255027 | controller | TASK [Get automation contents path={{ item.path }}] **************************** 2025-10-03 07:55:46.255041 | controller | Friday 03 October 2025 07:55:38 +0000 (0:00:00.281) 0:00:16.850 ******** 2025-10-03 07:55:46.255068 | controller | ok: [localhost] => (item=bgp-l3-xl.yaml) 2025-10-03 07:55:47.407238 | controller | ok: [localhost] => (item=bgp_dt01.yaml) 2025-10-03 07:55:47.407332 | controller | ok: [localhost] => (item=bgp_dt04_ipv6.yaml) 2025-10-03 07:55:47.407340 | controller | ok: [localhost] => (item=bmo01.yaml) 2025-10-03 07:55:47.407346 | controller | ok: [localhost] => (item=dcn.yaml) 2025-10-03 07:55:47.407352 | controller | ok: [localhost] => (item=dz-storage.yaml) 2025-10-03 07:55:47.407358 | controller | ok: [localhost] => (item=hci-adoption.yaml) 2025-10-03 07:55:47.407364 | controller | ok: [localhost] => (item=hci.yaml) 2025-10-03 07:55:47.407370 | controller | ok: [localhost] => (item=multi-namespace.yaml) 2025-10-03 07:55:47.407376 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-adoption.yaml) 2025-10-03 07:55:47.407382 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-hci.yaml) 2025-10-03 07:55:47.407388 | controller | ok: [localhost] => (item=nova-three-cells.yaml) 2025-10-03 07:55:47.407394 | controller | ok: [localhost] => (item=nova01alpha.yaml) 2025-10-03 07:55:47.407400 | controller | ok: [localhost] => (item=nova04delta-adoption.yaml) 2025-10-03 07:55:47.407406 | controller | ok: [localhost] => (item=nova04delta.yaml) 2025-10-03 07:55:47.407412 | controller | ok: [localhost] => (item=nvidia-mdev.yaml) 2025-10-03 07:55:47.407418 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough-adoption.yaml) 2025-10-03 07:55:47.407424 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough.yaml) 2025-10-03 07:55:47.407429 | controller | ok: [localhost] => (item=osasinfra-ipv6.yaml) 2025-10-03 07:55:47.407435 | controller | ok: [localhost] => (item=osasinfra.yaml) 2025-10-03 07:55:47.407441 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-2nodesets.yaml) 2025-10-03 07:55:47.407447 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-networker.yaml) 2025-10-03 07:55:47.407453 | controller | ok: [localhost] => (item=ovs-dpdk-sriov.yaml) 2025-10-03 07:55:47.407475 | controller | ok: [localhost] => (item=ovs-dpdk.yaml) 2025-10-03 07:55:47.407481 | controller | ok: [localhost] => (item=pidone.yaml) 2025-10-03 07:55:47.407487 | controller | ok: [localhost] => (item=sriov.yaml) 2025-10-03 07:55:47.407494 | controller | ok: [localhost] => (item=uni01alpha-adoption.yaml) 2025-10-03 07:55:47.407500 | controller | ok: [localhost] => (item=uni01alpha.yaml) 2025-10-03 07:55:47.407506 | controller | ok: [localhost] => (item=uni02beta-adoption.yaml) 2025-10-03 07:55:47.407511 | controller | ok: [localhost] => (item=uni02beta.yaml) 2025-10-03 07:55:47.407517 | controller | ok: [localhost] => (item=uni04delta-adoption.yaml) 2025-10-03 07:55:47.407523 | controller | ok: [localhost] => (item=uni04delta-ipv6-adoption.yaml) 2025-10-03 07:55:47.407529 | controller | ok: [localhost] => (item=uni04delta-ipv6.yaml) 2025-10-03 07:55:47.407535 | controller | ok: [localhost] => (item=uni04delta.yaml) 2025-10-03 07:55:47.407540 | controller | ok: [localhost] => (item=uni05epsilon-adoption.yaml) 2025-10-03 07:55:47.407546 | controller | ok: [localhost] => (item=uni05epsilon.yaml) 2025-10-03 07:55:47.407552 | controller | ok: [localhost] => (item=uni06zeta-adoption.yaml) 2025-10-03 07:55:47.407558 | controller | ok: [localhost] => (item=uni06zeta.yaml) 2025-10-03 07:55:47.407564 | controller | ok: [localhost] => (item=uni07eta-adoption.yaml) 2025-10-03 07:55:47.407570 | controller | ok: [localhost] => (item=uni07eta.yaml) 2025-10-03 07:55:47.407575 | controller | ok: [localhost] => (item=uni09iota.yaml) 2025-10-03 07:55:47.407581 | controller | 2025-10-03 07:55:47.407588 | controller | TASK [Load automation files as fact vas={{ 2025-10-03 07:55:47.407594 | controller | vas | default({}) | 2025-10-03 07:55:47.407600 | controller | combine(item.content | b64decode | from_yaml, recursive=true) 2025-10-03 07:55:47.407605 | controller | }}] *** 2025-10-03 07:55:47.407612 | controller | Friday 03 October 2025 07:55:46 +0000 (0:00:07.389) 0:00:24.240 ******** 2025-10-03 07:55:47.407632 | controller | ok: [localhost] => (item=bgp-l3-xl.yaml) 2025-10-03 07:55:47.446307 | controller | ok: [localhost] => (item=bgp_dt01.yaml) 2025-10-03 07:55:47.446391 | controller | ok: [localhost] => (item=bgp_dt04_ipv6.yaml) 2025-10-03 07:55:47.446406 | controller | ok: [localhost] => (item=bmo01.yaml) 2025-10-03 07:55:47.446414 | controller | ok: [localhost] => (item=dcn.yaml) 2025-10-03 07:55:47.446422 | controller | ok: [localhost] => (item=dz-storage.yaml) 2025-10-03 07:55:47.446428 | controller | ok: [localhost] => (item=hci-adoption.yaml) 2025-10-03 07:55:47.446434 | controller | ok: [localhost] => (item=hci.yaml) 2025-10-03 07:55:47.446440 | controller | ok: [localhost] => (item=multi-namespace.yaml) 2025-10-03 07:55:47.446446 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-adoption.yaml) 2025-10-03 07:55:47.446452 | controller | ok: [localhost] => (item=nfv-ovs-dpdk-sriov-hci.yaml) 2025-10-03 07:55:47.446459 | controller | ok: [localhost] => (item=nova-three-cells.yaml) 2025-10-03 07:55:47.446464 | controller | ok: [localhost] => (item=nova01alpha.yaml) 2025-10-03 07:55:47.446470 | controller | ok: [localhost] => (item=nova04delta-adoption.yaml) 2025-10-03 07:55:47.446476 | controller | ok: [localhost] => (item=nova04delta.yaml) 2025-10-03 07:55:47.446508 | controller | ok: [localhost] => (item=nvidia-mdev.yaml) 2025-10-03 07:55:47.446515 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough-adoption.yaml) 2025-10-03 07:55:47.446521 | controller | ok: [localhost] => (item=nvidia-vfio-passthrough.yaml) 2025-10-03 07:55:47.446527 | controller | ok: [localhost] => (item=osasinfra-ipv6.yaml) 2025-10-03 07:55:47.446532 | controller | ok: [localhost] => (item=osasinfra.yaml) 2025-10-03 07:55:47.446538 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-2nodesets.yaml) 2025-10-03 07:55:47.446544 | controller | ok: [localhost] => (item=ovs-dpdk-sriov-networker.yaml) 2025-10-03 07:55:47.446550 | controller | ok: [localhost] => (item=ovs-dpdk-sriov.yaml) 2025-10-03 07:55:47.446556 | controller | ok: [localhost] => (item=ovs-dpdk.yaml) 2025-10-03 07:55:47.446562 | controller | ok: [localhost] => (item=pidone.yaml) 2025-10-03 07:55:47.446568 | controller | ok: [localhost] => (item=sriov.yaml) 2025-10-03 07:55:47.446580 | controller | ok: [localhost] => (item=uni01alpha-adoption.yaml) 2025-10-03 07:55:47.446586 | controller | ok: [localhost] => (item=uni01alpha.yaml) 2025-10-03 07:55:47.446592 | controller | ok: [localhost] => (item=uni02beta-adoption.yaml) 2025-10-03 07:55:47.446598 | controller | ok: [localhost] => (item=uni02beta.yaml) 2025-10-03 07:55:47.446604 | controller | ok: [localhost] => (item=uni04delta-adoption.yaml) 2025-10-03 07:55:47.446610 | controller | ok: [localhost] => (item=uni04delta-ipv6-adoption.yaml) 2025-10-03 07:55:47.446624 | controller | ok: [localhost] => (item=uni04delta-ipv6.yaml) 2025-10-03 07:55:47.446630 | controller | ok: [localhost] => (item=uni04delta.yaml) 2025-10-03 07:55:47.446641 | controller | ok: [localhost] => (item=uni05epsilon-adoption.yaml) 2025-10-03 07:55:47.446647 | controller | ok: [localhost] => (item=uni05epsilon.yaml) 2025-10-03 07:55:47.446653 | controller | ok: [localhost] => (item=uni06zeta-adoption.yaml) 2025-10-03 07:55:47.446659 | controller | ok: [localhost] => (item=uni06zeta.yaml) 2025-10-03 07:55:47.446665 | controller | ok: [localhost] => (item=uni07eta-adoption.yaml) 2025-10-03 07:55:47.446671 | controller | ok: [localhost] => (item=uni07eta.yaml) 2025-10-03 07:55:47.446677 | controller | ok: [localhost] => (item=uni09iota.yaml) 2025-10-03 07:55:47.446683 | controller | 2025-10-03 07:55:47.446689 | controller | TASK [Prepare automation data cifmw_deploy_architecture_steps={{ vas['vas'][cifmw_architecture_scenario] }}] *** 2025-10-03 07:55:47.446695 | controller | Friday 03 October 2025 07:55:47 +0000 (0:00:01.152) 0:00:25.392 ******** 2025-10-03 07:55:47.446707 | controller | ok: [localhost] 2025-10-03 07:55:48.083732 | controller | 2025-10-03 07:55:48.083831 | controller | TASK [Create needed SSH keypairs comment={{ item.comment }}, path={{ item.path }}, type=ecdsa, size=521] *** 2025-10-03 07:55:48.083845 | controller | Friday 03 October 2025 07:55:47 +0000 (0:00:00.038) 0:00:25.431 ******** 2025-10-03 07:55:48.083868 | controller | changed: [localhost] => (item={'comment': 'Nova migration', 'path': '/home/zuul/ci-framework-data/artifacts/ecdsa_nova_migration'}) 2025-10-03 07:55:48.430789 | controller | changed: [localhost] => (item={'comment': 'EDPM deploy key', 'path': '/home/zuul/ci-framework-data/artifacts/ecdsa_deploy'}) 2025-10-03 07:55:48.430890 | controller | 2025-10-03 07:55:48.430901 | controller | TASK [Load public SSH keys path={{ item }}] ************************************ 2025-10-03 07:55:48.430909 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.637) 0:00:26.069 ******** 2025-10-03 07:55:48.430927 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_nova_migration.pub) 2025-10-03 07:55:48.787132 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_deploy.pub) 2025-10-03 07:55:48.787219 | controller | 2025-10-03 07:55:48.787228 | controller | TASK [Load private SSH keys path={{ item }}] *********************************** 2025-10-03 07:55:48.787234 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.346) 0:00:26.415 ******** 2025-10-03 07:55:48.787252 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_nova_migration) 2025-10-03 07:55:48.825908 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ecdsa_deploy) 2025-10-03 07:55:48.826002 | controller | 2025-10-03 07:55:48.826013 | controller | TASK [Generate needed facts out of local files cifmw_ci_gen_kustomize_values_ssh_authorizedkeys={{ 2025-10-03 07:55:48.826021 | controller | _pub_keys.results[1].content | b64decode 2025-10-03 07:55:48.826029 | controller | }}, cifmw_ci_gen_kustomize_values_ssh_private_key={{ 2025-10-03 07:55:48.826037 | controller | _priv_keys.results[1].content | b64decode 2025-10-03 07:55:48.826044 | controller | }}, cifmw_ci_gen_kustomize_values_ssh_public_key={{ 2025-10-03 07:55:48.826052 | controller | _pub_keys.results[1].content | b64decode 2025-10-03 07:55:48.826059 | controller | }}, cifmw_ci_gen_kustomize_values_migration_pub_key={{ 2025-10-03 07:55:48.826066 | controller | _pub_keys.results[0].content | b64decode 2025-10-03 07:55:48.826074 | controller | }}, cifmw_ci_gen_kustomize_values_migration_priv_key={{ 2025-10-03 07:55:48.826085 | controller | _priv_keys.results[0].content | b64decode 2025-10-03 07:55:48.826093 | controller | }}, cifmw_ci_gen_kustomize_values_sshd_ranges={{ 2025-10-03 07:55:48.826107 | controller | [ 2025-10-03 07:55:48.826115 | controller | cifmw_networking_env_definition.networks.ctlplane.network_v4 | default (none), 2025-10-03 07:55:48.826123 | controller | cifmw_networking_env_definition.networks.ctlplane.network_v6 | default (none) 2025-10-03 07:55:48.826131 | controller | ] | select() 2025-10-03 07:55:48.826139 | controller | }}] *** 2025-10-03 07:55:48.826146 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.355) 0:00:26.771 ******** 2025-10-03 07:55:48.826167 | controller | ok: [localhost] 2025-10-03 07:55:48.917686 | controller | 2025-10-03 07:55:48.917779 | controller | TASK [Execute deployment steps name=kustomize_deploy, tasks_from=execute_step.yml, apply={'tags': ['edpm_deploy']}] *** 2025-10-03 07:55:48.917822 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.039) 0:00:26.811 ******** 2025-10-03 07:55:48.917843 | controller | 2025-10-03 07:55:48.961527 | 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-10-03 07:55:48.961631 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.091) 0:00:26.903 ******** 2025-10-03 07:55:48.961655 | controller | ok: [localhost] => 2025-10-03 07:55:48.989435 | controller | changed: false 2025-10-03 07:55:48.989516 | controller | msg: All assertions passed 2025-10-03 07:55:48.989524 | controller | 2025-10-03 07:55:48.989531 | controller | TASK [kustomize_deploy : Check custom wait conditions that=item is match(_pattern), msg=The following custom condition is invalid: {{ item }}, quiet=True] *** 2025-10-03 07:55:48.989538 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.043) 0:00:26.946 ******** 2025-10-03 07:55:48.989555 | controller | skipping: [localhost] 2025-10-03 07:55:49.025169 | controller | 2025-10-03 07:55:49.025233 | controller | TASK [kustomize_deploy : Check builtin wait conditions that=item is match(_pattern), msg=The following builtin condition is invalid: {{ item }}, quiet=True] *** 2025-10-03 07:55:49.025244 | controller | Friday 03 October 2025 07:55:48 +0000 (0:00:00.027) 0:00:26.974 ******** 2025-10-03 07:55:49.025262 | 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-10-03 07:55:49.054313 | controller | 2025-10-03 07:55:49.054406 | controller | TASK [kustomize_deploy : Check wait_conditions validation result msg=Review and correct the faulty wait_conditions listed above.] *** 2025-10-03 07:55:49.054416 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.035) 0:00:27.010 ******** 2025-10-03 07:55:49.054438 | controller | skipping: [localhost] 2025-10-03 07:55:49.097308 | controller | 2025-10-03 07:55:49.097393 | controller | TASK [kustomize_deploy : Set stage_wait_conditions fact _wait_conditions={{ stage.wait_conditions + _custom_conditions }}] *** 2025-10-03 07:55:49.097401 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.028) 0:00:27.038 ******** 2025-10-03 07:55:49.097420 | controller | ok: [localhost] 2025-10-03 07:55:49.328258 | controller | 2025-10-03 07:55:49.328346 | controller | TASK [kustomize_deploy : Ensure source files exists path={{ 2025-10-03 07:55:49.328354 | controller | (cifmw_kustomize_deploy_architecture_repo_dest_dir, 2025-10-03 07:55:49.328360 | controller | stage['path'], item.src_file) | path_join 2025-10-03 07:55:49.328367 | controller | }}, get_attributes=False, get_checksum=False, get_mime=False] *** 2025-10-03 07:55:49.328373 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.043) 0:00:27.082 ******** 2025-10-03 07:55:49.328392 | controller | ok: [localhost] => (item={'name': 'network-values', 'src_file': 'values.yaml'}) 2025-10-03 07:55:49.392829 | controller | 2025-10-03 07:55:49.392868 | controller | TASK [kustomize_deploy : Assert source files exist that=['(item.stat is defined and item.stat.exists) or item.skipped'], quiet=True] *** 2025-10-03 07:55:49.392877 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.231) 0:00:27.313 ******** 2025-10-03 07:55:49.392889 | controller | ok: [localhost] => (item=values.yaml) 2025-10-03 07:55:49.436016 | controller | 2025-10-03 07:55:49.436058 | controller | TASK [Executing pre_stage hooks for examples/va/nvidia-vfio-passthrough/control-plane/networking/nncp name=run_hook] *** 2025-10-03 07:55:49.436066 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.064) 0:00:27.378 ******** 2025-10-03 07:55:49.436081 | controller | skipping: [localhost] 2025-10-03 07:55:49.528344 | controller | 2025-10-03 07:55:49.528434 | controller | TASK [Generate values.yaml for examples/va/nvidia-vfio-passthrough/control-plane/networking/nncp name=ci_gen_kustomize_values] *** 2025-10-03 07:55:49.528442 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.042) 0:00:27.420 ******** 2025-10-03 07:55:49.528486 | controller | 2025-10-03 07:55:49.593415 | controller | TASK [ci_gen_kustomize_values : Generate snippets files _raw_params=generate_snippets.yml] *** 2025-10-03 07:55:49.593506 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.092) 0:00:27.513 ******** 2025-10-03 07:55:49.593528 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_snippets.yml for localhost 2025-10-03 07:55:49.646357 | controller | 2025-10-03 07:55:49.646449 | 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-10-03 07:55:49.646459 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.065) 0:00:27.578 ******** 2025-10-03 07:55:49.646482 | controller | ok: [localhost] => 2025-10-03 07:55:49.858997 | controller | changed: false 2025-10-03 07:55:49.859044 | controller | msg: All assertions passed 2025-10-03 07:55:49.859054 | controller | 2025-10-03 07:55:49.859063 | 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-10-03 07:55:49.859071 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.052) 0:00:27.631 ******** 2025-10-03 07:55:49.859086 | controller | ok: [localhost] 2025-10-03 07:55:49.916711 | controller | 2025-10-03 07:55:49.916757 | 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-10-03 07:55:49.916767 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.212) 0:00:27.844 ******** 2025-10-03 07:55:49.916782 | controller | ok: [localhost] => 2025-10-03 07:55:50.112634 | controller | changed: false 2025-10-03 07:55:50.112682 | controller | msg: All assertions passed 2025-10-03 07:55:50.112691 | controller | 2025-10-03 07:55:50.112699 | controller | TASK [ci_gen_kustomize_values : Load original values file src={{ cifmw_ci_gen_kustomize_values_src_file }}] *** 2025-10-03 07:55:50.112707 | controller | Friday 03 October 2025 07:55:49 +0000 (0:00:00.057) 0:00:27.902 ******** 2025-10-03 07:55:50.112722 | controller | ok: [localhost] 2025-10-03 07:55:50.464910 | controller | 2025-10-03 07:55:50.465031 | 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-10-03 07:55:50.465043 | controller | _raw_manifests | reject('equalto', _config_map_content) 2025-10-03 07:55:50.465051 | controller | }}, _cifmw_gen_kustomize_values_base_cm_content={{ 2025-10-03 07:55:50.465059 | controller | _config_map_content | 2025-10-03 07:55:50.465067 | controller | ansible.utils.remove_keys( 2025-10-03 07:55:50.465075 | controller | target=_cifmw_gen_kustomize_values_reject_expressions, 2025-10-03 07:55:50.465082 | controller | matching_parameter='regex') 2025-10-03 07:55:50.465090 | controller | }}, cacheable=False] *** 2025-10-03 07:55:50.465097 | controller | Friday 03 October 2025 07:55:50 +0000 (0:00:00.195) 0:00:28.097 ******** 2025-10-03 07:55:50.465118 | controller | ok: [localhost] 2025-10-03 07:55:50.536138 | controller | 2025-10-03 07:55:50.536242 | controller | TASK [ci_gen_kustomize_values : Ensure we get the needed data depending on the values type _raw_params={{ _tasks }}] *** 2025-10-03 07:55:50.536250 | controller | Friday 03 October 2025 07:55:50 +0000 (0:00:00.352) 0:00:28.449 ******** 2025-10-03 07:55:50.536272 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/network_values.yml for localhost 2025-10-03 07:55:50.591292 | controller | 2025-10-03 07:55:50.591334 | controller | TASK [ci_gen_kustomize_values : Assert we have needed parameters that=['cifmw_networking_env_definition is defined']] *** 2025-10-03 07:55:50.591342 | controller | Friday 03 October 2025 07:55:50 +0000 (0:00:00.071) 0:00:28.521 ******** 2025-10-03 07:55:50.591354 | controller | ok: [localhost] => 2025-10-03 07:55:50.812983 | controller | changed: false 2025-10-03 07:55:50.813080 | controller | msg: All assertions passed 2025-10-03 07:55:50.813089 | controller | 2025-10-03 07:55:50.813096 | controller | TASK [ci_gen_kustomize_values : Ensure output directory exists path={{ snippet_datadir }}, state=directory, mode=0755] *** 2025-10-03 07:55:50.813119 | controller | Friday 03 October 2025 07:55:50 +0000 (0:00:00.055) 0:00:28.576 ******** 2025-10-03 07:55:50.813140 | controller | changed: [localhost] 2025-10-03 07:55:51.641511 | controller | 2025-10-03 07:55:51.641609 | controller | TASK [ci_gen_kustomize_values : Generate CI snippet backup=True, dest={{ 2025-10-03 07:55:51.641618 | controller | (snippet_datadir, 2025-10-03 07:55:51.641625 | controller | '02_ci_data.yaml') | path_join 2025-10-03 07:55:51.641631 | controller | }}, src={{ _tmpl_check_path | first }}, mode=0644] *** 2025-10-03 07:55:51.641637 | controller | Friday 03 October 2025 07:55:50 +0000 (0:00:00.220) 0:00:28.797 ******** 2025-10-03 07:55:51.641658 | controller | changed: [localhost] 2025-10-03 07:55:51.719160 | controller | 2025-10-03 07:55:51.719259 | 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-10-03 07:55:51.719270 | controller | Friday 03 October 2025 07:55:51 +0000 (0:00:00.828) 0:00:29.626 ******** 2025-10-03 07:55:51.719291 | controller | ok: [localhost] 2025-10-03 07:55:52.188315 | controller | 2025-10-03 07:55:52.188411 | controller | TASK [ci_gen_kustomize_values : Push base64 CI patches backup=True, dest={{ 2025-10-03 07:55:52.188422 | controller | (snippet_datadir, 2025-10-03 07:55:52.188431 | controller | '03_user_data_b64.yaml') | path_join 2025-10-03 07:55:52.188438 | controller | }}, content={{ 2025-10-03 07:55:52.188446 | controller | _base64_patch | 2025-10-03 07:55:52.188453 | controller | default({}) | 2025-10-03 07:55:52.188461 | controller | to_nice_yaml 2025-10-03 07:55:52.188469 | controller | }}, mode=0644] *** 2025-10-03 07:55:52.188477 | controller | Friday 03 October 2025 07:55:51 +0000 (0:00:00.077) 0:00:29.703 ******** 2025-10-03 07:55:52.188498 | controller | changed: [localhost] 2025-10-03 07:55:52.658577 | controller | 2025-10-03 07:55:52.658637 | controller | TASK [ci_gen_kustomize_values : Push user provided dataset backup=True, dest={{ 2025-10-03 07:55:52.658646 | controller | (snippet_datadir, 2025-10-03 07:55:52.658653 | controller | '04_user_data.yaml') | path_join 2025-10-03 07:55:52.658660 | controller | }}, content={{ 2025-10-03 07:55:52.658670 | controller | cifmw_ci_gen_kustomize_values_userdata | 2025-10-03 07:55:52.658676 | controller | default({}) | 2025-10-03 07:55:52.658687 | controller | to_nice_yaml 2025-10-03 07:55:52.658695 | controller | }}, mode=0644] *** 2025-10-03 07:55:52.658701 | controller | Friday 03 October 2025 07:55:52 +0000 (0:00:00.469) 0:00:30.173 ******** 2025-10-03 07:55:52.658714 | controller | changed: [localhost] 2025-10-03 07:55:53.172711 | controller | 2025-10-03 07:55:53.172749 | 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-10-03 07:55:53.172757 | controller | ( 2025-10-03 07:55:53.172764 | controller | snippet_datadir, 2025-10-03 07:55:53.172771 | controller | cifmw_ci_gen_kustomize_values_original_cm_content_file_name 2025-10-03 07:55:53.172777 | controller | ) | path_join 2025-10-03 07:55:53.172783 | controller | }}, mode=0644] *** 2025-10-03 07:55:53.172789 | controller | Friday 03 October 2025 07:55:52 +0000 (0:00:00.470) 0:00:30.643 ******** 2025-10-03 07:55:53.172805 | controller | changed: [localhost] 2025-10-03 07:55:53.260054 | controller | 2025-10-03 07:55:53.260096 | controller | TASK [ci_gen_kustomize_values : Generate values file _raw_params=generate_values.yml] *** 2025-10-03 07:55:53.260106 | controller | Friday 03 October 2025 07:55:53 +0000 (0:00:00.511) 0:00:31.155 ******** 2025-10-03 07:55:53.260120 | controller | included: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/ci_gen_kustomize_values/tasks/generate_values.yml for localhost 2025-10-03 07:55:53.333438 | controller | 2025-10-03 07:55:53.333483 | 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-10-03 07:55:53.333495 | controller | Friday 03 October 2025 07:55:53 +0000 (0:00:00.089) 0:00:31.245 ******** 2025-10-03 07:55:53.333511 | controller | ok: [localhost] => 2025-10-03 07:55:53.552901 | controller | changed: false 2025-10-03 07:55:53.552939 | controller | msg: All assertions passed 2025-10-03 07:55:53.552948 | controller | 2025-10-03 07:55:53.552964 | 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-10-03 07:55:53.552971 | controller | Friday 03 October 2025 07:55:53 +0000 (0:00:00.073) 0:00:31.318 ******** 2025-10-03 07:55:53.552982 | controller | ok: [localhost] 2025-10-03 07:55:53.600292 | controller | 2025-10-03 07:55:53.600332 | controller | TASK [ci_gen_kustomize_values : Ensure _content is empty _content={}] ********** 2025-10-03 07:55:53.600340 | controller | Friday 03 October 2025 07:55:53 +0000 (0:00:00.219) 0:00:31.538 ******** 2025-10-03 07:55:53.600351 | controller | ok: [localhost] 2025-10-03 07:55:54.168385 | controller | 2025-10-03 07:55:54.168473 | controller | TASK [ci_gen_kustomize_values : Load various snippet files path={{ file.path }}] *** 2025-10-03 07:55:54.168481 | controller | Friday 03 October 2025 07:55:53 +0000 (0:00:00.047) 0:00:31.585 ******** 2025-10-03 07:55:54.168500 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml) 2025-10-03 07:55:54.299475 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml) 2025-10-03 07:55:54.299521 | controller | ok: [localhost] => (item=/home/zuul/ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml) 2025-10-03 07:55:54.299532 | controller | 2025-10-03 07:55:54.299541 | controller | TASK [ci_gen_kustomize_values : Combine snippets _content={{ 2025-10-03 07:55:54.299549 | controller | _content | 2025-10-03 07:55:54.299557 | controller | default(_cifmw_gen_kustomize_values_base_cm_content, true) | 2025-10-03 07:55:54.299565 | controller | combine(_parsed, recursive=true) 2025-10-03 07:55:54.299573 | controller | }} 2025-10-03 07:55:54.299581 | controller | ] *** 2025-10-03 07:55:54.299589 | controller | Friday 03 October 2025 07:55:54 +0000 (0:00:00.568) 0:00:32.153 ******** 2025-10-03 07:55:54.299604 | controller | ok: [localhost] => (item=02_ci_data.yaml) 2025-10-03 07:55:54.544215 | controller | ok: [localhost] => (item=03_user_data_b64.yaml) 2025-10-03 07:55:54.544314 | controller | ok: [localhost] => (item=04_user_data.yaml) 2025-10-03 07:55:54.544326 | controller | 2025-10-03 07:55:54.544335 | controller | TASK [ci_gen_kustomize_values : Ensure directories exist path={{ _destdir }}, state=directory, mode=0755] *** 2025-10-03 07:55:54.544344 | controller | Friday 03 October 2025 07:55:54 +0000 (0:00:00.130) 0:00:32.284 ******** 2025-10-03 07:55:54.544368 | controller | changed: [localhost] 2025-10-03 07:55:55.106541 | controller | 2025-10-03 07:55:55.106640 | controller | TASK [ci_gen_kustomize_values : Output values file backup=True, dest={{ 2025-10-03 07:55:55.106651 | controller | (_destdir, 2025-10-03 07:55:55.106660 | controller | cifmw_ci_gen_kustomize_values_dest_filename) | path_join 2025-10-03 07:55:55.106669 | controller | }}, content={{ 2025-10-03 07:55:55.106677 | controller | ( 2025-10-03 07:55:55.106685 | controller | [ _content ] + _cifmw_gen_kustomize_values_extra_manifests 2025-10-03 07:55:55.106693 | controller | ) | cifmw.general.to_nice_yaml_all 2025-10-03 07:55:55.106702 | controller | }}, mode=0644] *** 2025-10-03 07:55:55.106710 | controller | Friday 03 October 2025 07:55:54 +0000 (0:00:00.243) 0:00:32.528 ******** 2025-10-03 07:55:55.106733 | controller | changed: [localhost] 2025-10-03 07:55:55.512708 | controller | 2025-10-03 07:55:55.512788 | controller | TASK [kustomize_deploy : Copy generated values for examples/va/nvidia-vfio-passthrough/control-plane/networking/nncp mode=0644, backup=True, remote_src=True, src={{ 2025-10-03 07:55:55.512797 | controller | (cifmw_kustomize_deploy_basedir, 2025-10-03 07:55:55.512821 | controller | 'artifacts', 'ci_gen_kustomize_values', 2025-10-03 07:55:55.512828 | controller | _val['name'], 'values.yaml') | path_join 2025-10-03 07:55:55.512836 | controller | }}, dest={{ 2025-10-03 07:55:55.512842 | controller | (cifmw_kustomize_deploy_architecture_repo_dest_dir, 2025-10-03 07:55:55.512849 | controller | stage['path'], _val.src_file 2025-10-03 07:55:55.512860 | controller | ) | 2025-10-03 07:55:55.512866 | controller | path_join 2025-10-03 07:55:55.512872 | controller | }}] *** 2025-10-03 07:55:55.512878 | controller | Friday 03 October 2025 07:55:55 +0000 (0:00:00.562) 0:00:33.091 ******** 2025-10-03 07:55:55.512898 | controller | changed: [localhost] => (item=network-values) 2025-10-03 07:55:55.570432 | controller | 2025-10-03 07:55:55.570511 | controller | TASK [kustomize_deploy : Stop before building kustomization if requested msg=Failing on demand {{ cifmw_deploy_architecture_stopper }}] *** 2025-10-03 07:55:55.570533 | controller | Friday 03 October 2025 07:55:55 +0000 (0:00:00.406) 0:00:33.497 ******** 2025-10-03 07:55:55.570551 | controller | skipping: [localhost] 2025-10-03 07:55:55.906174 | controller | 2025-10-03 07:55:55.906244 | controller | TASK [kustomize_deploy : Build kustomized content for examples/va/nvidia-vfio-passthrough/control-plane/networking/nncp chdir={{ _chdir }}, _raw_params=oc kustomize] *** 2025-10-03 07:55:55.906254 | controller | Friday 03 October 2025 07:55:55 +0000 (0:00:00.057) 0:00:33.555 ******** 2025-10-03 07:55:55.906269 | controller | task path: /home/zuul/src/github.com/openstack-k8s-operators/ci-framework/roles/kustomize_deploy/tasks/execute_step.yml:229 2025-10-03 07:55:56.016412 | controller | fatal: [localhost]: FAILED! => 2025-10-03 07:55:56.016502 | controller | changed: true 2025-10-03 07:55:56.016510 | controller | cmd: 2025-10-03 07:55:56.016516 | controller | - oc 2025-10-03 07:55:56.016522 | controller | - kustomize 2025-10-03 07:55:56.016528 | controller | delta: '0:00:00.113623' 2025-10-03 07:55:56.016534 | controller | end: '2025-10-03 07:55:55.886222' 2025-10-03 07:55:56.016541 | controller | msg: non-zero return code 2025-10-03 07:55:56.016547 | controller | rc: 1 2025-10-03 07:55:56.016553 | controller | start: '2025-10-03 07:55:55.772599' 2025-10-03 07:55:56.016560 | controller | stderr: 'error: accumulating components: accumulateDirectory: "recursed accumulation 2025-10-03 07:55:56.016566 | controller | of path ''/home/zuul/src/github.com/openstack-k8s-operators/architecture/va/nvidia-vfio-passthrough/networking/nncp'': 2025-10-03 07:55:56.016589 | controller | accumulating components: loader.New \"must build at directory: not a valid directory: 2025-10-03 07:55:56.016598 | controller | evalsymlink failure on ''/home/zuul/src/github.com/openstack-k8s-operators/lib/nncp'' 2025-10-03 07:55:56.016616 | controller | : lstat /home/zuul/src/github.com/openstack-k8s-operators/lib: no such file or directory\""' 2025-10-03 07:55:56.016767 | controller | stderr_lines: 2025-10-03 07:55:56.016775 | controller | - 'error: accumulating components: accumulateDirectory: "recursed accumulation of 2025-10-03 07:55:56.016782 | controller | path ''/home/zuul/src/github.com/openstack-k8s-operators/architecture/va/nvidia-vfio-passthrough/networking/nncp'': 2025-10-03 07:55:56.016788 | controller | accumulating components: loader.New \"must build at directory: not a valid directory: 2025-10-03 07:55:56.016794 | controller | evalsymlink failure on ''/home/zuul/src/github.com/openstack-k8s-operators/lib/nncp'' 2025-10-03 07:55:56.016818 | controller | : lstat /home/zuul/src/github.com/openstack-k8s-operators/lib: no such file or directory\""' 2025-10-03 07:55:56.016824 | controller | stdout: '' 2025-10-03 07:55:56.016830 | controller | stdout_lines: [] 2025-10-03 07:55:56.016839 | controller | 2025-10-03 07:55:56.016846 | controller | NO MORE HOSTS LEFT ************************************************************* 2025-10-03 07:55:56.016852 | controller | 2025-10-03 07:55:56.016858 | controller | PLAY RECAP ********************************************************************* 2025-10-03 07:55:56.016864 | controller | localhost : ok=58 changed=16 unreachable=0 failed=1 skipped=15 rescued=0 ignored=0 2025-10-03 07:55:56.016870 | controller | 2025-10-03 07:55:56.016876 | controller | Friday 03 October 2025 07:55:55 +0000 (0:00:00.336) 0:00:33.891 ******** 2025-10-03 07:55:56.016882 | controller | =============================================================================== 2025-10-03 07:55:56.016888 | controller | Get automation contents ------------------------------------------------- 7.39s 2025-10-03 07:55:56.016894 | controller | ci_setup : Install openshift client ------------------------------------- 5.15s 2025-10-03 07:55:56.016899 | controller | ci_setup : Install needed packages -------------------------------------- 5.13s 2025-10-03 07:55:56.016905 | controller | Load automation files as fact ------------------------------------------- 1.15s 2025-10-03 07:55:56.016911 | controller | ci_setup : Manage directories ------------------------------------------- 1.05s 2025-10-03 07:55:56.016918 | controller | Gathering Facts --------------------------------------------------------- 0.96s 2025-10-03 07:55:56.016927 | controller | ci_gen_kustomize_values : Generate CI snippet --------------------------- 0.83s 2025-10-03 07:55:56.016958 | controller | Create needed SSH keypairs ---------------------------------------------- 0.64s 2025-10-03 07:55:56.016968 | controller | ci_gen_kustomize_values : Load various snippet files -------------------- 0.57s 2025-10-03 07:55:56.016975 | controller | ci_gen_kustomize_values : Output values file ---------------------------- 0.56s 2025-10-03 07:55:56.016982 | controller | ci_gen_kustomize_values : Copy the base values.yaml --------------------- 0.51s 2025-10-03 07:55:56.016988 | controller | ci_gen_kustomize_values : Push user provided dataset -------------------- 0.47s 2025-10-03 07:55:56.016993 | controller | ci_gen_kustomize_values : Push base64 CI patches ------------------------ 0.47s 2025-10-03 07:55:56.016999 | controller | kustomize_deploy : Gather the list of scenario folders ------------------ 0.47s 2025-10-03 07:55:56.017005 | controller | ci_setup : Source completion from within .bashrc ------------------------ 0.41s 2025-10-03 07:55:56.017011 | controller | kustomize_deploy : Copy generated values for examples/va/nvidia-vfio-passthrough/control-plane/networking/nncp --- 0.41s 2025-10-03 07:55:56.017017 | controller | ci_setup : Ensure openshift client install path is present -------------- 0.39s 2025-10-03 07:55:56.017023 | controller | Load private SSH keys --------------------------------------------------- 0.36s 2025-10-03 07:55:56.017028 | controller | Create needed directories ----------------------------------------------- 0.35s 2025-10-03 07:55:56.017034 | controller | ci_gen_kustomize_values : Expose common data for future usage ----------- 0.35s 2025-10-03 07:55:56.494964 | controller | ERROR 2025-10-03 07:55:56.495169 | controller | { 2025-10-03 07:55:56.495229 | controller | "delta": "0:00:34.671129", 2025-10-03 07:55:56.495271 | controller | "end": "2025-10-03 07:55:56.017592", 2025-10-03 07:55:56.495309 | controller | "msg": "non-zero return code", 2025-10-03 07:55:56.495345 | controller | "rc": 2, 2025-10-03 07:55:56.495381 | controller | "start": "2025-10-03 07:55:21.346463" 2025-10-03 07:55:56.495452 | controller | } failure 2025-10-03 07:55:56.504430 | 2025-10-03 07:55:56.504531 | PLAY RECAP 2025-10-03 07:55:56.504605 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-10-03 07:55:56.504649 | 2025-10-03 07:55:56.614211 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/architecture/run.yml@main] 2025-10-03 07:55:56.616038 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-03 07:55:57.218460 | 2025-10-03 07:55:57.218566 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-03 07:55:57.239264 | 2025-10-03 07:55:57.239355 | TASK [Filter out host if needed] 2025-10-03 07:55:57.248065 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-03 07:55:57.252576 | 2025-10-03 07:55:57.252640 | TASK [Ensure file is present] 2025-10-03 07:55:57.684974 | controller | ok 2025-10-03 07:55:57.704173 | 2025-10-03 07:55:57.704310 | TASK [Manage molecule report file] 2025-10-03 07:55:58.234327 | controller | skipping: Conditional result was False 2025-10-03 07:55:58.240113 | 2025-10-03 07:55:58.240197 | TASK [Check if we get ci-framework-data basedir] 2025-10-03 07:55:58.535081 | controller | ok 2025-10-03 07:55:58.552383 | 2025-10-03 07:55:58.552560 | TASK [Create ci-framework-data log directory for zuul] 2025-10-03 07:55:58.949052 | controller | changed 2025-10-03 07:55:58.963587 | 2025-10-03 07:55:58.963784 | TASK [Copy ci-framework interesting files] 2025-10-03 07:55:59.428117 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-03 07:55:59.513087 | controller | changed 2025-10-03 07:55:59.520198 | 2025-10-03 07:55:59.520287 | TASK [Get SELinux listing] 2025-10-03 07:56:00.060055 | controller | changed 2025-10-03 07:56:00.073928 | 2025-10-03 07:56:00.074077 | TASK [Generate log index] 2025-10-03 07:56:01.065278 | controller | changed 2025-10-03 07:56:01.070994 | 2025-10-03 07:56:01.071058 | TASK [Get some env related data] 2025-10-03 07:56:01.812606 | controller | /home/zuul/.local/bin/ansible 2025-10-03 07:56:02.627960 | controller | changed 2025-10-03 07:56:02.634779 | 2025-10-03 07:56:02.634862 | TASK [Generate list of logs to collect in home directory] 2025-10-03 07:56:03.028442 | controller | ok: All paths examined 2025-10-03 07:56:03.049776 | 2025-10-03 07:56:03.049917 | LOOP [Copy logs from home directory] 2025-10-03 07:56:03.538085 | controller | changed: 2025-10-03 07:56:03.544695 | controller | { 2025-10-03 07:56:03.544812 | controller | "atime": 1759478099.369298, 2025-10-03 07:56:03.544863 | controller | "ctime": 1759478155.9050622, 2025-10-03 07:56:03.544901 | controller | "dev": 64513, 2025-10-03 07:56:03.544937 | controller | "gid": 1000, 2025-10-03 07:56:03.544972 | controller | "gr_name": "zuul", 2025-10-03 07:56:03.545009 | controller | "inode": 4453351, 2025-10-03 07:56:03.545044 | controller | "isblk": false, 2025-10-03 07:56:03.545079 | controller | "ischr": false, 2025-10-03 07:56:03.545113 | controller | "isdir": false, 2025-10-03 07:56:03.545146 | controller | "isfifo": false, 2025-10-03 07:56:03.545193 | controller | "isgid": false, 2025-10-03 07:56:03.545228 | controller | "islnk": false, 2025-10-03 07:56:03.545261 | controller | "isreg": true, 2025-10-03 07:56:03.545294 | controller | "issock": false, 2025-10-03 07:56:03.545327 | controller | "isuid": false, 2025-10-03 07:56:03.545360 | controller | "mode": "0644", 2025-10-03 07:56:03.545392 | controller | "mtime": 1759478155.9050622, 2025-10-03 07:56:03.545425 | controller | "nlink": 1, 2025-10-03 07:56:03.545460 | controller | "path": "/home/zuul/ansible.log", 2025-10-03 07:56:03.545497 | controller | "pw_name": "zuul", 2025-10-03 07:56:03.545533 | controller | "rgrp": true, 2025-10-03 07:56:03.545568 | controller | "roth": true, 2025-10-03 07:56:03.545602 | controller | "rusr": true, 2025-10-03 07:56:03.545637 | controller | "size": 54550, 2025-10-03 07:56:03.545707 | controller | "uid": 1000, 2025-10-03 07:56:03.545747 | controller | "wgrp": false, 2025-10-03 07:56:03.545781 | controller | "woth": false, 2025-10-03 07:56:03.545821 | controller | "wusr": true, 2025-10-03 07:56:03.545858 | controller | "xgrp": false, 2025-10-03 07:56:03.545893 | controller | "xoth": false, 2025-10-03 07:56:03.545927 | controller | "xusr": false 2025-10-03 07:56:03.545960 | controller | } 2025-10-03 07:56:03.561362 | 2025-10-03 07:56:03.561551 | TASK [Copy crio stats log file] 2025-10-03 07:56:03.591025 | controller | skipping: Conditional result was False 2025-10-03 07:56:03.604009 | 2025-10-03 07:56:03.604170 | TASK [Get SELinux related data] 2025-10-03 07:56:03.926975 | controller | 2025-10-03 07:56:04.159708 | controller | ERROR 2025-10-03 07:56:04.159980 | controller | { 2025-10-03 07:56:04.160039 | controller | "delta": "0:00:00.023145", 2025-10-03 07:56:04.160082 | controller | "end": "2025-10-03 07:56:03.929323", 2025-10-03 07:56:04.160119 | controller | "msg": "non-zero return code", 2025-10-03 07:56:04.160155 | controller | "rc": 1, 2025-10-03 07:56:04.160192 | controller | "start": "2025-10-03 07:56:03.906178" 2025-10-03 07:56:04.160226 | controller | } 2025-10-03 07:56:04.160273 | controller | ERROR: Ignoring Errors 2025-10-03 07:56:04.172441 | 2025-10-03 07:56:04.172575 | TASK [Create system configuration directory] 2025-10-03 07:56:04.467910 | controller | changed 2025-10-03 07:56:04.472910 | 2025-10-03 07:56:04.472970 | TASK [Get some of the system configurations] 2025-10-03 07:56:05.001378 | controller | changed 2025-10-03 07:56:05.012617 | 2025-10-03 07:56:05.012780 | TASK [Copy generated documentation if available] 2025-10-03 07:56:05.049157 | controller | skipping: Conditional result was False 2025-10-03 07:56:05.061272 | 2025-10-03 07:56:05.061406 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-03 07:56:05.087900 | controller | skipping: Conditional result was False 2025-10-03 07:56:05.100259 | 2025-10-03 07:56:05.100408 | TASK [Compress logs bigger than 2MB] 2025-10-03 07:56:05.649232 | controller | changed 2025-10-03 07:56:05.654904 | 2025-10-03 07:56:05.654971 | TASK [Copy files from workspace on node] 2025-10-03 07:56:05.674207 | controller | ok 2025-10-03 07:56:05.696860 | 2025-10-03 07:56:05.696928 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-03 07:56:05.731127 | controller | skipping: Conditional result was False 2025-10-03 07:56:05.739440 | 2025-10-03 07:56:05.739527 | TASK [fetch-output : Set log path for single node] 2025-10-03 07:56:05.781067 | controller | ok 2025-10-03 07:56:05.788347 | 2025-10-03 07:56:05.788431 | LOOP [fetch-output : Ensure local output dirs] 2025-10-03 07:56:06.038875 | controller -> localhost | ok: "/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/logs" 2025-10-03 07:56:06.039116 | controller -> localhost | changed: All items complete 2025-10-03 07:56:06.039146 | 2025-10-03 07:56:06.248067 | controller -> localhost | changed: "/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/artifacts" 2025-10-03 07:56:06.446643 | controller -> localhost | changed: "/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/docs" 2025-10-03 07:56:06.459422 | 2025-10-03 07:56:06.459534 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-03 07:56:07.121327 | controller | changed: 2025-10-03 07:56:07.132324 | controller | .d..t...... ./ 2025-10-03 07:56:07.132420 | controller | >f+++++++++ README.html 2025-10-03 07:56:07.132470 | controller | >f+++++++++ ansible.log 2025-10-03 07:56:07.132516 | controller | >f+++++++++ dmesg.log 2025-10-03 07:56:07.132580 | controller | >f+++++++++ installed-pkgs.log 2025-10-03 07:56:07.132624 | controller | >f+++++++++ python.log 2025-10-03 07:56:07.132699 | controller | >f+++++++++ registries.conf 2025-10-03 07:56:07.132756 | controller | >f+++++++++ selinux-denials.log 2025-10-03 07:56:07.132800 | controller | >f+++++++++ selinux-listing.log 2025-10-03 07:56:07.132847 | controller | cd+++++++++ ci-framework-data/ 2025-10-03 07:56:07.132889 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-03 07:56:07.132932 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_deploy 2025-10-03 07:56:07.132974 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_deploy.pub 2025-10-03 07:56:07.133015 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_nova_migration 2025-10-03 07:56:07.133055 | controller | >f+++++++++ ci-framework-data/artifacts/ecdsa_nova_migration.pub 2025-10-03 07:56:07.133093 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-03 07:56:07.133133 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/ 2025-10-03 07:56:07.133172 | controller | cd+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/ 2025-10-03 07:56:07.133211 | controller | >f+++++++++ ci-framework-data/artifacts/ci_gen_kustomize_values/network-values/values.yaml 2025-10-03 07:56:07.133250 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/ 2025-10-03 07:56:07.133289 | controller | cd+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/ 2025-10-03 07:56:07.133328 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/01_original.yaml 2025-10-03 07:56:07.133367 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/02_ci_data.yaml 2025-10-03 07:56:07.133406 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/03_user_data_b64.yaml 2025-10-03 07:56:07.133446 | controller | >f+++++++++ ci-framework-data/artifacts/ci_k8s_snippets/network-values/04_user_data.yaml 2025-10-03 07:56:07.133487 | controller | cd+++++++++ ci-framework-data/artifacts/kustomize_deploy/ 2025-10-03 07:56:07.133528 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/ 2025-10-03 07:56:07.133569 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/ 2025-10-03 07:56:07.133609 | controller | cd+++++++++ ci-framework-data/artifacts/manifests/openstack/cr/ 2025-10-03 07:56:07.133649 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-03 07:56:07.133735 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-03 07:56:07.133778 | controller | cd+++++++++ ci-framework-data/logs/ 2025-10-03 07:56:07.133818 | controller | cd+++++++++ registries.conf.d/ 2025-10-03 07:56:07.133857 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-03 07:56:07.133896 | controller | cd+++++++++ system-config/ 2025-10-03 07:56:07.133935 | controller | cd+++++++++ system-config/libvirt/ 2025-10-03 07:56:07.133975 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-03 07:56:07.134013 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-03 07:56:07.684974 | controller | changed: .d..t...... ./ 2025-10-03 07:56:08.144836 | controller | changed: .d..t...... ./ 2025-10-03 07:56:08.171980 | 2025-10-03 07:56:08.172171 | TASK [Return artifact to Zuul] 2025-10-03 07:56:08.199212 | controller | skipping: Conditional result was False 2025-10-03 07:56:08.227606 | 2025-10-03 07:56:08.227765 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-03 07:56:08.227896 | 2025-10-03 07:56:08.227932 | PLAY RECAP 2025-10-03 07:56:08.227981 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-10-03 07:56:08.228008 | 2025-10-03 07:56:08.347268 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-03 07:56:08.348414 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-03 07:56:08.929214 | 2025-10-03 07:56:08.929345 | PLAY [all] 2025-10-03 07:56:08.948768 | 2025-10-03 07:56:08.948879 | TASK [include_role : fetch-output] 2025-10-03 07:56:08.978835 | controller | ok 2025-10-03 07:56:08.996421 | 2025-10-03 07:56:08.996504 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-03 07:56:09.041109 | controller | skipping: Conditional result was False 2025-10-03 07:56:09.048907 | 2025-10-03 07:56:09.048999 | TASK [fetch-output : Set log path for single node] 2025-10-03 07:56:09.081573 | controller | ok 2025-10-03 07:56:09.088444 | 2025-10-03 07:56:09.088530 | LOOP [fetch-output : Ensure local output dirs] 2025-10-03 07:56:09.481357 | controller -> localhost | ok: "/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/logs" 2025-10-03 07:56:09.697362 | controller -> localhost | ok: "/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/artifacts" 2025-10-03 07:56:09.959162 | controller -> localhost | ok: "/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/docs" 2025-10-03 07:56:09.969259 | 2025-10-03 07:56:09.969374 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-03 07:56:10.615835 | controller | ok 2025-10-03 07:56:10.616409 | controller | ok: All items complete 2025-10-03 07:56:10.616490 | 2025-10-03 07:56:11.127296 | controller | ok 2025-10-03 07:56:11.616155 | controller | ok 2025-10-03 07:56:11.650427 | 2025-10-03 07:56:11.650570 | TASK [include_role : fetch-output-openshift] 2025-10-03 07:56:11.665503 | controller | skipping: Conditional result was False 2025-10-03 07:56:11.673370 | 2025-10-03 07:56:11.673459 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-03 07:56:12.091973 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014730 2025-10-03 07:56:12.329803 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007199 2025-10-03 07:56:12.359098 | 2025-10-03 07:56:12.359253 | PLAY [all] 2025-10-03 07:56:12.373436 | 2025-10-03 07:56:12.373499 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-03 07:56:12.876568 | controller | changed 2025-10-03 07:56:12.908962 | 2025-10-03 07:56:12.909053 | PLAY RECAP 2025-10-03 07:56:12.909107 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-03 07:56:12.909135 | 2025-10-03 07:56:13.005801 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-03 07:56:13.006765 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-03 07:56:13.696910 | 2025-10-03 07:56:13.697019 | PLAY [localhost] 2025-10-03 07:56:13.715377 | 2025-10-03 07:56:13.715476 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-03 07:56:14.088510 | localhost | changed 2025-10-03 07:56:14.093024 | 2025-10-03 07:56:14.093158 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-03 07:56:14.136315 | localhost | ok 2025-10-03 07:56:14.156000 | 2025-10-03 07:56:14.156126 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-03 07:56:14.579384 | localhost | changed 2025-10-03 07:56:14.589835 | 2025-10-03 07:56:14.589978 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-03 07:56:15.349648 | localhost | changed 2025-10-03 07:56:15.362146 | 2025-10-03 07:56:15.362282 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-03 07:56:15.847774 | localhost | Identity added: /var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/tmp/ansible.67swjce8 (/var/lib/zuul/builds/5f192751283a40b09616edcf44fb77e5/work/tmp/ansible.67swjce8) 2025-10-03 07:56:15.848114 | localhost | ok: Runtime: 0:00:00.013718 2025-10-03 07:56:15.858064 | 2025-10-03 07:56:15.858200 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-03 07:56:16.182732 | localhost | ok: Runtime: 0:00:00.008455 2025-10-03 07:56:16.194388 | 2025-10-03 07:56:16.194523 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-03 07:56:16.283464 | localhost | changed 2025-10-03 07:56:16.293375 | 2025-10-03 07:56:16.293516 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-03 07:56:16.750212 | localhost | changed 2025-10-03 07:56:16.799289 | 2025-10-03 07:56:16.799417 | PLAY [localhost] 2025-10-03 07:56:16.820053 | 2025-10-03 07:56:16.820134 | TASK [Generate bulk log download script] 2025-10-03 07:56:16.840159 | localhost | ok 2025-10-03 07:56:16.856381 | 2025-10-03 07:56:16.856471 | TASK [local-log-download : Check API endpoint is defined] 2025-10-03 07:56:16.886827 | localhost | ok: All assertions passed 2025-10-03 07:56:16.893016 | 2025-10-03 07:56:16.893109 | TASK [local-log-download : Create download script] 2025-10-03 07:56:17.374951 | localhost -> localhost | changed 2025-10-03 07:56:17.395639 | 2025-10-03 07:56:17.395928 | TASK [Register quick-download link] 2025-10-03 07:56:17.423312 | localhost | ok 2025-10-03 07:56:17.479008 | 2025-10-03 07:56:17.479124 | PLAY [logserver.rdoproject.org] 2025-10-03 07:56:17.492092 | 2025-10-03 07:56:17.492168 | TASK [Set zuul-log-path fact] 2025-10-03 07:56:17.513425 | logserver.rdoproject.org | ok 2025-10-03 07:56:17.524954 | 2025-10-03 07:56:17.525036 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 07:56:17.564282 | logserver.rdoproject.org | ok 2025-10-03 07:56:17.571166 | 2025-10-03 07:56:17.571251 | TASK [upload-logs : Create log directories] 2025-10-03 07:56:18.290217 | logserver.rdoproject.org | changed 2025-10-03 07:56:18.297796 | 2025-10-03 07:56:18.297927 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-03 07:56:18.622580 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.009529 2025-10-03 07:56:18.627343 | 2025-10-03 07:56:18.627411 | TASK [upload-logs : Upload logs to log server] 2025-10-03 07:56:19.288294 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-03 07:56:19.292131 | 2025-10-03 07:56:19.292216 | LOOP [upload-logs : Compress console log and json output] 2025-10-03 07:56:19.344756 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:19.357254 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:19.363681 | 2025-10-03 07:56:19.363803 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-03 07:56:19.403981 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:19.404265 | 2025-10-03 07:56:19.407493 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-03 07:56:19.413210 | 2025-10-03 07:56:19.413309 | LOOP [upload-logs : Upload console log and json output]