2025-10-08 05:38:35.872429 | Job console starting... 2025-10-08 05:38:35.890215 | Updating repositories 2025-10-08 05:38:35.987731 | Preparing job workspace 2025-10-08 05:38:45.731396 | Running Ansible setup... 2025-10-08 05:38:53.399220 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-08 05:38:53.974592 | 2025-10-08 05:38:53.974718 | PLAY [localhost] 2025-10-08 05:38:53.983037 | 2025-10-08 05:38:53.983103 | TASK [Gathering Facts] 2025-10-08 05:38:54.909619 | localhost | ok 2025-10-08 05:38:54.922314 | 2025-10-08 05:38:54.922404 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-08 05:38:55.363774 | localhost -> localhost | changed 2025-10-08 05:38:55.369307 | 2025-10-08 05:38:55.369375 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-08 05:38:56.195286 | localhost -> localhost | changed 2025-10-08 05:38:56.203753 | 2025-10-08 05:38:56.203820 | TASK [Setup log path fact] 2025-10-08 05:38:56.222299 | localhost | ok 2025-10-08 05:38:56.233828 | 2025-10-08 05:38:56.233894 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-08 05:38:56.261466 | localhost | ok 2025-10-08 05:38:56.268850 | 2025-10-08 05:38:56.268913 | TASK [emit-job-header : Print job information] 2025-10-08 05:38:56.306665 | # Job Information 2025-10-08 05:38:56.306800 | Ansible Version: 2.15.12 2025-10-08 05:38:56.306825 | Job: cifmw-multinode-kuttl 2025-10-08 05:38:56.306844 | Pipeline: github-check 2025-10-08 05:38:56.306862 | Executor: ze04.softwarefactory-project.io 2025-10-08 05:38:56.306879 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237 2025-10-08 05:38:56.306898 | Log URL (when completed): https://logserver.rdoproject.org/fee/rdoproject.org/feeb159bff734b26baca9ae077db1cb8/ 2025-10-08 05:38:56.306916 | Event ID: 920c7930-a408-11f0-96e0-244f77bacc6d 2025-10-08 05:38:56.310375 | 2025-10-08 05:38:56.310443 | LOOP [emit-job-header : Print node information] 2025-10-08 05:38:56.414865 | localhost | ok: 2025-10-08 05:38:56.415258 | localhost | # Node Information 2025-10-08 05:38:56.415319 | localhost | Inventory Hostname: controller 2025-10-08 05:38:56.415369 | localhost | Hostname: np0005475227 2025-10-08 05:38:56.415410 | localhost | Username: zuul 2025-10-08 05:38:56.415455 | localhost | Distro: CentOS 9 2025-10-08 05:38:56.415495 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-08 05:38:56.415533 | localhost | Region: RegionOne 2025-10-08 05:38:56.415570 | localhost | Label: cloud-centos-9-stream-tripleo-medium 2025-10-08 05:38:56.415606 | localhost | Product Name: OpenStack Nova 2025-10-08 05:38:56.415643 | localhost | Interface IP: 38.102.83.94 2025-10-08 05:38:56.489558 | localhost | ok: 2025-10-08 05:38:56.489742 | localhost | # Node Information 2025-10-08 05:38:56.489807 | localhost | Inventory Hostname: crc 2025-10-08 05:38:56.489851 | localhost | Hostname: crc 2025-10-08 05:38:56.489888 | localhost | Username: core 2025-10-08 05:38:56.489923 | localhost | Distro: RedHat 4.18 2025-10-08 05:38:56.489959 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-08 05:38:56.489994 | localhost | Region: RegionOne 2025-10-08 05:38:56.490029 | localhost | Label: crc-cloud-ocp-4-18-1-3xl 2025-10-08 05:38:56.490064 | localhost | Product Name: OpenStack Nova 2025-10-08 05:38:56.490098 | localhost | Interface IP: 38.102.83.50 2025-10-08 05:38:56.529177 | 2025-10-08 05:38:56.529371 | PLAY [all] 2025-10-08 05:38:56.538972 | 2025-10-08 05:38:56.539054 | TASK [Gather network facts] 2025-10-08 05:38:57.044064 | controller | ok 2025-10-08 05:38:57.216812 | crc | ok 2025-10-08 05:38:57.265032 | 2025-10-08 05:38:57.265116 | TASK [include_role : start-zuul-console] 2025-10-08 05:38:57.291610 | controller | ok 2025-10-08 05:38:57.317578 | crc | ok 2025-10-08 05:38:57.335293 | 2025-10-08 05:38:57.335358 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-08 05:38:57.728997 | controller | ok 2025-10-08 05:38:57.745919 | crc | ok 2025-10-08 05:38:57.759391 | 2025-10-08 05:38:57.759451 | TASK [include_role : add-build-sshkey] 2025-10-08 05:38:57.788447 | controller | ok 2025-10-08 05:38:57.793621 | crc | ok 2025-10-08 05:38:57.813137 | 2025-10-08 05:38:57.813202 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-08 05:38:58.040053 | controller -> localhost | ok 2025-10-08 05:38:58.054793 | 2025-10-08 05:38:58.054864 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-08 05:38:58.080994 | controller | ok 2025-10-08 05:38:58.096831 | crc | ok 2025-10-08 05:38:58.114555 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-08 05:38:58.114608 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-08 05:38:58.150313 | 2025-10-08 05:38:58.150428 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-08 05:38:58.570768 | controller -> localhost | Generating public/private rsa key pair. 2025-10-08 05:38:58.570984 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/feeb159bff734b26baca9ae077db1cb8_id_rsa. 2025-10-08 05:38:58.571012 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/feeb159bff734b26baca9ae077db1cb8_id_rsa.pub. 2025-10-08 05:38:58.571034 | controller -> localhost | The key fingerprint is: 2025-10-08 05:38:58.571053 | controller -> localhost | SHA256:i8h78IQzZgvFxllxTzyK5poqJVaZU+5Tu3gA+IRFoP4 zuul-build-sshkey 2025-10-08 05:38:58.571072 | controller -> localhost | The key's randomart image is: 2025-10-08 05:38:58.571091 | controller -> localhost | +---[RSA 3072]----+ 2025-10-08 05:38:58.571109 | controller -> localhost | | .o. ..... | 2025-10-08 05:38:58.571128 | controller -> localhost | |. . ... oo | 2025-10-08 05:38:58.571146 | controller -> localhost | |. +o=o . ... | 2025-10-08 05:38:58.571164 | controller -> localhost | |.o B*.o.. | 2025-10-08 05:38:58.571182 | controller -> localhost | | .+o++. S | 2025-10-08 05:38:58.571200 | controller -> localhost | |..+oB=oo . | 2025-10-08 05:38:58.571217 | controller -> localhost | |.o EoX= o | 2025-10-08 05:38:58.571235 | controller -> localhost | |. +ooo | 2025-10-08 05:38:58.571252 | controller -> localhost | | ...... | 2025-10-08 05:38:58.571269 | controller -> localhost | +----[SHA256]-----+ 2025-10-08 05:38:58.571314 | controller -> localhost | ok: Runtime: 0:00:00.069875 2025-10-08 05:38:58.577206 | 2025-10-08 05:38:58.577271 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-08 05:38:58.608481 | controller | ok 2025-10-08 05:38:58.613818 | crc | ok 2025-10-08 05:38:58.632416 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-08 05:38:58.632481 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-08 05:38:58.643691 | 2025-10-08 05:38:58.643755 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-08 05:38:58.668990 | controller | skipping: Conditional result was False 2025-10-08 05:38:58.679758 | crc | skipping: Conditional result was False 2025-10-08 05:38:58.686311 | 2025-10-08 05:38:58.686373 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-08 05:38:59.081377 | controller | changed 2025-10-08 05:38:59.220283 | crc | changed 2025-10-08 05:38:59.225924 | 2025-10-08 05:38:59.225986 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-08 05:38:59.487500 | controller | ok 2025-10-08 05:38:59.524404 | crc | ok 2025-10-08 05:38:59.535793 | 2025-10-08 05:38:59.535889 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-08 05:39:00.225219 | controller | changed 2025-10-08 05:39:00.515843 | crc | changed 2025-10-08 05:39:00.527554 | 2025-10-08 05:39:00.527779 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-08 05:39:01.238751 | controller | changed 2025-10-08 05:39:01.419106 | crc | changed 2025-10-08 05:39:01.427529 | 2025-10-08 05:39:01.427593 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-08 05:39:01.457651 | controller | skipping: Conditional result was False 2025-10-08 05:39:01.468387 | crc | skipping: Conditional result was False 2025-10-08 05:39:01.473858 | 2025-10-08 05:39:01.473919 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-08 05:39:01.801042 | controller -> localhost | changed 2025-10-08 05:39:01.822478 | 2025-10-08 05:39:01.822557 | TASK [add-build-sshkey : Add back temp key] 2025-10-08 05:39:02.079780 | controller -> localhost | Identity added: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/feeb159bff734b26baca9ae077db1cb8_id_rsa (zuul-build-sshkey) 2025-10-08 05:39:02.080022 | controller -> localhost | ok: Runtime: 0:00:00.009444 2025-10-08 05:39:02.085829 | 2025-10-08 05:39:02.085893 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-08 05:39:02.442974 | controller | ok 2025-10-08 05:39:02.468767 | crc | ok 2025-10-08 05:39:02.473366 | 2025-10-08 05:39:02.473426 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-08 05:39:02.498166 | controller | skipping: Conditional result was False 2025-10-08 05:39:02.508885 | crc | skipping: Conditional result was False 2025-10-08 05:39:02.523756 | 2025-10-08 05:39:02.523820 | TASK [include_role : validate-host] 2025-10-08 05:39:02.543872 | controller | ok 2025-10-08 05:39:02.560628 | crc | ok 2025-10-08 05:39:02.585874 | 2025-10-08 05:39:02.585996 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-08 05:39:02.616156 | controller | ok 2025-10-08 05:39:02.621892 | crc | ok 2025-10-08 05:39:02.626400 | 2025-10-08 05:39:02.626463 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-08 05:39:02.853036 | controller -> localhost | ok 2025-10-08 05:39:02.859129 | 2025-10-08 05:39:02.859192 | TASK [validate-host : Collect information about the host] 2025-10-08 05:39:03.591853 | controller | ok 2025-10-08 05:39:03.902132 | crc | ok 2025-10-08 05:39:03.914438 | 2025-10-08 05:39:03.914503 | TASK [validate-host : Sanitize hostname] 2025-10-08 05:39:03.954525 | controller | ok 2025-10-08 05:39:03.990251 | crc | ok 2025-10-08 05:39:03.995497 | 2025-10-08 05:39:03.995560 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-08 05:39:04.404763 | controller -> localhost | changed 2025-10-08 05:39:04.436945 | crc -> localhost | changed 2025-10-08 05:39:04.442372 | 2025-10-08 05:39:04.442435 | TASK [validate-host : Collect information about zuul worker] 2025-10-08 05:39:04.910965 | crc | ok 2025-10-08 05:39:04.920319 | controller | ok 2025-10-08 05:39:04.930402 | 2025-10-08 05:39:04.930549 | TASK [validate-host : Write out all zuul information for each host] 2025-10-08 05:39:05.413038 | controller -> localhost | changed 2025-10-08 05:39:05.475552 | crc -> localhost | changed 2025-10-08 05:39:05.504203 | 2025-10-08 05:39:05.504288 | TASK [include_role : prepare-workspace-openshift] 2025-10-08 05:39:05.519113 | controller | skipping: Conditional result was False 2025-10-08 05:39:05.526038 | 2025-10-08 05:39:05.526126 | TASK [include_role : remove-zuul-sshkey] 2025-10-08 05:39:05.540649 | controller | skipping: Conditional result was False 2025-10-08 05:39:05.548142 | 2025-10-08 05:39:05.548228 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-08 05:39:05.834942 | controller | ok: "logs" 2025-10-08 05:39:05.835362 | controller | ok: All items complete 2025-10-08 05:39:05.835422 | 2025-10-08 05:39:05.851462 | crc | ok: "logs" 2025-10-08 05:39:06.047260 | controller | ok: "artifacts" 2025-10-08 05:39:06.101132 | crc | ok: "artifacts" 2025-10-08 05:39:06.268303 | controller | ok: "docs" 2025-10-08 05:39:06.365264 | crc | ok: "docs" 2025-10-08 05:39:06.388788 | 2025-10-08 05:39:06.389052 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-08 05:39:06.670219 | controller | changed: "logs" 2025-10-08 05:39:06.670502 | controller | ok: All items complete 2025-10-08 05:39:06.670546 | 2025-10-08 05:39:06.745863 | crc | changed: "logs" 2025-10-08 05:39:06.886436 | controller | changed: "artifacts" 2025-10-08 05:39:06.989873 | crc | changed: "artifacts" 2025-10-08 05:39:07.095620 | controller | changed: "docs" 2025-10-08 05:39:07.284100 | crc | changed: "docs" 2025-10-08 05:39:07.377403 | 2025-10-08 05:39:07.377520 | PLAY RECAP 2025-10-08 05:39:07.377564 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-08 05:39:07.377589 | crc | ok: 17 changed: 6 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-10-08 05:39:07.377611 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 05:39:07.377627 | 2025-10-08 05:39:07.503450 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-08 05:39:07.506915 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-08 05:39:08.124248 | 2025-10-08 05:39:08.124369 | PLAY [all] 2025-10-08 05:39:08.157328 | 2025-10-08 05:39:08.157412 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-08 05:39:08.239995 | controller | ok 2025-10-08 05:39:08.250507 | crc | ok 2025-10-08 05:39:08.257106 | 2025-10-08 05:39:08.257210 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-08 05:39:08.716287 | controller | changed 2025-10-08 05:39:08.813608 | crc | changed 2025-10-08 05:39:08.828367 | 2025-10-08 05:39:08.828599 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-08 05:39:09.903049 | controller | changed 2025-10-08 05:39:10.024558 | crc | changed 2025-10-08 05:39:10.056884 | 2025-10-08 05:39:10.056985 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-08 05:39:10.439929 | controller | changed: 2025-10-08 05:39:10.440296 | controller | { 2025-10-08 05:39:10.440366 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-08 05:39:10.440417 | controller | } 2025-10-08 05:39:10.587835 | crc | changed: 2025-10-08 05:39:10.587956 | crc | { 2025-10-08 05:39:10.588008 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-08 05:39:10.588030 | crc | } 2025-10-08 05:39:10.680419 | controller | changed: 2025-10-08 05:39:10.680559 | controller | { 2025-10-08 05:39:10.680610 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-08 05:39:10.680653 | controller | } 2025-10-08 05:39:10.943301 | controller | changed: 2025-10-08 05:39:10.943450 | controller | { 2025-10-08 05:39:10.943501 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-10-08 05:39:10.943633 | controller | } 2025-10-08 05:39:10.958783 | crc | changed: 2025-10-08 05:39:10.958927 | crc | { 2025-10-08 05:39:10.958986 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-08 05:39:10.959029 | crc | } 2025-10-08 05:39:11.173437 | controller | changed: 2025-10-08 05:39:11.173568 | controller | { 2025-10-08 05:39:11.173619 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-08 05:39:11.173659 | controller | } 2025-10-08 05:39:11.338513 | crc | changed: 2025-10-08 05:39:11.338870 | crc | { 2025-10-08 05:39:11.339044 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC9MiLfy30deHA7xPOAlew5qUq3UP2gmRMYJi8PtkjFB20/DKeWwWNnkZPqP9AayruRoo51SIiVg870gbZE2jYl+Ncx/FYDe56JeC3ySZsXoAVkC9bP7gkOGqOmJjirvAgPMI7bogVz8i+66Q4Ar7OKTp3762G4IuWPPEg4ce4Y7lx9qWocZapHYq4cYKMxrOZ7SEbFSATBbe2bPZAPKTw8do/Eny+Hq/LkHFhIeyra6cqTFQYShr+zPln0Cr+ro/pDX3bB+1ubFgTpjpkkkQsLhDfR6cCdCWM2lgnS3BTtYj5Ct9/JRPR5YOphqZz+uB+OEu2IL68hmU9vNTth1KeX rlandy@redhat.com" 2025-10-08 05:39:11.339103 | crc | } 2025-10-08 05:39:11.402947 | controller | changed: 2025-10-08 05:39:11.403073 | controller | { 2025-10-08 05:39:11.403126 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-08 05:39:11.403166 | controller | } 2025-10-08 05:39:11.619154 | controller | changed: 2025-10-08 05:39:11.619252 | controller | { 2025-10-08 05:39:11.619297 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-08 05:39:11.619325 | controller | } 2025-10-08 05:39:11.695045 | crc | changed: 2025-10-08 05:39:11.695159 | crc | { 2025-10-08 05:39:11.695191 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-08 05:39:11.695216 | crc | } 2025-10-08 05:39:11.869132 | controller | changed: 2025-10-08 05:39:11.869235 | controller | { 2025-10-08 05:39:11.869268 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2025-10-08 05:39:11.869297 | controller | } 2025-10-08 05:39:12.082758 | crc | changed: 2025-10-08 05:39:12.082902 | crc | { 2025-10-08 05:39:12.082952 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-08 05:39:12.082993 | crc | } 2025-10-08 05:39:12.151482 | controller | changed: 2025-10-08 05:39:12.151800 | controller | { 2025-10-08 05:39:12.151871 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2025-10-08 05:39:12.151917 | controller | } 2025-10-08 05:39:12.404527 | controller | changed: 2025-10-08 05:39:12.404717 | controller | { 2025-10-08 05:39:12.404778 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-08 05:39:12.404820 | controller | } 2025-10-08 05:39:12.419105 | crc | changed: 2025-10-08 05:39:12.419212 | crc | { 2025-10-08 05:39:12.419261 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-08 05:39:12.419301 | crc | } 2025-10-08 05:39:12.644663 | controller | changed: 2025-10-08 05:39:12.644863 | controller | { 2025-10-08 05:39:12.644914 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-08 05:39:12.644953 | controller | } 2025-10-08 05:39:12.822524 | crc | changed: 2025-10-08 05:39:12.822733 | crc | { 2025-10-08 05:39:12.822798 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDLOQd4ZLtkZXQGY6UwAr/06ppWQK4fDO3HaqxPk98csyOCBXsliSKK39Bso828+5srIXiW7aI6aC9P5mwi4mUZlGPfJlQbfrcGvY+b/SocuvaGK+1RrHLoJCT52LBhwgrzlXio2jeksZeein8iaTrhsPrOAs7KggIL/rB9hEiB3NaOPWhhoCP4vlW6MEMExGcqB/1FVxXFBPnLkEyW0Lk7ycVflZl2ocRxbfjZi0+tI1Wlinp8PvSQSc/WVrAcDgKjc/mB4ODPOyYy3G8FHgfMsrXSDEyjBKgLKMsdCrAUcqJQWjkqXleXSYOV4q3pzL+9umK+q/e3P/bIoSFQzmJKTU1eDfuvPXmow9F5H54fii/Da7ezlMJ+wPGHJrRAkmzvMbALy7xwswLhZMkOGNtRcPqaKYRmIBKpw3o6bCTtcNUHOtOQnzwY8JzrM2eBWJBXAANYw+9/ho80JIiwhg29CFNpVBuHbql2YxJQNrnl90guN65rYNpDxdIluweyUf8= anbanerj@kaermorhen" 2025-10-08 05:39:12.822845 | crc | } 2025-10-08 05:39:12.910044 | controller | changed: 2025-10-08 05:39:12.910189 | controller | { 2025-10-08 05:39:12.910237 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-08 05:39:12.910275 | controller | } 2025-10-08 05:39:13.194489 | crc | changed: 2025-10-08 05:39:13.194641 | crc | { 2025-10-08 05:39:13.194724 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQC3VwV8Im9kRm49lt3tM36hj4Zv27FxGo4C1Q/0jqhzFmHY7RHbmeRr8ObhwWoHjXSozKWg8FL5ER0z3hTwL0W6lez3sL7hUaCmSuZmG5Hnl3x4vTSxDI9JZ/Y65rtYiiWQo2fC5xJhU/4+0e5e/pseCm8cKRSu+SaxhO+sd6FDojA2x1BzOzKiQRDy/1zWGp/cZkxcEuB1wHI5LMzN03c67vmbu+fhZRAUO4dQkvcnj2LrhQtpa+ytvnSjr8icMDosf1OsbSffwZFyHB/hfWGAfe0eIeSA2XPraxiPknXxiPKx2MJsaUTYbsZcm3EjFdHBBMumw5rBI74zLrMRvCO9GwBEmGT4rFng1nP+yw5DB8sn2zqpOsPg1LYRwCPOUveC13P6pgsZZPh812e8v5EKnETct+5XI3dVpdw6CnNiLwAyVAF15DJvBGT/u1k0Myg/bQn+Gv9k2MSj6LvQmf6WbZu2Wgjm30z3FyCneBqTL7mLF19YXzeC0ufHz5pnO1E= dasm@fedora" 2025-10-08 05:39:13.194768 | crc | } 2025-10-08 05:39:13.206453 | controller | changed: 2025-10-08 05:39:13.206555 | controller | { 2025-10-08 05:39:13.206603 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-08 05:39:13.206640 | controller | } 2025-10-08 05:39:13.475655 | controller | changed: 2025-10-08 05:39:13.475855 | controller | { 2025-10-08 05:39:13.475905 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-08 05:39:13.475945 | controller | } 2025-10-08 05:39:13.570046 | crc | changed: 2025-10-08 05:39:13.570175 | crc | { 2025-10-08 05:39:13.570223 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-08 05:39:13.570263 | crc | } 2025-10-08 05:39:13.736717 | controller | changed: 2025-10-08 05:39:13.736850 | controller | { 2025-10-08 05:39:13.736897 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-08 05:39:13.736936 | controller | } 2025-10-08 05:39:13.921946 | crc | changed: 2025-10-08 05:39:13.922101 | crc | { 2025-10-08 05:39:13.922149 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-08 05:39:13.922187 | crc | } 2025-10-08 05:39:13.990635 | controller | changed: 2025-10-08 05:39:13.991079 | controller | { 2025-10-08 05:39:13.991149 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-08 05:39:13.991190 | controller | } 2025-10-08 05:39:14.237868 | controller | changed: 2025-10-08 05:39:14.238242 | controller | { 2025-10-08 05:39:14.238312 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-08 05:39:14.238353 | controller | } 2025-10-08 05:39:14.272713 | crc | changed: 2025-10-08 05:39:14.272848 | crc | { 2025-10-08 05:39:14.273101 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-08 05:39:14.273163 | crc | } 2025-10-08 05:39:14.471509 | controller | changed: 2025-10-08 05:39:14.471648 | controller | { 2025-10-08 05:39:14.471710 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2025-10-08 05:39:14.471744 | controller | } 2025-10-08 05:39:14.647449 | crc | changed: 2025-10-08 05:39:14.647577 | crc | { 2025-10-08 05:39:14.647608 | crc | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-08 05:39:14.647633 | crc | } 2025-10-08 05:39:14.697438 | controller | changed: 2025-10-08 05:39:14.697500 | controller | { 2025-10-08 05:39:14.697529 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2025-10-08 05:39:14.697554 | controller | } 2025-10-08 05:39:14.945483 | controller | changed: 2025-10-08 05:39:14.945713 | controller | { 2025-10-08 05:39:14.945774 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-08 05:39:14.945815 | controller | } 2025-10-08 05:39:15.022803 | crc | changed: 2025-10-08 05:39:15.022922 | crc | { 2025-10-08 05:39:15.022970 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-08 05:39:15.023008 | crc | } 2025-10-08 05:39:15.196962 | controller | changed: 2025-10-08 05:39:15.197101 | controller | { 2025-10-08 05:39:15.197150 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-08 05:39:15.197189 | controller | } 2025-10-08 05:39:15.387886 | crc | changed: 2025-10-08 05:39:15.388053 | crc | { 2025-10-08 05:39:15.388102 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-08 05:39:15.388142 | crc | } 2025-10-08 05:39:15.447940 | controller | changed: 2025-10-08 05:39:15.448038 | controller | { 2025-10-08 05:39:15.448085 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-08 05:39:15.448125 | controller | } 2025-10-08 05:39:15.690723 | controller | changed: 2025-10-08 05:39:15.690879 | controller | { 2025-10-08 05:39:15.690927 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-08 05:39:15.690965 | controller | } 2025-10-08 05:39:15.756959 | crc | changed: 2025-10-08 05:39:15.757127 | crc | { 2025-10-08 05:39:15.757175 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-08 05:39:15.757215 | crc | } 2025-10-08 05:39:15.937149 | controller | changed: 2025-10-08 05:39:15.937296 | controller | { 2025-10-08 05:39:15.937356 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2025-10-08 05:39:15.937407 | controller | } 2025-10-08 05:39:16.103175 | crc | changed: 2025-10-08 05:39:16.103460 | crc | { 2025-10-08 05:39:16.103526 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-08 05:39:16.103574 | crc | } 2025-10-08 05:39:16.221432 | controller | changed: 2025-10-08 05:39:16.221534 | controller | { 2025-10-08 05:39:16.221581 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-08 05:39:16.221620 | controller | } 2025-10-08 05:39:16.479119 | crc | changed: 2025-10-08 05:39:16.479226 | crc | { 2025-10-08 05:39:16.479275 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQCfNtF7NvKl915TGsGGoseUb06Hj8L/S4toWf0hExeY+F00woL6NvBlJD0nDct+P5a22I4EhvoQCRQ8reaPCm1lybR3uiRIJsj+8zkVvLwby9LXzfZorlNG9ofjd00FEmB09uW/YvTl6Q9XwwwX6tInzIOv3TMqTHHGOL74ibbj8J/FJR0cFEyj0z4WQRvtkh32xAHl83gbuINryMt0sqRI+clj2381NKL55DRLQrVw0gsfqqxiHAnXg21qWmc4J+b9e9kiuAFQjcjwTVkwJCcg3xbPwC/qokYRby/Y5S40UUd7/jEARGXT7RZgpzTuDd1oZiCVrnrqJNPaMNdVv5MLeFdf1B7iIe5aa/fGouX7AO4SdKhZUdnJmCFAGvjC6S3JMZ2wAcUl+OHnssfmdj7XL50cLo27vjuzMtLAgSqi6N99m92WCF2s8J9aVzszX7Xz9OKZCeGsiVJp3/NdABKzSEAyM9xBD/5Vho894Sav+otpySHe3p6RUTgbB5Zu8VyZRZ/UtB3ueXxyo764yrc6qWIDqrehm84Xm9g+/jpIBzGPl07NUNJpdt/6Sgf9RIKXw/7XypO5yZfUcuFNGTxLfqjTNrtgLZNcjfav6sSdVXVcMPL//XNuRdKmVFaO76eV/oGMQGr1fGcCD+N+CpI7+Q+fCNB6VFWG4nZFuI/Iuw== averdagu@redhat.com" 2025-10-08 05:39:16.479330 | crc | } 2025-10-08 05:39:16.492792 | controller | changed: 2025-10-08 05:39:16.492966 | controller | { 2025-10-08 05:39:16.493020 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-08 05:39:16.493059 | controller | } 2025-10-08 05:39:16.738392 | controller | changed: 2025-10-08 05:39:16.738555 | controller | { 2025-10-08 05:39:16.738785 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-08 05:39:16.738899 | controller | } 2025-10-08 05:39:16.838740 | crc | changed: 2025-10-08 05:39:16.838986 | crc | { 2025-10-08 05:39:16.839151 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABgQDq8l27xI+QlQVdS4djp9ogSoyrNE2+Ox6vKPdhSNL1J3PE5w+WCSvMz9A5gnNuH810zwbekEApbxTze/gLQJwBHA52CChfURpXrFaxY7ePXRElwKAL3mJfzBWY/c5jnNL9TCVmFJTGZkFZP3Nh+BMgZvL6xBkt3WKm6Uq18qzd9XeKcZusrA+O+uLv1fVeQnadY9RIqOCyeFYCzLWrUfTyE8x/XG0hAWIM7qpnF2cALQS2h9n4hW5ybiUN790H08wf9hFwEf5nxY9Z9dVkPFQiTSGKNBzmnCXU9skxS/xhpFjJ5duGSZdtAHe9O+nGZm9c67hxgtf8e5PDuqAdXEv2cf6e3VBAt+Bz8EKI3yosTj0oZHfwr42Yzb1l/SKy14Rggsrc9KAQlrGXan6+u2jcQqqx7l+SWmnpFiWTV9u5cWj2IgOhApOitmRBPYqk9rE2usfO0hLn/Pj/R/Nau4803e1/EikdLE7Ps95s9mX5jRDjAoUa2JwFF5RsVFyL910= ashigupt@ashigupt.remote.csb" 2025-10-08 05:39:16.839256 | crc | } 2025-10-08 05:39:16.839379 | crc | changed: All items complete 2025-10-08 05:39:16.839591 | 2025-10-08 05:39:17.228452 | crc | changed: 2025-10-08 05:39:17.228669 | crc | { 2025-10-08 05:39:17.228761 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-08 05:39:17.228803 | crc | } 2025-10-08 05:39:17.581873 | crc | changed: 2025-10-08 05:39:17.582047 | crc | { 2025-10-08 05:39:17.582096 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-08 05:39:17.582136 | crc | } 2025-10-08 05:39:17.947854 | crc | changed: 2025-10-08 05:39:17.948329 | crc | { 2025-10-08 05:39:17.948400 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-08 05:39:17.948442 | crc | } 2025-10-08 05:39:18.321137 | crc | changed: 2025-10-08 05:39:18.321429 | crc | { 2025-10-08 05:39:18.321491 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-08 05:39:18.321533 | crc | } 2025-10-08 05:39:18.667532 | crc | changed: 2025-10-08 05:39:18.667724 | crc | { 2025-10-08 05:39:18.667781 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAACAQDZdI7t1cxYx65heVI24HTV4F7oQLW1zyfxHreL2TIJKxjyrUUKIFEUmTutcBlJRLNT2Eoix6x1sOw9YrchloCLcn//SGfTElr9mSc5jbjb7QXEU+zJMhtxyEJ1Po3CUGnj7ckiIXw7wcawZtrEOAQ9pH3ExYCJcEMiyNjRQZCxT3tPK+S4B95EWh5Fsrz9CkwpjNRPPH7LigCeQTM3Wc7r97utAslBUUvYceDSLA7rMgkitJE38b7rZBeYzsGQ8YYUBjTCtehqQXxCRjizbHWaaZkBU+N3zkKB6n/iCNGIO690NK7A/qb6msTijiz1PeuM8ThOsi9qXnbX5v0PoTpcFSojV7NHAQ71f0XXuS43FhZctT+Dcx44dT8Fb5vJu2cJGrk+qF8ZgJYNpRS7gPg0EG2EqjK7JMf9ULdjSu0r+KlqIAyLvtzT4eOnQipoKlb/WG5D/0ohKv7OMQ352ggfkBFIQsRXyyTCT98Ft9juqPuahi3CAQmP4H9dyE+7+Kz437PEtsxLmfm6naNmWi7Ee1DqWPwS8rEajsm4sNM4wW9gdBboJQtc0uZw0DfLj1I9r3Mc8Ol0jYtz0yNQDSzVLrGCaJlC311trU70tZ+ZkAVV6Mn8lOhSbj1cK0lvSr6ZK4dgqGl3I1eTZJJhbLNdg7UOVaiRx9543+C/p/As7w== brjackma@redhat.com" 2025-10-08 05:39:18.667824 | crc | } 2025-10-08 05:39:18.997134 | crc | changed: 2025-10-08 05:39:18.997413 | crc | { 2025-10-08 05:39:18.997495 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-08 05:39:18.997555 | crc | } 2025-10-08 05:39:19.425079 | crc | changed: 2025-10-08 05:39:19.425322 | crc | { 2025-10-08 05:39:19.425378 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-08 05:39:19.425434 | crc | } 2025-10-08 05:39:19.776840 | crc | changed: 2025-10-08 05:39:19.776990 | crc | { 2025-10-08 05:39:19.777037 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-08 05:39:19.777077 | crc | } 2025-10-08 05:39:19.828170 | 2025-10-08 05:39:19.828402 | TASK [Set timezone to UTC] 2025-10-08 05:39:20.341959 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-08 05:39:20.553784 | crc | ok 2025-10-08 05:39:20.564327 | 2025-10-08 05:39:20.564462 | TASK [Create nodepool directory] 2025-10-08 05:39:20.869226 | controller | changed 2025-10-08 05:39:20.927205 | crc | changed 2025-10-08 05:39:20.939460 | 2025-10-08 05:39:20.939595 | TASK [Create nodepool sub_nodes file] 2025-10-08 05:39:21.629192 | controller | changed 2025-10-08 05:39:21.829350 | crc | changed 2025-10-08 05:39:21.841019 | 2025-10-08 05:39:21.841169 | TASK [Create nodepool sub_nodes_private file] 2025-10-08 05:39:22.578873 | controller | changed 2025-10-08 05:39:22.729530 | crc | changed 2025-10-08 05:39:22.741122 | 2025-10-08 05:39:22.741276 | LOOP [Populate nodepool sub_nodes file] 2025-10-08 05:39:22.808436 | 2025-10-08 05:39:22.808619 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-08 05:39:22.867876 | 2025-10-08 05:39:22.868067 | TASK [Create nodepool primary file] 2025-10-08 05:39:22.901922 | controller | skipping: Conditional result was False 2025-10-08 05:39:22.922952 | crc | skipping: Conditional result was False 2025-10-08 05:39:22.930259 | 2025-10-08 05:39:22.930341 | TASK [Create nodepool node_private for this node] 2025-10-08 05:39:23.635567 | controller | changed 2025-10-08 05:39:23.846866 | crc | changed 2025-10-08 05:39:23.858863 | 2025-10-08 05:39:23.858993 | LOOP [Copy ssh keys to nodepool directory] 2025-10-08 05:39:24.316310 | controller | ok: Item: id_rsa Runtime: 0:00:00.010456 2025-10-08 05:39:24.316574 | 2025-10-08 05:39:24.335402 | crc | ok: Item: id_rsa Runtime: 0:00:00.010586 2025-10-08 05:39:24.541997 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.009685 2025-10-08 05:39:24.587570 | crc | ok: Item: id_rsa.pub Runtime: 0:00:00.009067 2025-10-08 05:39:24.605234 | 2025-10-08 05:39:24.605325 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-08 05:39:25.367667 | controller | changed 2025-10-08 05:39:25.544296 | crc | changed 2025-10-08 05:39:25.554578 | 2025-10-08 05:39:25.554735 | TASK [Validate sudoers config after edits] 2025-10-08 05:39:25.947312 | controller | /etc/sudoers: parsed OK 2025-10-08 05:39:25.947515 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-08 05:39:25.947578 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-08 05:39:25.947588 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-08 05:39:25.987385 | crc | /etc/sudoers: parsed OK 2025-10-08 05:39:25.987582 | crc | /etc/sudoers.d/coreos-sudo-group: parsed OK 2025-10-08 05:39:25.987601 | crc | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-08 05:39:26.158507 | controller | ok: Runtime: 0:00:00.007466 2025-10-08 05:39:26.173560 | crc | ok: Runtime: 0:00:00.010387 2025-10-08 05:39:26.184952 | 2025-10-08 05:39:26.185078 | TASK [Show the environment passed in to job shell scripts] 2025-10-08 05:39:26.537053 | controller | SHELL=/bin/bash 2025-10-08 05:39:26.537100 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-08 05:39:26.537109 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-08 05:39:26.537116 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/f73256b19c90fb94359fc527fcfcb675474058ed 2025-10-08 05:39:26.537122 | controller | PWD=/home/zuul 2025-10-08 05:39:26.537129 | controller | ZUUL_PIPELINE=github-check 2025-10-08 05:39:26.537135 | controller | LOGNAME=zuul 2025-10-08 05:39:26.537141 | controller | XDG_SESSION_TYPE=tty 2025-10-08 05:39:26.537147 | controller | _=/usr/bin/env 2025-10-08 05:39:26.537153 | controller | MOTD_SHOWN=pam 2025-10-08 05:39:26.537159 | controller | HOME=/home/zuul 2025-10-08 05:39:26.537165 | controller | LANG=en_US.UTF-8 2025-10-08 05:39:26.537171 | controller | SSH_CONNECTION=38.102.83.114 47740 38.102.83.94 22 2025-10-08 05:39:26.537177 | controller | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2025-10-08 05:39:26.537187 | controller | ZUUL_CHANGE_IDS=3237,f73256b19c90fb94359fc527fcfcb675474058ed 2025-10-08 05:39:26.537193 | controller | WORKSPACE=/home/zuul/workspace 2025-10-08 05:39:26.537199 | controller | XDG_SESSION_CLASS=user 2025-10-08 05:39:26.537205 | controller | SELINUX_ROLE_REQUESTED= 2025-10-08 05:39:26.537211 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-08 05:39:26.537217 | controller | USER=zuul 2025-10-08 05:39:26.537223 | controller | ZUUL_VOTING=True 2025-10-08 05:39:26.537229 | controller | BUILD_TIMEOUT=9000000 2025-10-08 05:39:26.537235 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-08 05:39:26.537241 | controller | SHLVL=1 2025-10-08 05:39:26.537247 | controller | ZUUL_PATCHSET=f73256b19c90fb94359fc527fcfcb675474058ed 2025-10-08 05:39:26.537253 | controller | XDG_SESSION_ID=1 2025-10-08 05:39:26.537259 | controller | ZUUL_BRANCH=main 2025-10-08 05:39:26.537265 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-08 05:39:26.537271 | controller | SSH_CLIENT=38.102.83.114 47740 22 2025-10-08 05:39:26.537277 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-08 05:39:26.537283 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-08 05:39:26.537289 | controller | which_declare=declare -f 2025-10-08 05:39:26.537296 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-08 05:39:26.537302 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-08 05:39:26.537308 | controller | ZUUL_CHANGE=3237 2025-10-08 05:39:26.537314 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-08 05:39:26.537320 | controller | ZUUL_UUID=feeb159bff734b26baca9ae077db1cb8 2025-10-08 05:39:26.537326 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-08 05:39:26.537333 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-08 05:39:26.537339 | controller | } 2025-10-08 05:39:26.602368 | crc | SHELL=/bin/bash 2025-10-08 05:39:26.602443 | crc | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-08 05:39:26.602452 | crc | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-08 05:39:26.602460 | crc | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/f73256b19c90fb94359fc527fcfcb675474058ed 2025-10-08 05:39:26.602466 | crc | PWD=/var/home/core 2025-10-08 05:39:26.602472 | crc | ZUUL_PIPELINE=github-check 2025-10-08 05:39:26.602487 | crc | LOGNAME=core 2025-10-08 05:39:26.602499 | crc | XDG_SESSION_TYPE=tty 2025-10-08 05:39:26.602545 | crc | _=/usr/bin/env 2025-10-08 05:39:26.602557 | crc | MOTD_SHOWN=pam 2025-10-08 05:39:26.602653 | crc | HOME=/var/home/core 2025-10-08 05:39:26.602663 | crc | LANG=C.UTF-8 2025-10-08 05:39:26.602670 | crc | SSH_CONNECTION=38.102.83.114 52516 38.102.83.50 22 2025-10-08 05:39:26.602679 | crc | TOX_TESTENV_PASSENV=ZUUL_UUID ZUUL_PROJECT ZUUL_SHORT_PROJECT_NAME ZUUL_PIPELINE ZUUL_VOTING WORKSPACE BUILD_TIMEOUT ZUUL_BRANCH ZUUL_CHANGES ZUUL_CHANGE_IDS ZUUL_CHANGE ZUUL_PATCHSET 2025-10-08 05:39:26.602691 | crc | ZUUL_CHANGE_IDS=3237,f73256b19c90fb94359fc527fcfcb675474058ed 2025-10-08 05:39:26.602698 | crc | WORKSPACE=/home/zuul/workspace 2025-10-08 05:39:26.602704 | crc | XDG_SESSION_CLASS=user 2025-10-08 05:39:26.602711 | crc | SELINUX_ROLE_REQUESTED= 2025-10-08 05:39:26.602718 | crc | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-08 05:39:26.602726 | crc | USER=core 2025-10-08 05:39:26.602734 | crc | ZUUL_VOTING=True 2025-10-08 05:39:26.602741 | crc | BUILD_TIMEOUT=9000000 2025-10-08 05:39:26.602749 | crc | SELINUX_USE_CURRENT_RANGE= 2025-10-08 05:39:26.602756 | crc | SHLVL=1 2025-10-08 05:39:26.602763 | crc | ZUUL_PATCHSET=f73256b19c90fb94359fc527fcfcb675474058ed 2025-10-08 05:39:26.602770 | crc | XDG_SESSION_ID=2 2025-10-08 05:39:26.602777 | crc | ZUUL_BRANCH=main 2025-10-08 05:39:26.602784 | crc | XDG_RUNTIME_DIR=/run/user/1000 2025-10-08 05:39:26.602793 | crc | SSH_CLIENT=38.102.83.114 52516 22 2025-10-08 05:39:26.602810 | crc | which_declare=declare -f 2025-10-08 05:39:26.602819 | crc | PATH=/var/home/core/.local/bin:/var/home/core/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-08 05:39:26.602827 | crc | SELINUX_LEVEL_REQUESTED= 2025-10-08 05:39:26.602836 | crc | ZUUL_CHANGE=3237 2025-10-08 05:39:26.602845 | crc | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-08 05:39:26.602853 | crc | ZUUL_UUID=feeb159bff734b26baca9ae077db1cb8 2025-10-08 05:39:26.602861 | crc | BASH_FUNC_which%%=() { ( alias; 2025-10-08 05:39:26.602869 | crc | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-08 05:39:26.602877 | crc | } 2025-10-08 05:39:26.773496 | controller | ok: Runtime: 0:00:00.007090 2025-10-08 05:39:26.789751 | crc | ok: Runtime: 0:00:00.008076 2025-10-08 05:39:26.801036 | 2025-10-08 05:39:26.801173 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-08 05:39:26.839916 | controller | skipping: Conditional result was False 2025-10-08 05:39:26.850900 | crc | skipping: Conditional result was False 2025-10-08 05:39:26.858333 | 2025-10-08 05:39:26.858421 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-08 05:39:27.439610 | controller | skipping: Conditional result was False 2025-10-08 05:39:27.440498 | crc | skipping: Conditional result was False 2025-10-08 05:39:27.452317 | 2025-10-08 05:39:27.452446 | TASK [Ensure legacy workspace directory] 2025-10-08 05:39:27.711540 | controller | changed 2025-10-08 05:39:27.809464 | crc | changed 2025-10-08 05:39:27.882895 | 2025-10-08 05:39:27.882961 | PLAY RECAP 2025-10-08 05:39:27.883007 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-08 05:39:27.883034 | crc | ok: 14 changed: 10 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-08 05:39:27.883051 | 2025-10-08 05:39:28.003805 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-08 05:39:28.011366 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network.yml@master] 2025-10-08 05:39:28.647207 | 2025-10-08 05:39:28.647326 | PLAY [controller] 2025-10-08 05:39:28.669911 | 2025-10-08 05:39:28.669994 | TASK [Debug parameters] 2025-10-08 05:39:28.698698 | controller | ok 2025-10-08 05:39:28.704181 | 2025-10-08 05:39:28.704249 | TASK [Assert crc_ci_bootstrap_cloud_name is defined] 2025-10-08 05:39:28.734099 | controller | ok: All assertions passed 2025-10-08 05:39:28.739166 | 2025-10-08 05:39:28.739230 | TASK [Assert crc_ci_bootstrap_networking is defined and contains the minimum fields] 2025-10-08 05:39:28.779126 | controller | ok: All assertions passed 2025-10-08 05:39:28.783996 | 2025-10-08 05:39:28.784058 | TASK [Assert that the default network exists and has no VLAN tag] 2025-10-08 05:39:28.816016 | controller | ok: All assertions passed 2025-10-08 05:39:28.822793 | 2025-10-08 05:39:28.822873 | LOOP [Assert that all instances has a given fixed IP for each net and default net is present] 2025-10-08 05:39:28.926323 | controller | ok: All assertions passed 2025-10-08 05:39:28.937847 | controller | ok: All assertions passed 2025-10-08 05:39:28.957523 | 2025-10-08 05:39:28.957756 | LOOP [Assert that every host references an valid/declared network] 2025-10-08 05:39:29.019415 | controller | ok: All assertions passed 2025-10-08 05:39:29.019880 | controller | ok: All items complete 2025-10-08 05:39:29.019952 | 2025-10-08 05:39:29.030822 | controller | ok: All assertions passed 2025-10-08 05:39:29.043979 | 2025-10-08 05:39:29.044375 | LOOP [Assert that all instances has in range fixed IP for each net] 2025-10-08 05:39:29.134477 | controller | ok: All assertions passed 2025-10-08 05:39:29.150893 | controller | ok: All assertions passed 2025-10-08 05:39:29.170043 | 2025-10-08 05:39:29.170251 | TASK [Assert that all non-default nets has the vlan tag] 2025-10-08 05:39:29.240367 | controller | ok: All assertions passed 2025-10-08 05:39:29.251178 | 2025-10-08 05:39:29.251304 | TASK [Install required packages] 2025-10-08 05:39:43.398866 | controller | changed 2025-10-08 05:39:43.411511 | 2025-10-08 05:39:43.411654 | TASK [Create openstack config dir] 2025-10-08 05:39:43.809579 | controller | changed 2025-10-08 05:39:43.815660 | 2025-10-08 05:39:43.815751 | LOOP [Create ci dir in etc folder in the controller] 2025-10-08 05:39:44.162260 | controller -> 38.102.83.50 | changed: "crc" 2025-10-08 05:39:44.162559 | controller -> 38.102.83.50 | ok: All items complete 2025-10-08 05:39:44.162601 | 2025-10-08 05:39:44.411216 | controller -> 38.102.83.94 | changed: "controller" 2025-10-08 05:39:44.425071 | 2025-10-08 05:39:44.425187 | TASK [Set global resource names as facts] 2025-10-08 05:39:44.456379 | controller | ok 2025-10-08 05:39:44.461527 | 2025-10-08 05:39:44.461584 | TASK [Generate CA cert file] 2025-10-08 05:39:44.486161 | controller | skipping: Conditional result was False 2025-10-08 05:39:44.500014 | 2025-10-08 05:39:44.500181 | TASK [Update CA certs] 2025-10-08 05:39:45.041376 | controller | skipping: Conditional result was False 2025-10-08 05:39:45.055536 | 2025-10-08 05:39:45.055732 | TASK [Generate clouds config from cloud_secrets secret] 2025-10-08 05:39:46.153835 | controller | changed 2025-10-08 05:39:46.165272 | 2025-10-08 05:39:46.165405 | TASK [Create the default network] 2025-10-08 05:39:48.936668 | controller | admin_state_up: true 2025-10-08 05:39:48.936953 | controller | availability_zone_hints: 2025-10-08 05:39:48.937169 | controller | - nova 2025-10-08 05:39:48.937180 | controller | availability_zones: [] 2025-10-08 05:39:48.937642 | controller | created_at: '2025-10-08T05:39:47Z' 2025-10-08 05:39:48.937897 | controller | description: '' 2025-10-08 05:39:48.938098 | controller | dns_domain: '' 2025-10-08 05:39:48.938347 | controller | id: 210324df-ec00-4234-a83d-72c09c28c095 2025-10-08 05:39:48.938621 | controller | ipv4_address_scope: null 2025-10-08 05:39:48.938915 | controller | ipv6_address_scope: null 2025-10-08 05:39:48.939199 | controller | is_default: false 2025-10-08 05:39:48.939412 | controller | is_vlan_qinq: null 2025-10-08 05:39:48.939635 | controller | is_vlan_transparent: true 2025-10-08 05:39:48.939898 | controller | l2_adjacency: true 2025-10-08 05:39:48.940156 | controller | mtu: 1500 2025-10-08 05:39:48.940379 | controller | name: zuul-ci-net-feeb159b 2025-10-08 05:39:48.940605 | controller | port_security_enabled: false 2025-10-08 05:39:48.940887 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-08 05:39:48.941111 | controller | provider:network_type: null 2025-10-08 05:39:48.941342 | controller | provider:physical_network: null 2025-10-08 05:39:48.941568 | controller | provider:segmentation_id: null 2025-10-08 05:39:48.941802 | controller | qos_policy_id: null 2025-10-08 05:39:48.942011 | controller | revision_number: 1 2025-10-08 05:39:48.942223 | controller | router:external: false 2025-10-08 05:39:48.942420 | controller | segments: null 2025-10-08 05:39:48.942615 | controller | shared: false 2025-10-08 05:39:48.942863 | controller | status: ACTIVE 2025-10-08 05:39:48.943056 | controller | subnets: [] 2025-10-08 05:39:48.943247 | controller | tags: [] 2025-10-08 05:39:48.943485 | controller | updated_at: '2025-10-08T05:39:48Z' 2025-10-08 05:39:49.213563 | controller | changed 2025-10-08 05:39:49.225248 | 2025-10-08 05:39:49.225380 | TASK [Create subnet - ipv4] 2025-10-08 05:39:51.487990 | controller | allocation_pools: 2025-10-08 05:39:51.488261 | controller | - end: 192.168.122.254 2025-10-08 05:39:51.488274 | controller | start: 192.168.122.2 2025-10-08 05:39:51.488283 | controller | cidr: 192.168.122.0/24 2025-10-08 05:39:51.488429 | controller | created_at: '2025-10-08T05:39:51Z' 2025-10-08 05:39:51.488552 | controller | description: '' 2025-10-08 05:39:51.488688 | controller | dns_nameservers: [] 2025-10-08 05:39:51.488862 | controller | dns_publish_fixed_ip: null 2025-10-08 05:39:51.489012 | controller | enable_dhcp: false 2025-10-08 05:39:51.489141 | controller | gateway_ip: 192.168.122.1 2025-10-08 05:39:51.489259 | controller | host_routes: [] 2025-10-08 05:39:51.489393 | controller | id: b6567535-aaa0-450c-a406-db46c72e4961 2025-10-08 05:39:51.489539 | controller | ip_version: 4 2025-10-08 05:39:51.489663 | controller | ipv6_address_mode: null 2025-10-08 05:39:51.489869 | controller | ipv6_ra_mode: null 2025-10-08 05:39:51.490004 | controller | name: zuul-ci-subnet-feeb159b 2025-10-08 05:39:51.490152 | controller | network_id: 210324df-ec00-4234-a83d-72c09c28c095 2025-10-08 05:39:51.490307 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-08 05:39:51.490432 | controller | revision_number: 0 2025-10-08 05:39:51.490562 | controller | segment_id: null 2025-10-08 05:39:51.490701 | controller | service_types: [] 2025-10-08 05:39:51.490828 | controller | subnetpool_id: null 2025-10-08 05:39:51.490952 | controller | tags: [] 2025-10-08 05:39:51.491094 | controller | updated_at: '2025-10-08T05:39:51Z' 2025-10-08 05:39:51.779024 | controller | changed 2025-10-08 05:39:51.791434 | 2025-10-08 05:39:51.791597 | TASK [Set yaml returned data for further usage] 2025-10-08 05:39:51.873801 | controller | ok 2025-10-08 05:39:51.886488 | 2025-10-08 05:39:51.886617 | TASK [Create router] 2025-10-08 05:39:52.437947 | controller | skipping: Conditional result was False 2025-10-08 05:39:52.451674 | 2025-10-08 05:39:52.451852 | TASK [Set router yaml returned data for further usage] 2025-10-08 05:39:52.529546 | controller | skipping: Conditional result was False 2025-10-08 05:39:52.542113 | 2025-10-08 05:39:52.542251 | TASK [Add router to subnet] 2025-10-08 05:39:53.097984 | controller | skipping: Conditional result was False 2025-10-08 05:39:53.111363 | 2025-10-08 05:39:53.111505 | LOOP [Create ports, VLANs and configure them on the instance] 2025-10-08 05:39:53.189386 | controller | ok: 2025-10-08 05:39:53.189801 | controller | { 2025-10-08 05:39:53.189873 | controller | "key": "controller", 2025-10-08 05:39:53.189925 | controller | "value": { 2025-10-08 05:39:53.189973 | controller | "networks": { 2025-10-08 05:39:53.190018 | controller | "default": { 2025-10-08 05:39:53.190063 | controller | "ip": "192.168.122.11" 2025-10-08 05:39:53.190107 | controller | } 2025-10-08 05:39:53.190271 | controller | } 2025-10-08 05:39:53.190347 | controller | } 2025-10-08 05:39:53.190395 | controller | } 2025-10-08 05:39:56.187774 | controller | ok: 2025-10-08 05:39:56.187935 | controller | { 2025-10-08 05:39:56.187985 | controller | "key": "crc", 2025-10-08 05:39:56.188024 | controller | "value": { 2025-10-08 05:39:56.188060 | controller | "networks": { 2025-10-08 05:39:56.188095 | controller | "default": { 2025-10-08 05:39:56.188130 | controller | "ip": "192.168.122.10" 2025-10-08 05:39:56.188166 | controller | }, 2025-10-08 05:39:56.188200 | controller | "internal-api": { 2025-10-08 05:39:56.188233 | controller | "ip": "172.17.0.5" 2025-10-08 05:39:56.188266 | controller | }, 2025-10-08 05:39:56.188298 | controller | "storage": { 2025-10-08 05:39:56.188331 | controller | "ip": "172.18.0.5" 2025-10-08 05:39:56.188364 | controller | }, 2025-10-08 05:39:56.188397 | controller | "tenant": { 2025-10-08 05:39:56.188430 | controller | "ip": "172.19.0.5" 2025-10-08 05:39:56.188462 | controller | } 2025-10-08 05:39:56.188495 | controller | } 2025-10-08 05:39:56.188528 | controller | } 2025-10-08 05:39:56.188561 | controller | } 2025-10-08 05:39:56.201398 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance.yml 2025-10-08 05:39:56.208474 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance.yml 2025-10-08 05:39:56.224738 | 2025-10-08 05:39:56.224883 | TASK [Create instance ports and attach if necessary] 2025-10-08 05:39:56.253283 | controller | ok 2025-10-08 05:39:56.333881 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance-create-attach-port.yml 2025-10-08 05:39:56.339663 | 2025-10-08 05:39:56.339739 | TASK [Print the host networking data] 2025-10-08 05:39:56.395005 | controller | ok 2025-10-08 05:39:56.405511 | 2025-10-08 05:39:56.405634 | TASK [Create the private network parent port] 2025-10-08 05:39:59.014968 | controller | admin_state_up: true 2025-10-08 05:39:59.015175 | controller | allowed_address_pairs: [] 2025-10-08 05:39:59.015363 | controller | binding_host_id: null 2025-10-08 05:39:59.015491 | controller | binding_profile: {} 2025-10-08 05:39:59.015616 | controller | binding_vif_details: {} 2025-10-08 05:39:59.015759 | controller | binding_vif_type: null 2025-10-08 05:39:59.015917 | controller | binding_vnic_type: normal 2025-10-08 05:39:59.016080 | controller | created_at: '2025-10-08T05:39:58Z' 2025-10-08 05:39:59.016210 | controller | data_plane_status: null 2025-10-08 05:39:59.016327 | controller | description: '' 2025-10-08 05:39:59.016448 | controller | device_id: '' 2025-10-08 05:39:59.016582 | controller | device_owner: '' 2025-10-08 05:39:59.016740 | controller | device_profile: null 2025-10-08 05:39:59.017065 | controller | dns_assignment: 2025-10-08 05:39:59.017185 | controller | - fqdn: host-192-168-122-11.openstacklocal. 2025-10-08 05:39:59.017195 | controller | hostname: host-192-168-122-11 2025-10-08 05:39:59.017205 | controller | ip_address: 192.168.122.11 2025-10-08 05:39:59.017213 | controller | dns_domain: '' 2025-10-08 05:39:59.017336 | controller | dns_name: '' 2025-10-08 05:39:59.017474 | controller | extra_dhcp_opts: [] 2025-10-08 05:39:59.017754 | controller | fixed_ips: 2025-10-08 05:39:59.017887 | controller | - ip_address: 192.168.122.11 2025-10-08 05:39:59.017897 | controller | subnet_id: b6567535-aaa0-450c-a406-db46c72e4961 2025-10-08 05:39:59.017906 | controller | hardware_offload_type: null 2025-10-08 05:39:59.018015 | controller | hints: '' 2025-10-08 05:39:59.018147 | controller | id: d88421f4-0eff-4188-9863-2bbeafc9e49a 2025-10-08 05:39:59.018268 | controller | ip_allocation: immediate 2025-10-08 05:39:59.018397 | controller | mac_address: fa:16:3e:2a:41:35 2025-10-08 05:39:59.018542 | controller | name: controller-64566401-8ea6-4640-9549-ca80c08688ae 2025-10-08 05:39:59.018704 | controller | network_id: 210324df-ec00-4234-a83d-72c09c28c095 2025-10-08 05:39:59.018839 | controller | numa_affinity_policy: null 2025-10-08 05:39:59.018996 | controller | port_security_enabled: false 2025-10-08 05:39:59.019142 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-08 05:39:59.019273 | controller | propagate_uplink_status: null 2025-10-08 05:39:59.019399 | controller | resource_request: null 2025-10-08 05:39:59.019552 | controller | revision_number: 1 2025-10-08 05:39:59.019699 | controller | qos_network_policy_id: null 2025-10-08 05:39:59.019829 | controller | qos_policy_id: null 2025-10-08 05:39:59.019954 | controller | security_group_ids: [] 2025-10-08 05:39:59.020088 | controller | status: DOWN 2025-10-08 05:39:59.020202 | controller | tags: [] 2025-10-08 05:39:59.020369 | controller | trunk_details: null 2025-10-08 05:39:59.020487 | controller | trusted: null 2025-10-08 05:39:59.020621 | controller | updated_at: '2025-10-08T05:39:58Z' 2025-10-08 05:39:59.477402 | controller | changed 2025-10-08 05:39:59.489768 | 2025-10-08 05:39:59.489905 | TASK [Set common facts for further usage] 2025-10-08 05:39:59.581093 | controller | ok 2025-10-08 05:39:59.592951 | 2025-10-08 05:39:59.593098 | TASK [Create the trunk port] 2025-10-08 05:40:00.140616 | controller | skipping: Conditional result was False 2025-10-08 05:40:00.147206 | 2025-10-08 05:40:00.147279 | TASK [Avoid NetworkManager to automatically picked up the new interface] 2025-10-08 05:40:00.201821 | controller | skipping: Conditional result was False 2025-10-08 05:40:00.210925 | 2025-10-08 05:40:00.211017 | TASK [Refresh NetworkManager] 2025-10-08 05:40:00.256811 | controller | skipping: Conditional result was False 2025-10-08 05:40:00.266265 | 2025-10-08 05:40:00.266351 | TASK [Attach the port to the instance] 2025-10-08 05:40:10.319910 | controller | changed 2025-10-08 05:40:10.325755 | 2025-10-08 05:40:10.325818 | TASK [Wait till the interface exists] 2025-10-08 05:40:10.638848 | controller -> 38.102.83.94 | changed 2025-10-08 05:40:10.645083 | 2025-10-08 05:40:10.645146 | TASK [Prepare interface data to be used configuring trunk and vlan ifaces] 2025-10-08 05:40:10.778156 | controller | ok 2025-10-08 05:40:10.807476 | 2025-10-08 05:40:10.807592 | LOOP [Create VLANs ports and attach them to the trunk] 2025-10-08 05:40:10.837305 | 2025-10-08 05:40:10.837438 | LOOP [Prepare VLANs interface data to be used configuring] 2025-10-08 05:40:10.857105 | 2025-10-08 05:40:10.857224 | LOOP [Create NetworkManager configuration file for the trunk port] 2025-10-08 05:40:11.587527 | controller -> 38.102.83.94 | changed: 2025-10-08 05:40:11.587938 | controller -> 38.102.83.94 | { 2025-10-08 05:40:11.587996 | controller -> 38.102.83.94 | "key": "default", 2025-10-08 05:40:11.588036 | controller -> 38.102.83.94 | "value": { 2025-10-08 05:40:11.588071 | controller -> 38.102.83.94 | "connection": "ci-private-network", 2025-10-08 05:40:11.588106 | controller -> 38.102.83.94 | "gw": "192.168.122.1", 2025-10-08 05:40:11.588140 | controller -> 38.102.83.94 | "iface": "eth1", 2025-10-08 05:40:11.588173 | controller -> 38.102.83.94 | "ip": "192.168.122.11/24", 2025-10-08 05:40:11.588204 | controller -> 38.102.83.94 | "mac": "fa:16:3e:2a:41:35", 2025-10-08 05:40:11.588236 | controller -> 38.102.83.94 | "mtu": "1500" 2025-10-08 05:40:11.588268 | controller -> 38.102.83.94 | } 2025-10-08 05:40:11.588301 | controller -> 38.102.83.94 | } 2025-10-08 05:40:11.588359 | 2025-10-08 05:40:11.605649 | 2025-10-08 05:40:11.605875 | TASK [Refresh NetworkManager] 2025-10-08 05:40:12.533133 | controller -> 38.102.83.94 | changed 2025-10-08 05:40:12.550253 | 2025-10-08 05:40:12.550386 | TASK [Debug fetch IP routes] 2025-10-08 05:40:12.822842 | controller -> 38.102.83.94 | changed 2025-10-08 05:40:12.836522 | 2025-10-08 05:40:12.836718 | TASK [Debug IP routes] 2025-10-08 05:40:12.884961 | controller -> 38.102.83.94 | ok 2025-10-08 05:40:12.899937 | 2025-10-08 05:40:12.900068 | TASK [Create instance ports and attach if necessary] 2025-10-08 05:40:12.932478 | controller | ok 2025-10-08 05:40:12.956865 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance-create-attach-port.yml 2025-10-08 05:40:12.965122 | 2025-10-08 05:40:12.965204 | TASK [Print the host networking data] 2025-10-08 05:40:13.002625 | controller | ok 2025-10-08 05:40:13.012203 | 2025-10-08 05:40:13.012289 | TASK [Create the private network parent port] 2025-10-08 05:40:16.356924 | controller | admin_state_up: true 2025-10-08 05:40:16.357010 | controller | allowed_address_pairs: [] 2025-10-08 05:40:16.357156 | controller | binding_host_id: null 2025-10-08 05:40:16.357263 | controller | binding_profile: {} 2025-10-08 05:40:16.357364 | controller | binding_vif_details: {} 2025-10-08 05:40:16.357469 | controller | binding_vif_type: null 2025-10-08 05:40:16.357622 | controller | binding_vnic_type: normal 2025-10-08 05:40:16.357757 | controller | created_at: '2025-10-08T05:40:15Z' 2025-10-08 05:40:16.357861 | controller | data_plane_status: null 2025-10-08 05:40:16.357961 | controller | description: '' 2025-10-08 05:40:16.358056 | controller | device_id: '' 2025-10-08 05:40:16.358154 | controller | device_owner: '' 2025-10-08 05:40:16.358254 | controller | device_profile: null 2025-10-08 05:40:16.358558 | controller | dns_assignment: 2025-10-08 05:40:16.358651 | controller | - fqdn: host-192-168-122-10.openstacklocal. 2025-10-08 05:40:16.358660 | controller | hostname: host-192-168-122-10 2025-10-08 05:40:16.358666 | controller | ip_address: 192.168.122.10 2025-10-08 05:40:16.358674 | controller | dns_domain: '' 2025-10-08 05:40:16.358765 | controller | dns_name: '' 2025-10-08 05:40:16.358862 | controller | extra_dhcp_opts: [] 2025-10-08 05:40:16.359100 | controller | fixed_ips: 2025-10-08 05:40:16.359207 | controller | - ip_address: 192.168.122.10 2025-10-08 05:40:16.359215 | controller | subnet_id: b6567535-aaa0-450c-a406-db46c72e4961 2025-10-08 05:40:16.359223 | controller | hardware_offload_type: null 2025-10-08 05:40:16.359300 | controller | hints: '' 2025-10-08 05:40:16.359414 | controller | id: fc326d07-0057-4feb-bb19-68fa5a43220f 2025-10-08 05:40:16.359512 | controller | ip_allocation: immediate 2025-10-08 05:40:16.359620 | controller | mac_address: fa:16:3e:30:04:94 2025-10-08 05:40:16.359758 | controller | name: crc-4394bc66-4ac8-4c29-b7ea-ad1631ce1848 2025-10-08 05:40:16.359884 | controller | network_id: 210324df-ec00-4234-a83d-72c09c28c095 2025-10-08 05:40:16.359986 | controller | numa_affinity_policy: null 2025-10-08 05:40:16.360127 | controller | port_security_enabled: false 2025-10-08 05:40:16.360353 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-08 05:40:16.360460 | controller | propagate_uplink_status: null 2025-10-08 05:40:16.360557 | controller | resource_request: null 2025-10-08 05:40:16.360684 | controller | revision_number: 1 2025-10-08 05:40:16.360809 | controller | qos_network_policy_id: null 2025-10-08 05:40:16.360903 | controller | qos_policy_id: null 2025-10-08 05:40:16.361002 | controller | security_group_ids: [] 2025-10-08 05:40:16.361095 | controller | status: DOWN 2025-10-08 05:40:16.361186 | controller | tags: [] 2025-10-08 05:40:16.361286 | controller | trunk_details: null 2025-10-08 05:40:16.361378 | controller | trusted: null 2025-10-08 05:40:16.361489 | controller | updated_at: '2025-10-08T05:40:15Z' 2025-10-08 05:40:16.561581 | controller | changed 2025-10-08 05:40:16.574369 | 2025-10-08 05:40:16.574494 | TASK [Set common facts for further usage] 2025-10-08 05:40:16.666054 | controller | ok 2025-10-08 05:40:16.678775 | 2025-10-08 05:40:16.678906 | TASK [Create the trunk port] 2025-10-08 05:40:17.221585 | controller | skipping: Conditional result was False 2025-10-08 05:40:17.228032 | 2025-10-08 05:40:17.228092 | TASK [Avoid NetworkManager to automatically picked up the new interface] 2025-10-08 05:40:17.314092 | controller | skipping: Conditional result was False 2025-10-08 05:40:17.320604 | 2025-10-08 05:40:17.320664 | TASK [Refresh NetworkManager] 2025-10-08 05:40:17.365281 | controller | skipping: Conditional result was False 2025-10-08 05:40:17.371750 | 2025-10-08 05:40:17.371843 | TASK [Attach the port to the instance] 2025-10-08 05:40:24.916569 | controller | changed 2025-10-08 05:40:24.923302 | 2025-10-08 05:40:24.923372 | TASK [Wait till the interface exists] 2025-10-08 05:40:25.253125 | controller -> 38.102.83.50 | changed 2025-10-08 05:40:25.262079 | 2025-10-08 05:40:25.262165 | TASK [Prepare interface data to be used configuring trunk and vlan ifaces] 2025-10-08 05:40:25.399364 | controller | ok 2025-10-08 05:40:25.406849 | 2025-10-08 05:40:25.406929 | LOOP [Create VLANs ports and attach them to the trunk] 2025-10-08 05:40:25.459088 | controller | skipping: Conditional result was False 2025-10-08 05:40:28.465669 | controller | skipping: Conditional result was False 2025-10-08 05:40:31.481617 | controller | skipping: Conditional result was False 2025-10-08 05:40:31.491438 | 2025-10-08 05:40:31.491560 | LOOP [Prepare VLANs interface data to be used configuring] 2025-10-08 05:40:31.658391 | controller | ok: 2025-10-08 05:40:31.658590 | controller | { 2025-10-08 05:40:31.658616 | controller | "key": "internal-api", 2025-10-08 05:40:31.658641 | controller | "value": { 2025-10-08 05:40:31.658658 | controller | "ip": "172.17.0.5" 2025-10-08 05:40:31.658674 | controller | } 2025-10-08 05:40:31.658710 | controller | } 2025-10-08 05:40:31.658739 | 2025-10-08 05:40:31.688613 | controller | ok: 2025-10-08 05:40:31.688778 | controller | { 2025-10-08 05:40:31.688807 | controller | "key": "storage", 2025-10-08 05:40:31.688827 | controller | "value": { 2025-10-08 05:40:31.688844 | controller | "ip": "172.18.0.5" 2025-10-08 05:40:31.688860 | controller | } 2025-10-08 05:40:31.688875 | controller | } 2025-10-08 05:40:31.729724 | controller | ok: 2025-10-08 05:40:31.729947 | controller | { 2025-10-08 05:40:31.730005 | controller | "key": "tenant", 2025-10-08 05:40:31.730046 | controller | "value": { 2025-10-08 05:40:31.730082 | controller | "ip": "172.19.0.5" 2025-10-08 05:40:31.730117 | controller | } 2025-10-08 05:40:31.730152 | controller | } 2025-10-08 05:40:31.761447 | 2025-10-08 05:40:31.761627 | LOOP [Create NetworkManager configuration file for the trunk port] 2025-10-08 05:40:32.628140 | controller -> 38.102.83.50 | changed: 2025-10-08 05:40:32.628355 | controller -> 38.102.83.50 | { 2025-10-08 05:40:32.628381 | controller -> 38.102.83.50 | "key": "default", 2025-10-08 05:40:32.628398 | controller -> 38.102.83.50 | "value": { 2025-10-08 05:40:32.628414 | controller -> 38.102.83.50 | "connection": "ci-private-network", 2025-10-08 05:40:32.628430 | controller -> 38.102.83.50 | "gw": "192.168.122.1", 2025-10-08 05:40:32.628445 | controller -> 38.102.83.50 | "iface": "ens7", 2025-10-08 05:40:32.628460 | controller -> 38.102.83.50 | "ip": "192.168.122.10/24", 2025-10-08 05:40:32.628475 | controller -> 38.102.83.50 | "mac": "fa:16:3e:30:04:94", 2025-10-08 05:40:32.628489 | controller -> 38.102.83.50 | "mtu": "1500" 2025-10-08 05:40:32.628504 | controller -> 38.102.83.50 | } 2025-10-08 05:40:32.628519 | controller -> 38.102.83.50 | } 2025-10-08 05:40:33.467547 | controller -> 38.102.83.50 | changed: 2025-10-08 05:40:33.467657 | controller -> 38.102.83.50 | { 2025-10-08 05:40:33.467700 | controller -> 38.102.83.50 | "key": "internal-api", 2025-10-08 05:40:33.467721 | controller -> 38.102.83.50 | "value": { 2025-10-08 05:40:33.467738 | controller -> 38.102.83.50 | "connection": "ci-private-network-20", 2025-10-08 05:40:33.467754 | controller -> 38.102.83.50 | "iface": "ens7.20", 2025-10-08 05:40:33.467771 | controller -> 38.102.83.50 | "ip": "172.17.0.5/24", 2025-10-08 05:40:33.467786 | controller -> 38.102.83.50 | "mac": "52:54:00:ed:1c:a2", 2025-10-08 05:40:33.467801 | controller -> 38.102.83.50 | "mtu": "1496", 2025-10-08 05:40:33.467817 | controller -> 38.102.83.50 | "parent_iface": "ens7", 2025-10-08 05:40:33.467832 | controller -> 38.102.83.50 | "vlan": 20 2025-10-08 05:40:33.467847 | controller -> 38.102.83.50 | } 2025-10-08 05:40:33.467862 | controller -> 38.102.83.50 | } 2025-10-08 05:40:34.203833 | controller -> 38.102.83.50 | changed: 2025-10-08 05:40:34.203959 | controller -> 38.102.83.50 | { 2025-10-08 05:40:34.203988 | controller -> 38.102.83.50 | "key": "storage", 2025-10-08 05:40:34.204012 | controller -> 38.102.83.50 | "value": { 2025-10-08 05:40:34.204030 | controller -> 38.102.83.50 | "connection": "ci-private-network-21", 2025-10-08 05:40:34.204053 | controller -> 38.102.83.50 | "iface": "ens7.21", 2025-10-08 05:40:34.204077 | controller -> 38.102.83.50 | "ip": "172.18.0.5/24", 2025-10-08 05:40:34.204100 | controller -> 38.102.83.50 | "mac": "52:54:00:25:ef:98", 2025-10-08 05:40:34.204118 | controller -> 38.102.83.50 | "mtu": "1496", 2025-10-08 05:40:34.204151 | controller -> 38.102.83.50 | "parent_iface": "ens7", 2025-10-08 05:40:34.204170 | controller -> 38.102.83.50 | "vlan": 21 2025-10-08 05:40:34.204189 | controller -> 38.102.83.50 | } 2025-10-08 05:40:34.204206 | controller -> 38.102.83.50 | } 2025-10-08 05:40:35.040608 | controller -> 38.102.83.50 | changed: 2025-10-08 05:40:35.040779 | controller -> 38.102.83.50 | { 2025-10-08 05:40:35.040813 | controller -> 38.102.83.50 | "key": "tenant", 2025-10-08 05:40:35.040831 | controller -> 38.102.83.50 | "value": { 2025-10-08 05:40:35.040847 | controller -> 38.102.83.50 | "connection": "ci-private-network-22", 2025-10-08 05:40:35.040864 | controller -> 38.102.83.50 | "iface": "ens7.22", 2025-10-08 05:40:35.040880 | controller -> 38.102.83.50 | "ip": "172.19.0.5/24", 2025-10-08 05:40:35.040896 | controller -> 38.102.83.50 | "mac": "52:54:00:f1:92:4b", 2025-10-08 05:40:35.040912 | controller -> 38.102.83.50 | "mtu": "1496", 2025-10-08 05:40:35.040927 | controller -> 38.102.83.50 | "parent_iface": "ens7", 2025-10-08 05:40:35.040943 | controller -> 38.102.83.50 | "vlan": 22 2025-10-08 05:40:35.040958 | controller -> 38.102.83.50 | } 2025-10-08 05:40:35.040974 | controller -> 38.102.83.50 | } 2025-10-08 05:40:35.059000 | 2025-10-08 05:40:35.059105 | TASK [Refresh NetworkManager] 2025-10-08 05:40:35.916952 | controller -> 38.102.83.50 | changed 2025-10-08 05:40:35.925534 | 2025-10-08 05:40:35.925598 | TASK [Debug fetch IP routes] 2025-10-08 05:40:36.236795 | controller -> 38.102.83.50 | changed 2025-10-08 05:40:36.244453 | 2025-10-08 05:40:36.244518 | TASK [Debug IP routes] 2025-10-08 05:40:36.278234 | controller -> 38.102.83.50 | ok 2025-10-08 05:40:36.284764 | 2025-10-08 05:40:36.284831 | TASK [Display some data about network ports] 2025-10-08 05:40:38.117717 | controller | +--------------------------------------+-------------------------------------------------+-------------------+-------------------------------------------------------------------------------+--------+ 2025-10-08 05:40:38.226601 | controller | | ID | Name | MAC Address | Fixed IP Addresses | Status | 2025-10-08 05:40:38.226742 | controller | +--------------------------------------+-------------------------------------------------+-------------------+-------------------------------------------------------------------------------+--------+ 2025-10-08 05:40:38.226766 | controller | | ce9a67ce-dbe6-40db-9b3b-bb5a7426e16d | | fa:16:3e:2a:87:8d | | DOWN | 2025-10-08 05:40:38.226780 | controller | | d88421f4-0eff-4188-9863-2bbeafc9e49a | controller-64566401-8ea6-4640-9549-ca80c08688ae | fa:16:3e:2a:41:35 | ip_address='192.168.122.11', subnet_id='b6567535-aaa0-450c-a406-db46c72e4961' | ACTIVE | 2025-10-08 05:40:38.226794 | controller | | fc326d07-0057-4feb-bb19-68fa5a43220f | crc-4394bc66-4ac8-4c29-b7ea-ad1631ce1848 | fa:16:3e:30:04:94 | ip_address='192.168.122.10', subnet_id='b6567535-aaa0-450c-a406-db46c72e4961' | ACTIVE | 2025-10-08 05:40:38.226807 | controller | +--------------------------------------+-------------------------------------------------+-------------------+-------------------------------------------------------------------------------+--------+ 2025-10-08 05:40:38.348535 | controller | changed 2025-10-08 05:40:38.359273 | 2025-10-08 05:40:38.359367 | LOOP [Display server configuration] 2025-10-08 05:40:40.620053 | controller | changed 2025-10-08 05:40:40.620326 | controller | changed: All items complete 2025-10-08 05:40:40.620364 | 2025-10-08 05:40:45.747202 | controller | changed 2025-10-08 05:40:45.768342 | 2025-10-08 05:40:45.768451 | TASK [Fetch underneath provider DNSs] 2025-10-08 05:40:45.787711 | controller | ok 2025-10-08 05:40:45.794331 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-fetch-provider-dns.yml 2025-10-08 05:40:45.804051 | 2025-10-08 05:40:45.804109 | TASK [Fetch the DNS list of the default interface] 2025-10-08 05:40:46.208198 | controller | ok 2025-10-08 05:40:46.214351 | 2025-10-08 05:40:46.214411 | TASK [Set provider DNS for further usage] 2025-10-08 05:40:46.275817 | controller | ok 2025-10-08 05:40:46.281160 | 2025-10-08 05:40:46.281220 | LOOP [Save networking data to file for further usage] 2025-10-08 05:40:47.190664 | controller -> 38.102.83.50 | changed: "crc" 2025-10-08 05:40:47.967508 | controller -> 38.102.83.94 | changed: "controller" 2025-10-08 05:40:47.983916 | 2025-10-08 05:40:47.984027 | TASK [Remove cloud_secrets file] 2025-10-08 05:40:48.235328 | controller | changed 2025-10-08 05:40:48.270716 | 2025-10-08 05:40:48.270810 | PLAY RECAP 2025-10-08 05:40:48.270864 | controller | ok: 48 changed: 22 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-08 05:40:48.270891 | 2025-10-08 05:40:48.400711 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network.yml@master] 2025-10-08 05:40:48.404583 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/prepare-crc.yaml@master] 2025-10-08 05:40:48.969611 | 2025-10-08 05:40:48.969742 | PLAY [Prefer ipv4 over ipv6] 2025-10-08 05:40:49.005832 | 2025-10-08 05:40:49.005955 | TASK [Configure /etc/gai.conf to prever ipv4 over ipv6] 2025-10-08 05:40:49.062588 | controller | skipping: Conditional result was False 2025-10-08 05:40:49.093657 | crc | skipping: Conditional result was False 2025-10-08 05:40:49.142231 | 2025-10-08 05:40:49.142392 | PLAY [Generic task for migration time to crc-cloud] 2025-10-08 05:40:49.162190 | 2025-10-08 05:40:49.162253 | TASK [Check if there is a image build date file] 2025-10-08 05:40:49.649087 | crc | ok 2025-10-08 05:40:49.669141 | 2025-10-08 05:40:49.669258 | TASK [Print image date] 2025-10-08 05:40:50.140056 | crc | Wed Oct 8 00:02:11 UTC 2025 | Image type: crc-cloud 2025-10-08 05:40:50.221323 | crc | ok 2025-10-08 05:40:50.236876 | 2025-10-08 05:40:50.237011 | TASK [Run crc-cloud preparation] 2025-10-08 05:40:50.356388 | crc | ok 2025-10-08 05:40:50.385355 | 2025-10-08 05:40:50.385434 | TASK [prepare-crc-cloud : Print build date] 2025-10-08 05:40:50.416214 | crc | ok 2025-10-08 05:40:50.424015 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/build_date.yaml 2025-10-08 05:40:50.433294 | 2025-10-08 05:40:50.433353 | TASK [prepare-crc-cloud : Check if there is a image build date file] 2025-10-08 05:40:50.743815 | crc | ok 2025-10-08 05:40:50.753385 | 2025-10-08 05:40:50.753471 | TASK [prepare-crc-cloud : Print image date if available] 2025-10-08 05:40:51.076254 | crc | Wed Oct 8 00:02:11 UTC 2025 | Image type: crc-cloud 2025-10-08 05:40:51.297653 | crc | ok 2025-10-08 05:40:51.312998 | 2025-10-08 05:40:51.313138 | TASK [prepare-crc-cloud : Tune Kubelet config file] 2025-10-08 05:40:51.340887 | crc | skipping: Conditional result was False 2025-10-08 05:40:51.357314 | 2025-10-08 05:40:51.357450 | TASK [prepare-crc-cloud : Reboot CRC host to get the network interfaces] 2025-10-08 05:40:51.398592 | crc | ok 2025-10-08 05:40:51.417424 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/reboot_crc.yaml 2025-10-08 05:40:51.432060 | 2025-10-08 05:40:51.432146 | TASK [prepare-crc-cloud : Reboot host after adding pull secret and changing kubelet node params] 2025-10-08 05:41:13.406862 | crc | changed 2025-10-08 05:41:13.415793 | 2025-10-08 05:41:13.415871 | TASK [Start Zuul console after reboot] 2025-10-08 05:41:13.440362 | crc | ok 2025-10-08 05:41:13.465378 | 2025-10-08 05:41:13.465462 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-08 05:41:14.020920 | crc | ok 2025-10-08 05:41:14.039186 | 2025-10-08 05:41:14.039270 | TASK [prepare-crc-cloud : Prepare for executing crc-cloud] 2025-10-08 05:41:14.073483 | crc | ok 2025-10-08 05:41:14.084781 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/pre.yaml 2025-10-08 05:41:14.100599 | 2025-10-08 05:41:14.100704 | TASK [prepare-crc-cloud : Disable overwriting /etc/resolv.conf by the NetworkManager] 2025-10-08 05:41:15.137673 | crc | changed 2025-10-08 05:41:15.153930 | 2025-10-08 05:41:15.154058 | TASK [prepare-crc-cloud : Reload NetworkManager after creating custom rules] 2025-10-08 05:41:17.015155 | crc | changed 2025-10-08 05:41:17.024072 | 2025-10-08 05:41:17.024136 | TASK [prepare-crc-cloud : Inject pull secret into /var/lib/kubelet/config.json] 2025-10-08 05:41:17.984784 | crc | changed 2025-10-08 05:41:18.001212 | 2025-10-08 05:41:18.001359 | TASK [prepare-crc-cloud : Check if etcd slow profile set] 2025-10-08 05:41:18.027897 | crc | skipping: Conditional result was False 2025-10-08 05:41:18.048897 | 2025-10-08 05:41:18.048994 | TASK [prepare-crc-cloud : Use ramdisk for etcd] 2025-10-08 05:41:18.082783 | crc | ok 2025-10-08 05:41:18.093560 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/ramdisk.yaml 2025-10-08 05:41:18.105561 | 2025-10-08 05:41:18.105628 | TASK [prepare-crc-cloud : Move current etcd to other place] 2025-10-08 05:41:18.642773 | crc | ok 2025-10-08 05:41:18.658042 | 2025-10-08 05:41:18.658180 | TASK [prepare-crc-cloud : Mount ramdisk] 2025-10-08 05:41:19.117243 | crc | changed 2025-10-08 05:41:19.127289 | 2025-10-08 05:41:19.127383 | TASK [prepare-crc-cloud : Set proper permissions after mount] 2025-10-08 05:41:19.607220 | crc | changed 2025-10-08 05:41:19.619156 | 2025-10-08 05:41:19.619241 | TASK [prepare-crc-cloud : Copy content from old location to ramdisk] 2025-10-08 05:41:21.771394 | crc | changed 2025-10-08 05:41:21.819469 | 2025-10-08 05:41:21.819627 | TASK [prepare-crc-cloud : Set proper SELinux context] 2025-10-08 05:41:22.360557 | crc | ok 2025-10-08 05:41:22.376444 | 2025-10-08 05:41:22.376586 | TASK [prepare-crc-cloud : Block crc.testing domains] 2025-10-08 05:41:22.418992 | crc | ok 2025-10-08 05:41:22.438485 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/block_crc_domains.yaml 2025-10-08 05:41:22.460603 | 2025-10-08 05:41:22.460756 | LOOP [prepare-crc-cloud : Set crc.testing domains into /etc/hosts] 2025-10-08 05:41:22.870598 | crc | changed: line added 2025-10-08 05:41:23.148359 | crc | changed: line added 2025-10-08 05:41:23.399577 | crc | changed: line added 2025-10-08 05:41:23.675275 | crc | changed: line added 2025-10-08 05:41:23.936567 | crc | changed: line added 2025-10-08 05:41:24.201592 | crc | changed: line added 2025-10-08 05:41:24.497063 | crc | changed: line added 2025-10-08 05:41:24.805207 | crc | changed: line added 2025-10-08 05:41:24.832867 | 2025-10-08 05:41:24.833063 | TASK [prepare-crc-cloud : Get default interface name] 2025-10-08 05:41:25.178062 | crc | ens3 2025-10-08 05:41:25.397274 | crc | ok 2025-10-08 05:41:25.415071 | 2025-10-08 05:41:25.415237 | LOOP [prepare-crc-cloud : Block CRC domains also using iptables] 2025-10-08 05:41:25.909445 | crc | ok 2025-10-08 05:41:25.909877 | crc | changed: All items complete 2025-10-08 05:41:25.909937 | 2025-10-08 05:41:26.205408 | crc | ok 2025-10-08 05:41:26.512886 | crc | ok 2025-10-08 05:41:26.810313 | crc | ok 2025-10-08 05:41:27.114649 | crc | ok 2025-10-08 05:41:27.423344 | crc | ok 2025-10-08 05:41:27.692759 | crc | ok 2025-10-08 05:41:27.957298 | crc | ok 2025-10-08 05:41:27.988205 | 2025-10-08 05:41:27.988405 | TASK [prepare-crc-cloud : Set required facts] 2025-10-08 05:41:28.032908 | crc | ok 2025-10-08 05:41:28.087517 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/set_vars.yaml 2025-10-08 05:41:28.103390 | 2025-10-08 05:41:28.103454 | TASK [prepare-crc-cloud : Set required facts] 2025-10-08 05:41:28.155574 | crc | Output suppressed because no_log was given 2025-10-08 05:41:28.162355 | 2025-10-08 05:41:28.162419 | TASK [Start crc-cloud role when Zuul defined] 2025-10-08 05:41:28.194053 | crc | ok 2025-10-08 05:41:28.239392 | 2025-10-08 05:41:28.239480 | TASK [deploy-crc-cloud : Check if pull-secret is provided] 2025-10-08 05:41:28.253423 | crc | skipping: Conditional result was False 2025-10-08 05:41:28.262537 | 2025-10-08 05:41:28.262612 | TASK [deploy-crc-cloud : Create kubeconfig] 2025-10-08 05:41:28.283542 | crc | ok 2025-10-08 05:41:28.292004 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/kubeconfig.yaml 2025-10-08 05:41:28.304440 | 2025-10-08 05:41:28.304507 | TASK [deploy-crc-cloud : Create kube directory] 2025-10-08 05:41:28.612632 | crc | changed 2025-10-08 05:41:28.622538 | 2025-10-08 05:41:28.622626 | TASK [deploy-crc-cloud : Copy kubeconfig to user dir] 2025-10-08 05:41:29.053213 | crc | changed 2025-10-08 05:41:29.062946 | 2025-10-08 05:41:29.063032 | TASK [deploy-crc-cloud : Setup dnsmasq] 2025-10-08 05:41:29.089171 | crc | ok 2025-10-08 05:41:29.103495 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/dnsmasq.yaml 2025-10-08 05:41:29.122374 | 2025-10-08 05:41:29.122466 | TASK [deploy-crc-cloud : Create crc-dnsmasq.conf] 2025-10-08 05:41:30.021068 | crc | changed 2025-10-08 05:41:30.041437 | 2025-10-08 05:41:30.041611 | LOOP [deploy-crc-cloud : Set this host as first nameserver in /etc/resolv.conf] 2025-10-08 05:41:30.424031 | crc | changed: line replaced 2025-10-08 05:41:30.661074 | crc | ok 2025-10-08 05:41:30.942485 | crc | ok 2025-10-08 05:41:30.970122 | 2025-10-08 05:41:30.970254 | TASK [deploy-crc-cloud : Disable overwriting /etc/resolv.conf by the NetworkManager] 2025-10-08 05:41:31.797951 | crc | ok 2025-10-08 05:41:31.813604 | 2025-10-08 05:41:31.813785 | TASK [deploy-crc-cloud : Restart NetworkManager when its needed] 2025-10-08 05:41:31.841896 | crc | skipping: Conditional result was False 2025-10-08 05:41:31.860166 | 2025-10-08 05:41:31.860304 | TASK [deploy-crc-cloud : Restart dnsmasq] 2025-10-08 05:41:32.674506 | crc | changed 2025-10-08 05:41:32.695124 | 2025-10-08 05:41:32.695259 | TASK [deploy-crc-cloud : Start kubelet] 2025-10-08 05:41:32.729518 | crc | ok 2025-10-08 05:41:32.742040 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/kubelet.yaml 2025-10-08 05:41:32.762614 | 2025-10-08 05:41:32.762711 | TASK [deploy-crc-cloud : Start and enable kubelet] 2025-10-08 05:41:47.704561 | crc | changed 2025-10-08 05:41:47.729149 | 2025-10-08 05:41:47.729306 | TASK [deploy-crc-cloud : Wait for port 6443 to be up] 2025-10-08 05:42:48.233455 | crc | ok 2025-10-08 05:42:48.248801 | 2025-10-08 05:42:48.248929 | TASK [deploy-crc-cloud : Wait for API to start before continue] 2025-10-08 05:42:49.705334 | crc | NAMESPACE NAME READY STATUS RESTARTS AGE 2025-10-08 05:42:49.705433 | crc | openshift-apiserver-operator openshift-apiserver-operator-796bbdcf4f-fc8z2 0/1 Pending 0 40s 2025-10-08 05:42:49.705459 | crc | openshift-apiserver apiserver-76f77b778f-l8lbz 0/2 Pending 0 40s 2025-10-08 05:42:49.705475 | crc | openshift-authentication-operator authentication-operator-69f744f599-qptpn 0/1 Pending 0 40s 2025-10-08 05:42:49.705489 | crc | openshift-authentication oauth-openshift-558db77b4-kk279 0/1 Pending 0 40s 2025-10-08 05:42:49.705503 | crc | openshift-cluster-machine-approver machine-approver-56656f9798-8g7mm 0/2 Pending 0 40s 2025-10-08 05:42:49.705524 | crc | openshift-cluster-samples-operator cluster-samples-operator-665b6dd947-7n8zp 0/2 Pending 0 40s 2025-10-08 05:42:49.705542 | crc | openshift-cluster-version cluster-version-operator-5c965bbfc6-kz2j8 0/1 Pending 0 40s 2025-10-08 05:42:49.705564 | crc | openshift-config-operator openshift-config-operator-7777fb866f-jzkpk 0/1 Pending 0 40s 2025-10-08 05:42:49.705604 | crc | openshift-console-operator console-operator-58897d9998-pl2jx 0/1 Pending 0 40s 2025-10-08 05:42:49.705670 | crc | openshift-console console-f9d7485db-nm64j 0/1 Pending 0 40s 2025-10-08 05:42:49.705707 | crc | openshift-console downloads-7954f5f757-vzhlt 0/1 Pending 0 40s 2025-10-08 05:42:49.705743 | crc | openshift-controller-manager-operator openshift-controller-manager-operator-756b6f6bc6-hk98g 0/1 Pending 0 40s 2025-10-08 05:42:49.705794 | crc | openshift-controller-manager controller-manager-879f6c89f-wwrrd 0/1 Pending 0 40s 2025-10-08 05:42:49.705867 | crc | openshift-dns-operator dns-operator-744455d44c-g94xj 0/2 Pending 0 40s 2025-10-08 05:42:49.705923 | crc | openshift-dns node-resolver-p75vp 0/1 Pending 0 40s 2025-10-08 05:42:49.705972 | crc | openshift-etcd-operator etcd-operator-b45778765-zq9fh 0/1 Pending 0 40s 2025-10-08 05:42:49.706016 | crc | openshift-image-registry cluster-image-registry-operator-dc59b4c8b-zjgrt 0/1 Pending 0 40s 2025-10-08 05:42:49.706069 | crc | openshift-image-registry image-registry-697d97f7c8-488wl 0/1 Pending 0 40s 2025-10-08 05:42:49.706124 | crc | openshift-image-registry node-ca-brl9t 0/1 Pending 0 40s 2025-10-08 05:42:49.706175 | crc | openshift-ingress-operator ingress-operator-5b745b69d9-gxjgh 0/2 Pending 0 40s 2025-10-08 05:42:49.706226 | crc | openshift-ingress router-default-5444994796-cg7dr 0/1 Pending 0 40s 2025-10-08 05:42:49.706268 | crc | openshift-kube-apiserver-operator kube-apiserver-operator-766d6c64bb-g8ndk 0/1 Pending 0 40s 2025-10-08 05:42:49.706320 | crc | openshift-kube-apiserver kube-apiserver-crc 0/5 Pending 0 41s 2025-10-08 05:42:49.706361 | crc | openshift-kube-controller-manager-operator kube-controller-manager-operator-78b949d7b-ssrcd 0/1 Pending 0 40s 2025-10-08 05:42:49.706399 | crc | openshift-kube-controller-manager kube-controller-manager-crc 0/4 Pending 0 41s 2025-10-08 05:42:49.706442 | crc | openshift-kube-scheduler-operator openshift-kube-scheduler-operator-5fdd9b5758-d9ld2 0/1 Pending 0 40s 2025-10-08 05:42:49.706480 | crc | openshift-kube-scheduler openshift-kube-scheduler-crc 0/3 Pending 0 6s 2025-10-08 05:42:49.706513 | crc | openshift-kube-storage-version-migrator-operator kube-storage-version-migrator-operator-b67b599dd-wftvg 0/1 Pending 0 40s 2025-10-08 05:42:49.706558 | crc | openshift-kube-storage-version-migrator migrator-59844c95c7-fmx5t 0/2 Pending 0 40s 2025-10-08 05:42:49.706600 | crc | openshift-machine-api control-plane-machine-set-operator-78cbb6b69f-kgs4v 0/1 Pending 0 40s 2025-10-08 05:42:49.706650 | crc | openshift-machine-api machine-api-operator-5694c8668f-jqltz 0/2 Pending 0 40s 2025-10-08 05:42:49.706693 | crc | openshift-machine-config-operator machine-config-controller-84d6567774-w2kf5 0/2 Pending 0 40s 2025-10-08 05:42:49.706732 | crc | openshift-machine-config-operator machine-config-daemon-wlb9w 0/2 Pending 0 40s 2025-10-08 05:42:49.706843 | crc | openshift-machine-config-operator machine-config-operator-74547568cd-txqhm 0/2 Pending 0 40s 2025-10-08 05:42:49.706882 | crc | openshift-marketplace marketplace-operator-79b997595-8pkjf 0/1 Pending 0 40s 2025-10-08 05:42:49.706928 | crc | openshift-multus multus-additional-cni-plugins-q9zvc 0/1 Pending 0 40s 2025-10-08 05:42:49.706969 | crc | openshift-multus multus-admission-controller-857f4d67dd-hv79w 0/2 Pending 0 40s 2025-10-08 05:42:49.707026 | crc | openshift-multus multus-b85s6 0/1 Pending 0 40s 2025-10-08 05:42:49.707077 | crc | openshift-multus network-metrics-daemon-2d68j 0/2 Pending 0 40s 2025-10-08 05:42:49.707120 | crc | openshift-network-console networking-console-plugin-85b44fc459-gdk6g 1/1 Running 2 227d 2025-10-08 05:42:49.707161 | crc | openshift-network-diagnostics network-check-source-55646444c4-trplf 1/1 Running 2 227d 2025-10-08 05:42:49.707210 | crc | openshift-network-diagnostics network-check-target-xd92c 1/1 Running 2 227d 2025-10-08 05:42:49.707252 | crc | openshift-network-node-identity network-node-identity-vrzqb 2/2 Running 7 227d 2025-10-08 05:42:49.707305 | crc | openshift-network-operator iptables-alerter-4ln5h 1/1 Running 2 227d 2025-10-08 05:42:49.707347 | crc | openshift-network-operator network-operator-58b4c7f79c-55gtf 1/1 Running 4 227d 2025-10-08 05:42:49.707390 | crc | openshift-oauth-apiserver apiserver-7bbb656c7d-48m8v 0/1 Pending 0 40s 2025-10-08 05:42:49.707430 | crc | openshift-operator-lifecycle-manager catalog-operator-68c6474976-45ggn 0/1 Pending 0 39s 2025-10-08 05:42:49.707475 | crc | openshift-operator-lifecycle-manager collect-profiles-29331690-6zsj6 0/1 Pending 0 40s 2025-10-08 05:42:49.707520 | crc | openshift-operator-lifecycle-manager olm-operator-6b444d44fb-55j7b 0/1 Pending 0 39s 2025-10-08 05:42:49.707552 | crc | openshift-operator-lifecycle-manager package-server-manager-789f6589d5-mzkg9 0/2 Pending 0 39s 2025-10-08 05:42:49.707589 | crc | openshift-operator-lifecycle-manager packageserver-d55dfcdfc-76jv9 0/1 Pending 0 39s 2025-10-08 05:42:49.707638 | crc | openshift-ovn-kubernetes ovnkube-control-plane-749d76644c-d9865 0/2 Pending 0 39s 2025-10-08 05:42:49.707690 | crc | openshift-ovn-kubernetes ovnkube-node-fgb4p 0/8 Pending 0 40s 2025-10-08 05:42:49.707728 | crc | openshift-route-controller-manager route-controller-manager-6576b87f9c-nlh9f 0/1 Pending 0 39s 2025-10-08 05:42:49.707770 | crc | openshift-service-ca-operator service-ca-operator-777779d784-vnr8p 0/1 Pending 0 39s 2025-10-08 05:42:49.707859 | crc | openshift-service-ca service-ca-9c57cc56f-jw4lt 0/1 Pending 0 39s 2025-10-08 05:42:49.811467 | crc | ok 2025-10-08 05:42:49.828271 | 2025-10-08 05:42:49.828427 | TASK [deploy-crc-cloud : Replace default pubkey] 2025-10-08 05:42:49.872361 | crc | ok 2025-10-08 05:42:49.892190 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/pubkey.yaml 2025-10-08 05:42:49.914591 | 2025-10-08 05:42:49.914694 | TASK [deploy-crc-cloud : Check if id_rsa.pub exists] 2025-10-08 05:42:50.261615 | crc | ok 2025-10-08 05:42:50.270674 | 2025-10-08 05:42:50.270772 | TASK [deploy-crc-cloud : Read pub key] 2025-10-08 05:42:50.813851 | crc | skipping: Conditional result was False 2025-10-08 05:42:50.830707 | 2025-10-08 05:42:50.830856 | TASK [deploy-crc-cloud : Wait for machineconfig] 2025-10-08 05:42:50.858337 | crc | skipping: Conditional result was False 2025-10-08 05:42:50.875932 | 2025-10-08 05:42:50.876087 | TASK [deploy-crc-cloud : Patch machineconfig 99-master-ssh] 2025-10-08 05:42:51.434592 | crc | skipping: Conditional result was False 2025-10-08 05:42:51.451337 | 2025-10-08 05:42:51.451488 | TASK [deploy-crc-cloud : Wait for cluster become healthy] 2025-10-08 05:42:51.494661 | crc | ok 2025-10-08 05:42:51.513580 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-08 05:42:51.541288 | 2025-10-08 05:42:51.541375 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy etcd|openshift-apiserver] 2025-10-08 05:42:52.068239 | crc | True 2025-10-08 05:42:52.069249 | crc | False 2025-10-08 05:44:40.415890 | crc | changed 2025-10-08 05:44:40.431295 | 2025-10-08 05:44:40.431465 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-08 05:44:40.486503 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-08 05:44:40.502594 | 2025-10-08 05:44:40.502759 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-08 05:44:40.529933 | crc | skipping: Conditional result was False 2025-10-08 05:44:40.542109 | 2025-10-08 05:44:40.542201 | TASK [deploy-crc-cloud : Set credentials] 2025-10-08 05:44:40.577694 | crc | ok 2025-10-08 05:44:40.595093 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/set_credentials.yaml 2025-10-08 05:44:40.620566 | 2025-10-08 05:44:40.620634 | TASK [deploy-crc-cloud : Ensure htpasswd.txt does not exists] 2025-10-08 05:44:40.896398 | crc | ok 2025-10-08 05:44:40.911931 | 2025-10-08 05:44:40.912068 | TASK [deploy-crc-cloud : Create temporary directory] 2025-10-08 05:44:41.324200 | crc | changed 2025-10-08 05:44:41.339549 | 2025-10-08 05:44:41.339716 | TASK [deploy-crc-cloud : Create Dockerfile] 2025-10-08 05:44:42.197171 | crc | changed 2025-10-08 05:44:42.211712 | 2025-10-08 05:44:42.211803 | TASK [deploy-crc-cloud : Build container image for htpasswd] 2025-10-08 05:44:58.832041 | crc | STEP 1/3: FROM quay.io/centos/centos:stream9-minimal 2025-10-08 05:44:58.841066 | crc | Trying to pull quay.io/centos/centos:stream9-minimal... 2025-10-08 05:44:59.432895 | crc | Getting image source signatures 2025-10-08 05:45:01.605026 | crc | Copying blob sha256:d8c0dbbf20f3017cc356fa40af20d191b0e85e25d7706ee63c2a0cb5ebf6fc7a 2025-10-08 05:45:01.605086 | crc | Copying config sha256:20aff0b003bb92b55d5d701079b860731e831f5cb1708e195790448697d67e85 2025-10-08 05:45:01.617732 | crc | Writing manifest to image destination 2025-10-08 05:45:01.696880 | crc | STEP 2/3: RUN microdnf --setopt=tsflags=nodocs --setopt=install_weak_deps=0 install -y httpd-tools 2025-10-08 05:45:02.184020 | crc | Downloading metadata... 2025-10-08 05:45:02.833680 | crc | Downloading metadata... 2025-10-08 05:45:05.235010 | crc | Downloading metadata... 2025-10-08 05:45:13.000240 | crc | Package Repository Size 2025-10-08 05:45:13.181953 | crc | Installing: 2025-10-08 05:45:13.182014 | crc | apr-1.7.0-12.el9.x86_64 appstream 126.2 kB 2025-10-08 05:45:13.182029 | crc | apr-util-1.6.1-23.el9.x86_64 appstream 97.3 kB 2025-10-08 05:45:13.182041 | crc | apr-util-bdb-1.6.1-23.el9.x86_64 appstream 13.3 kB 2025-10-08 05:45:13.182053 | crc | expat-2.5.0-5.el9.x86_64 baseos 118.6 kB 2025-10-08 05:45:13.182066 | crc | httpd-tools-2.4.62-7.el9.x86_64 appstream 81.5 kB 2025-10-08 05:45:13.182078 | crc | libdb-5.3.28-57.el9.x86_64 baseos 752.9 kB 2025-10-08 05:45:13.182090 | crc | Transaction Summary: 2025-10-08 05:45:13.182102 | crc | Installing: 6 packages 2025-10-08 05:45:13.182114 | crc | Reinstalling: 0 packages 2025-10-08 05:45:13.182126 | crc | Upgrading: 0 packages 2025-10-08 05:45:13.182137 | crc | Obsoleting: 0 packages 2025-10-08 05:45:13.182149 | crc | Removing: 0 packages 2025-10-08 05:45:13.182168 | crc | Downgrading: 0 packages 2025-10-08 05:45:13.182192 | crc | Downloading packages... 2025-10-08 05:45:14.264431 | crc | warning: Signature not supported. Hash algorithm SHA1 not available. 2025-10-08 05:45:14.286501 | crc | 2025-10-08 05:45:14.286533 | crc | (microdnf:1): libdnf-WARNING **: 05:45:14.263: failed to parse public key for /etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-Extras 2025-10-08 05:45:14.286546 | crc | Running transaction test... 2025-10-08 05:45:15.025615 | crc | Installing: apr;1.7.0-12.el9;x86_64;appstream 2025-10-08 05:45:15.033749 | crc | Installing: expat;2.5.0-5.el9;x86_64;baseos 2025-10-08 05:45:15.042606 | crc | Installing: libdb;5.3.28-57.el9;x86_64;baseos 2025-10-08 05:45:15.062408 | crc | Installing: apr-util-bdb;1.6.1-23.el9;x86_64;appstream 2025-10-08 05:45:15.066096 | crc | Installing: apr-util;1.6.1-23.el9;x86_64;appstream 2025-10-08 05:45:15.073050 | crc | Installing: httpd-tools;2.4.62-7.el9;x86_64;appstream 2025-10-08 05:45:15.118780 | crc | Complete. 2025-10-08 05:45:16.358989 | crc | --> 3521c01244e8 2025-10-08 05:45:16.366780 | crc | STEP 3/3: ENTRYPOINT ["htpasswd", "-Bbn"] 2025-10-08 05:45:16.552220 | crc | COMMIT localhost/htpasswd:latest 2025-10-08 05:45:16.552300 | crc | --> 08e451af6bcf 2025-10-08 05:45:16.552319 | crc | Successfully tagged localhost/htpasswd:latest 2025-10-08 05:45:16.600085 | crc | 08e451af6bcfb088e224a5ed1bc39a9975d9b48d5036dc762e01d1c05548696b 2025-10-08 05:45:16.810471 | crc | changed 2025-10-08 05:45:16.869377 | 2025-10-08 05:45:16.869528 | LOOP [deploy-crc-cloud : Get htpasswd] 2025-10-08 05:45:16.956593 | crc | Output suppressed because no_log was given 2025-10-08 05:45:16.969219 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/get_htpasswd.yaml 2025-10-08 05:45:16.970489 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/get_htpasswd.yaml 2025-10-08 05:45:16.971646 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/get_htpasswd.yaml 2025-10-08 05:45:16.987007 | 2025-10-08 05:45:16.987090 | TASK [deploy-crc-cloud : Get htpasswd for developer] 2025-10-08 05:45:17.427668 | crc | time="2025-10-08T05:45:17Z" level=warning msg="The input device is not a TTY. The --tty and --interactive flags might not work properly" 2025-10-08 05:45:19.039802 | crc | changed 2025-10-08 05:45:19.056839 | 2025-10-08 05:45:19.056991 | TASK [deploy-crc-cloud : Get htpasswd for kubeadmin] 2025-10-08 05:45:19.546527 | crc | time="2025-10-08T05:45:19Z" level=warning msg="The input device is not a TTY. The --tty and --interactive flags might not work properly" 2025-10-08 05:45:35.147163 | crc | changed 2025-10-08 05:45:35.164323 | 2025-10-08 05:45:35.164464 | TASK [deploy-crc-cloud : Get htpasswd for redhat] 2025-10-08 05:45:35.630241 | crc | time="2025-10-08T05:45:35Z" level=warning msg="The input device is not a TTY. The --tty and --interactive flags might not work properly" 2025-10-08 05:45:40.238526 | crc | changed 2025-10-08 05:45:40.254189 | 2025-10-08 05:45:40.254328 | TASK [deploy-crc-cloud : Cleanup htpasswd.txt file] 2025-10-08 05:45:40.838182 | crc | changed 2025-10-08 05:45:40.854549 | 2025-10-08 05:45:40.854718 | TASK [deploy-crc-cloud : Create secret with generic htpass-secret] 2025-10-08 05:45:41.418004 | crc | changed 2025-10-08 05:45:41.433811 | 2025-10-08 05:45:41.433947 | TASK [deploy-crc-cloud : Replace htpass-secret] 2025-10-08 05:45:41.927115 | crc | secret/htpass-secret replaced 2025-10-08 05:45:42.007225 | crc | changed 2025-10-08 05:45:42.022878 | 2025-10-08 05:45:42.023020 | TASK [deploy-crc-cloud : Remove temporary directory] 2025-10-08 05:45:42.362105 | crc | changed 2025-10-08 05:45:42.377905 | 2025-10-08 05:45:42.378044 | TASK [deploy-crc-cloud : Replace default CA] 2025-10-08 05:45:42.411274 | crc | ok 2025-10-08 05:45:42.432402 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/replace_default_ca.yaml 2025-10-08 05:45:42.464845 | 2025-10-08 05:45:42.464939 | TASK [deploy-crc-cloud : Generate key] 2025-10-08 05:45:45.526707 | crc | changed 2025-10-08 05:45:45.542396 | 2025-10-08 05:45:45.542544 | TASK [deploy-crc-cloud : Generate cert] 2025-10-08 05:45:46.104364 | crc | changed 2025-10-08 05:45:46.119905 | 2025-10-08 05:45:46.120043 | TASK [deploy-crc-cloud : Generate csr] 2025-10-08 05:45:46.780130 | crc | ..+..+.+.........+......+..+..........+.....+....+.....+.+..+.+...............+..+...+.+...+...........+....+..+.+.....+.......+...+...+..+.......+........+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.+..+.+...+..+.........+...+.+.................+....+.........+............+..+......+.+...+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*..................+.+.....+.......+.....+......+....+...+...+.....+....+...+.....+.............+..+...+..........+..+...+.+......+...+.....+.........+...+.......+..+...+.............+........+..........+...........+.........+..........+.....+......+.+.......................+.......+..+......+.+.....+......+...+.......+...+......+........+......+.......+..+..........+..+.+.........+......+...+..+.........+...+...+....+.........+.....................+...+.....+..........+.....+......+....+...+..+.......+.....+....+.....+.+...+...+..+...+.........+.........+....+...+.........+.........+.........+.....+.....................+.+.....+.+..+.+..+...+.+...............+..................+......+..+...............+...+..........+..............+.+.....+.......+.....+....+.....+...+...+..........+...+..............+...+....+.....+.............+........+..........+...+.....+.+.....+.............+..+......+...+.+...+...+.....+.........+...+.+...........+...+.+..+...+.+......+..+..........+..+...+............+......+...+.........+...+...+.......+...............+.....+.......+..+...+.......+..............+......+.+...+.....+.........+......+....+........+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++ 2025-10-08 05:45:46.890158 | crc | ....+..+.+........+.........+.+..+.............+.....+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*..............+...+.....+.+.........+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*......+....+..+......+...+..........+......+...+.....+..........+..................+..+......+..........+.....+....+..+.+..+...+..........+...+...........+.+...+..+.........+......+............+...+...+.+....................+...+...+...+......+.+..+..........+......+.....+....+...+....................+...+.......+.....+.........+.+..+.+...........+...+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++ 2025-10-08 05:45:46.893307 | crc | ----- 2025-10-08 05:45:47.217441 | crc | changed 2025-10-08 05:45:47.235186 | 2025-10-08 05:45:47.235384 | TASK [deploy-crc-cloud : Generate user cert] 2025-10-08 05:45:47.616088 | crc | Certificate request self-signature ok 2025-10-08 05:45:47.626067 | crc | subject=O = ${GROUP}, CN = core 2025-10-08 05:45:47.804355 | crc | changed 2025-10-08 05:45:47.820152 | 2025-10-08 05:45:47.820291 | TASK [deploy-crc-cloud : Create configmap] 2025-10-08 05:45:48.284872 | crc | configmap/client-ca-custom created 2025-10-08 05:45:48.400648 | crc | changed 2025-10-08 05:45:48.407648 | 2025-10-08 05:45:48.407727 | TASK [deploy-crc-cloud : Patch apiserver] 2025-10-08 05:45:48.932983 | crc | apiserver.config.openshift.io/cluster patched 2025-10-08 05:45:49.002868 | crc | changed 2025-10-08 05:45:49.018840 | 2025-10-08 05:45:49.018973 | TASK [deploy-crc-cloud : Create configmap] 2025-10-08 05:45:49.512924 | crc | W1008 05:45:49.512743 14842 helpers.go:703] --dry-run is deprecated and can be replaced with --dry-run=client. 2025-10-08 05:45:49.579862 | crc | configmap/admin-kubeconfig-client-ca replaced 2025-10-08 05:45:49.665365 | crc | changed 2025-10-08 05:45:49.681143 | 2025-10-08 05:45:49.681292 | TASK [deploy-crc-cloud : Login to the OpenShift cluster] 2025-10-08 05:45:49.723955 | crc | ok 2025-10-08 05:45:49.742250 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/login.yaml 2025-10-08 05:45:49.779954 | 2025-10-08 05:45:49.780030 | TASK [deploy-crc-cloud : Try to login after all changes] 2025-10-08 05:45:50.362589 | crc | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-08 05:45:50.419305 | crc | 2025-10-08 05:45:50.419369 | crc | Unable to connect to the server: EOF 2025-10-08 05:46:11.697957 | crc | ok 2025-10-08 05:46:11.714257 | 2025-10-08 05:46:11.714403 | TASK [deploy-crc-cloud : Patch pull secret] 2025-10-08 05:46:11.758300 | crc | ok 2025-10-08 05:46:11.775579 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/patch_pull_secret.yaml 2025-10-08 05:46:11.812965 | 2025-10-08 05:46:11.813037 | TASK [deploy-crc-cloud : Patch pull secret] 2025-10-08 05:46:12.352621 | crc | Output suppressed because no_log was given 2025-10-08 05:46:12.367516 | 2025-10-08 05:46:12.367648 | TASK [deploy-crc-cloud : Wait for cluster become healthy after patching CA and pull secret] 2025-10-08 05:46:12.410024 | crc | ok 2025-10-08 05:46:12.427742 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-08 05:46:12.468459 | 2025-10-08 05:46:12.468523 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy etcd|openshift-apiserver] 2025-10-08 05:46:12.907017 | crc | True 2025-10-08 05:46:12.908260 | crc | True 2025-10-08 05:46:13.007026 | crc | changed 2025-10-08 05:46:13.013976 | 2025-10-08 05:46:13.014041 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-08 05:46:13.056001 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-08 05:46:13.062561 | 2025-10-08 05:46:13.062621 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-08 05:46:13.087219 | crc | skipping: Conditional result was False 2025-10-08 05:46:13.095595 | 2025-10-08 05:46:13.095662 | TASK [deploy-crc-cloud : Create certificate and patch secret] 2025-10-08 05:46:13.119803 | crc | skipping: Conditional result was False 2025-10-08 05:46:13.127965 | 2025-10-08 05:46:13.128030 | TASK [deploy-crc-cloud : Wait for cluster become healthy after adding domain] 2025-10-08 05:46:13.196049 | crc | ok 2025-10-08 05:46:13.204099 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-08 05:46:13.232359 | 2025-10-08 05:46:13.232424 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy etcd|openshift-apiserver] 2025-10-08 05:46:13.767508 | crc | True 2025-10-08 05:46:13.768933 | crc | True 2025-10-08 05:46:13.819011 | crc | changed 2025-10-08 05:46:13.826029 | 2025-10-08 05:46:13.826092 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-08 05:46:13.867879 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-08 05:46:13.875044 | 2025-10-08 05:46:13.875104 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-08 05:46:13.899573 | crc | skipping: Conditional result was False 2025-10-08 05:46:13.908142 | 2025-10-08 05:46:13.908208 | TASK [deploy-crc-cloud : Patch ingress config] 2025-10-08 05:46:13.932569 | crc | skipping: Conditional result was False 2025-10-08 05:46:13.941114 | 2025-10-08 05:46:13.941178 | TASK [deploy-crc-cloud : Patch api server] 2025-10-08 05:46:13.965575 | crc | skipping: Conditional result was False 2025-10-08 05:46:13.973453 | 2025-10-08 05:46:13.973515 | TASK [deploy-crc-cloud : Patch default route] 2025-10-08 05:46:13.997525 | crc | skipping: Conditional result was False 2025-10-08 05:46:14.007032 | 2025-10-08 05:46:14.007095 | TASK [deploy-crc-cloud : Wait for cluster become healthy after changing ingress api server and default route] 2025-10-08 05:46:14.037781 | crc | ok 2025-10-08 05:46:14.046185 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-08 05:46:14.076284 | 2025-10-08 05:46:14.076346 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy authentication|console|etcd|ingress|openshift-apiserver] 2025-10-08 05:46:14.569475 | crc | True 2025-10-08 05:46:14.570695 | crc | True 2025-10-08 05:46:14.570712 | crc | True 2025-10-08 05:46:14.570720 | crc | True 2025-10-08 05:46:14.570728 | crc | True 2025-10-08 05:46:14.644324 | crc | changed 2025-10-08 05:46:14.659539 | 2025-10-08 05:46:14.659670 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-08 05:46:14.712899 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-08 05:46:14.727792 | 2025-10-08 05:46:14.727920 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-08 05:46:14.754752 | crc | skipping: Conditional result was False 2025-10-08 05:46:14.766086 | 2025-10-08 05:46:14.766186 | TASK [deploy-crc-cloud : Get console route] 2025-10-08 05:46:14.791493 | crc | skipping: Conditional result was False 2025-10-08 05:46:14.813287 | 2025-10-08 05:46:14.813376 | TASK [Start crc-cloud role when Zuul is not defined] 2025-10-08 05:46:14.849203 | crc | skipping: Conditional result was False 2025-10-08 05:46:14.860252 | 2025-10-08 05:46:14.860340 | TASK [prepare-crc-cloud : Recreate kubelet config.json] 2025-10-08 05:46:14.894951 | crc | ok 2025-10-08 05:46:14.909824 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/inject-pull-secret.yaml 2025-10-08 05:46:14.940115 | 2025-10-08 05:46:14.940176 | TASK [prepare-crc-cloud : Fail when openshift_pull_sec not provided] 2025-10-08 05:46:15.005050 | crc | skipping: Conditional result was False 2025-10-08 05:46:15.016235 | 2025-10-08 05:46:15.016327 | TASK [prepare-crc-cloud : Cleanup file] 2025-10-08 05:46:15.570946 | crc | Output suppressed because no_log was given 2025-10-08 05:46:15.580636 | 2025-10-08 05:46:15.580742 | TASK [prepare-crc-cloud : Copy pull-secret to kubelet config.json] 2025-10-08 05:46:15.959490 | crc | Output suppressed because no_log was given 2025-10-08 05:46:15.974257 | 2025-10-08 05:46:15.974395 | TASK [prepare-crc-cloud : Replace singleqoute with doublequote] 2025-10-08 05:46:16.427948 | crc | changed: 42 replacements made 2025-10-08 05:46:16.442984 | 2025-10-08 05:46:16.443120 | TASK [prepare-crc-cloud : Remove spaces] 2025-10-08 05:46:16.790836 | crc | changed: 20 replacements made 2025-10-08 05:46:16.806485 | 2025-10-08 05:46:16.806623 | TASK [prepare-crc-cloud : Ensure you are logged in to the OpenShift] 2025-10-08 05:46:16.848894 | crc | ok 2025-10-08 05:46:16.865818 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/openshift_login.yaml 2025-10-08 05:46:16.898910 | 2025-10-08 05:46:16.899012 | TASK [prepare-crc-cloud : Login to the OpenShift] 2025-10-08 05:46:17.385454 | crc | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-08 05:46:17.492342 | crc | 2025-10-08 05:46:17.492410 | crc | Login successful. 2025-10-08 05:46:17.511460 | crc | 2025-10-08 05:46:17.511492 | crc | You have access to 65 projects, the list has been suppressed. You can list all projects with 'oc projects' 2025-10-08 05:46:17.537792 | crc | 2025-10-08 05:46:17.537877 | crc | Using project "default". 2025-10-08 05:46:17.948304 | crc | ok 2025-10-08 05:46:17.964523 | 2025-10-08 05:46:17.964712 | TASK [prepare-crc-cloud : Post tasks after crc-cloud script execution] 2025-10-08 05:46:17.997119 | crc | ok 2025-10-08 05:46:18.018728 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/post.yaml 2025-10-08 05:46:18.049827 | 2025-10-08 05:46:18.049916 | LOOP [prepare-crc-cloud : Set DNS nameservers provided by cloud provider] 2025-10-08 05:46:18.399323 | crc | changed: line added 2025-10-08 05:46:18.399838 | crc | changed: All items complete 2025-10-08 05:46:18.399904 | 2025-10-08 05:46:18.668741 | crc | changed: line added 2025-10-08 05:46:18.689541 | 2025-10-08 05:46:18.689785 | TASK [prepare-crc-cloud : Increase dnsmasq cache size] 2025-10-08 05:46:19.049584 | crc | changed: line added 2025-10-08 05:46:19.064805 | 2025-10-08 05:46:19.064945 | TASK [prepare-crc-cloud : Reload NetworkManager after adding cache and DNS server] 2025-10-08 05:46:20.994435 | crc | changed 2025-10-08 05:46:21.014135 | 2025-10-08 05:46:21.014269 | TASK [prepare-crc-cloud : Ensure kube config does not exists] 2025-10-08 05:46:21.364583 | crc | ok 2025-10-08 05:46:21.380865 | 2025-10-08 05:46:21.381004 | TASK [prepare-crc-cloud : Copy new generated KUBECONFIG] 2025-10-08 05:46:21.408379 | crc | skipping: Conditional result was False 2025-10-08 05:46:21.425356 | 2025-10-08 05:46:21.425491 | TASK [prepare-crc-cloud : Delete all openshift-marketplace pods] 2025-10-08 05:46:21.851799 | crc | pod "certified-operators-m4vgh" deleted 2025-10-08 05:46:21.860017 | crc | pod "community-operators-bzr5s" deleted 2025-10-08 05:46:21.870347 | crc | pod "marketplace-operator-79b997595-8pkjf" deleted 2025-10-08 05:46:21.880648 | crc | pod "redhat-marketplace-6pb7h" deleted 2025-10-08 05:46:21.890373 | crc | pod "redhat-operators-p9d69" deleted 2025-10-08 05:46:23.499139 | crc | ok 2025-10-08 05:46:23.514228 | 2025-10-08 05:46:23.514357 | TASK [prepare-crc-cloud : Pause machineconfigpool] 2025-10-08 05:46:23.557257 | crc | ok 2025-10-08 05:46:23.574126 | crc | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/pause_mcp.yaml 2025-10-08 05:46:23.608443 | 2025-10-08 05:46:23.608514 | LOOP [prepare-crc-cloud : Pause the machineconfig configuration if mcp is not needed] 2025-10-08 05:46:24.105228 | crc | ok 2025-10-08 05:46:24.549518 | crc | ok 2025-10-08 05:46:24.567622 | 2025-10-08 05:46:24.567878 | TASK [prepare-crc-cloud : Print current machineconfigpool] 2025-10-08 05:46:25.086906 | crc | NAME CONFIG UPDATED UPDATING DEGRADED MACHINECOUNT READYMACHINECOUNT UPDATEDMACHINECOUNT DEGRADEDMACHINECOUNT AGE 2025-10-08 05:46:25.086983 | crc | master rendered-master-f83a149c7490c3b0bf850df839837383 False True True 1 0 0 1 227d 2025-10-08 05:46:25.097445 | crc | worker rendered-worker-594cc07c9feefb5e37f2530ac457d36c True False False 0 0 0 0 227d 2025-10-08 05:46:25.153339 | crc | ok 2025-10-08 05:46:25.169492 | 2025-10-08 05:46:25.169633 | TASK [prepare-crc-cloud : Set low profile to etcd to avoid flakiness] 2025-10-08 05:46:25.197218 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.215479 | 2025-10-08 05:46:25.215650 | TASK [prepare-crc-cloud : Fix machineconfigpool degradation] 2025-10-08 05:46:25.242713 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.261258 | 2025-10-08 05:46:25.261416 | TASK [prepare-crc-cloud : Remove drain machineconfig for the node] 2025-10-08 05:46:25.288507 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.309496 | 2025-10-08 05:46:25.309727 | TASK [prepare-crc-cloud : Post machineconfigpool tasks] 2025-10-08 05:46:25.336871 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.356552 | 2025-10-08 05:46:25.356744 | TASK [prepare-crc-cloud : Enable monitoring and cluster-monitoring-operator] 2025-10-08 05:46:25.384012 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.415727 | 2025-10-08 05:46:25.415825 | TASK [Run crc-extracted preparation] 2025-10-08 05:46:25.440759 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.456233 | 2025-10-08 05:46:25.456358 | TASK [Fail when image build date does not exists] 2025-10-08 05:46:25.481638 | crc | skipping: Conditional result was False 2025-10-08 05:46:25.527362 | 2025-10-08 05:46:25.527456 | PLAY [Set IOPS and Read/Write disk limitation] 2025-10-08 05:46:25.564431 | 2025-10-08 05:46:25.564499 | TASK [Set limit for disk usage - IOPS and Read/Write] 2025-10-08 05:46:25.638010 | controller | ok 2025-10-08 05:46:25.644103 | crc | ok 2025-10-08 05:46:25.671310 | 2025-10-08 05:46:25.671377 | TASK [disk-usage-limitation : Get block device major:minor] 2025-10-08 05:46:26.100592 | crc | 252:0 2025-10-08 05:46:26.254197 | controller | 252:0 2025-10-08 05:46:26.286529 | crc | ok 2025-10-08 05:46:26.292050 | controller | ok 2025-10-08 05:46:26.297576 | 2025-10-08 05:46:26.297640 | LOOP [disk-usage-limitation : Ensure that some cgroup dirs exists] 2025-10-08 05:46:26.561046 | controller | ok: "/sys/fs/cgroup/init.scope" 2025-10-08 05:46:26.561307 | controller | ok: All items complete 2025-10-08 05:46:26.561334 | 2025-10-08 05:46:26.683493 | crc | ok: "/sys/fs/cgroup/init.scope" 2025-10-08 05:46:26.778713 | controller | changed: "/sys/fs/cgroup/machine.slice" 2025-10-08 05:46:26.998595 | controller | ok: "/sys/fs/cgroup/system.slice" 2025-10-08 05:46:27.010087 | crc | ok: "/sys/fs/cgroup/machine.slice" 2025-10-08 05:46:27.233228 | controller | ok: "/sys/fs/cgroup/user.slice" 2025-10-08 05:46:27.325285 | crc | ok: "/sys/fs/cgroup/system.slice" 2025-10-08 05:46:27.606236 | crc | ok: "/sys/fs/cgroup/user.slice" 2025-10-08 05:46:27.623804 | 2025-10-08 05:46:27.623996 | TASK [disk-usage-limitation : Enable IO limit] 2025-10-08 05:46:27.924359 | controller | changed: line replaced 2025-10-08 05:46:28.031496 | crc | changed: line replaced 2025-10-08 05:46:28.045258 | 2025-10-08 05:46:28.045401 | TASK [disk-usage-limitation : Flush handlers that will call systemd daemon-reload] 2025-10-08 05:46:28.067640 | 2025-10-08 05:46:28.067768 | TASK [disk-usage-limitation : Flush handlers that will call systemd daemon-reload] 2025-10-08 05:46:28.083658 | 2025-10-08 05:46:28.083786 | TASK [disk-usage-limitation : Reload systemd daemon after enabling IOAccounting] 2025-10-08 05:46:29.014997 | controller | ok 2025-10-08 05:46:30.046139 | crc | ok 2025-10-08 05:46:30.058460 | 2025-10-08 05:46:30.058616 | TASK [disk-usage-limitation : Wait for system.slice cgroup to have io.max file] 2025-10-08 05:46:30.369131 | controller | ok 2025-10-08 05:46:30.439302 | crc | ok 2025-10-08 05:46:30.448265 | 2025-10-08 05:46:30.448349 | LOOP [disk-usage-limitation : Set IOPS limit in the root cgroup] 2025-10-08 05:46:30.767381 | controller | ok 2025-10-08 05:46:30.767822 | controller | ok: All items complete 2025-10-08 05:46:30.767883 | 2025-10-08 05:46:30.871391 | crc | ok 2025-10-08 05:46:30.998728 | controller | ok 2025-10-08 05:46:31.185407 | crc | ok 2025-10-08 05:46:31.261967 | controller | ok 2025-10-08 05:46:31.472728 | crc | ok 2025-10-08 05:46:31.480715 | controller | ok 2025-10-08 05:46:31.774973 | crc | ok 2025-10-08 05:46:31.796979 | 2025-10-08 05:46:31.797188 | TASK [disk-usage-limitation : Verify the IOPS limit] 2025-10-08 05:46:32.196106 | crc | init 2025-10-08 05:46:32.198791 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.199598 | crc | machine 2025-10-08 05:46:32.202097 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.202500 | crc | system 2025-10-08 05:46:32.204058 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.204293 | crc | user 2025-10-08 05:46:32.206593 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.171732 | controller | init 2025-10-08 05:46:32.172527 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.172539 | controller | machine 2025-10-08 05:46:32.172546 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.172552 | controller | system 2025-10-08 05:46:32.172558 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.172564 | controller | user 2025-10-08 05:46:32.172572 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:32.421757 | controller | ok 2025-10-08 05:46:32.436165 | crc | ok 2025-10-08 05:46:32.448866 | 2025-10-08 05:46:32.449003 | TASK [disk-usage-limitation : Check if kubepods.slice exists] 2025-10-08 05:46:32.717127 | controller | ok 2025-10-08 05:46:32.742585 | crc | ok 2025-10-08 05:46:32.756448 | 2025-10-08 05:46:32.756585 | TASK [disk-usage-limitation : Set the limit] 2025-10-08 05:46:33.346571 | controller | skipping: Conditional result was False 2025-10-08 05:46:33.362341 | crc | ok 2025-10-08 05:46:33.374833 | 2025-10-08 05:46:33.374968 | TASK [disk-usage-limitation : Verify the IOPS limit - kubepods slice] 2025-10-08 05:46:33.842088 | crc | kubepods 2025-10-08 05:46:33.843947 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:33.972531 | controller | skipping: Conditional result was False 2025-10-08 05:46:33.988325 | crc | ok 2025-10-08 05:46:34.001131 | 2025-10-08 05:46:34.001262 | TASK [disk-usage-limitation : Print the current io.max value] 2025-10-08 05:46:34.085859 | controller | ok: 2025-10-08 05:46:34.086246 | controller | init 2025-10-08 05:46:34.086306 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.086349 | controller | machine 2025-10-08 05:46:34.086389 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.086426 | controller | system 2025-10-08 05:46:34.086463 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.086500 | controller | user 2025-10-08 05:46:34.086541 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.111450 | crc | ok: 2025-10-08 05:46:34.111554 | crc | init 2025-10-08 05:46:34.111605 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.111646 | crc | machine 2025-10-08 05:46:34.111737 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.111783 | crc | system 2025-10-08 05:46:34.111822 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.111884 | crc | user 2025-10-08 05:46:34.111924 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 kubepods 2025-10-08 05:46:34.111962 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-08 05:46:34.219454 | 2025-10-08 05:46:34.219557 | PLAY RECAP 2025-10-08 05:46:34.219597 | controller | ok: 9 changed: 2 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-10-08 05:46:34.219622 | crc | ok: 104 changed: 43 unreachable: 0 failed: 0 skipped: 27 rescued: 0 ignored: 0 2025-10-08 05:46:34.219640 | 2025-10-08 05:46:34.328829 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/prepare-crc.yaml@master] 2025-10-08 05:46:34.336938 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-08 05:46:34.889343 | 2025-10-08 05:46:34.889446 | PLAY [all,!compute] 2025-10-08 05:46:34.923397 | 2025-10-08 05:46:34.923480 | TASK [Enable container-tools rhel-modules for c8/crc node] 2025-10-08 05:46:35.489566 | crc | skipping: Conditional result was False 2025-10-08 05:46:35.490443 | controller | skipping: Conditional result was False 2025-10-08 05:46:35.503520 | 2025-10-08 05:46:35.503667 | TASK [Install podman] 2025-10-08 05:46:35.593738 | crc | skipping: Conditional result was False 2025-10-08 05:47:44.065795 | controller | changed 2025-10-08 05:47:44.078358 | 2025-10-08 05:47:44.078485 | TASK [Set var name for quay login zuul secret] 2025-10-08 05:47:44.160041 | crc | skipping: Conditional result was False 2025-10-08 05:47:44.160805 | controller | skipping: Conditional result was False 2025-10-08 05:47:44.173115 | 2025-10-08 05:47:44.173245 | TASK [Print the username] 2025-10-08 05:47:44.626925 | controller | openstack-k8s-operators+cirobot 2025-10-08 05:47:44.779527 | crc | skipping: Conditional result was False 2025-10-08 05:47:44.792124 | controller | ok: Runtime: 0:00:00.005657 2025-10-08 05:47:44.804570 | 2025-10-08 05:47:44.804738 | TASK [Fail when user or password is not set] 2025-10-08 05:47:44.884139 | controller | skipping: Conditional result was False 2025-10-08 05:47:44.895415 | crc | skipping: Conditional result was False 2025-10-08 05:47:44.907959 | 2025-10-08 05:47:44.908090 | TASK [Set vars for quay login] 2025-10-08 05:47:44.979225 | controller | Output suppressed because no_log was given 2025-10-08 05:47:44.991391 | 2025-10-08 05:47:44.991520 | LOOP [Perform container registry login(s) with podman] 2025-10-08 05:47:45.881420 | controller | Output suppressed because no_log was given 2025-10-08 05:47:45.893407 | 2025-10-08 05:47:45.893538 | LOOP [Perform container registry login(s) with buildah] 2025-10-08 05:47:45.971598 | controller | Output suppressed because no_log was given 2025-10-08 05:47:45.972050 | 2025-10-08 05:47:46.010123 | 2025-10-08 05:47:46.010263 | TASK [Set Insecure registry for content provider] 2025-10-08 05:47:46.081228 | controller | skipping: Conditional result was False 2025-10-08 05:47:46.083016 | crc | skipping: Conditional result was False 2025-10-08 05:47:46.162115 | 2025-10-08 05:47:46.162175 | PLAY RECAP 2025-10-08 05:47:46.162217 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-08 05:47:46.162242 | crc | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0 2025-10-08 05:47:46.162260 | 2025-10-08 05:47:46.266411 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-08 05:47:46.273457 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/data_plane_adoption/dpa_RH_subscription_registry_login.yaml@master] 2025-10-08 05:47:46.897920 | 2025-10-08 05:47:46.898029 | PLAY [rh-subscription] 2025-10-08 05:47:46.898125 | 2025-10-08 05:47:46.898168 | PLAY RECAP 2025-10-08 05:47:46.898203 | 2025-10-08 05:47:46.981577 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/data_plane_adoption/dpa_RH_subscription_registry_login.yaml@master] 2025-10-08 05:47:46.988914 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-customizations.yml@main] 2025-10-08 05:47:47.618964 | 2025-10-08 05:47:47.619084 | PLAY [Tweak CRC node] 2025-10-08 05:47:47.646071 | 2025-10-08 05:47:47.646178 | TASK [Load network parameters] 2025-10-08 05:47:48.449351 | crc | ok 2025-10-08 05:47:48.463830 | 2025-10-08 05:47:48.463980 | TASK [Check which dnsmasq config we must edit] 2025-10-08 05:47:48.903900 | crc | ok 2025-10-08 05:47:48.918253 | 2025-10-08 05:47:48.918394 | TASK [Ensure crc knows about its second NIC] 2025-10-08 05:47:49.889310 | crc | changed 2025-10-08 05:47:49.934852 | 2025-10-08 05:47:49.934996 | TASK [Ensure crc does not get "public" DNS] 2025-10-08 05:47:50.915772 | crc | changed 2025-10-08 05:47:50.934833 | 2025-10-08 05:47:50.934975 | TASK [Restart NetworkManager] 2025-10-08 05:47:52.125053 | crc | changed 2025-10-08 05:47:52.144527 | 2025-10-08 05:47:52.144663 | LOOP [Configure dns forwarders] 2025-10-08 05:47:52.637102 | crc | ok 2025-10-08 05:47:52.945136 | crc | ok 2025-10-08 05:47:52.967888 | 2025-10-08 05:47:52.968095 | TASK [Configure local DNS for CRC pod] 2025-10-08 05:47:53.479796 | crc | ok 2025-10-08 05:47:53.494353 | 2025-10-08 05:47:53.494485 | TASK [Configure dnsmasq listen-address to listen on both br-ex and ci-private-network] 2025-10-08 05:47:53.955167 | crc | changed: line added 2025-10-08 05:47:53.969531 | 2025-10-08 05:47:53.969659 | TASK [Restart native dnsmasq service] 2025-10-08 05:47:54.593445 | crc | changed 2025-10-08 05:47:54.613452 | 2025-10-08 05:47:54.613616 | TASK [Stop dnsmasq] 2025-10-08 05:47:54.641233 | crc | skipping: Conditional result was False 2025-10-08 05:47:54.657744 | 2025-10-08 05:47:54.657878 | TASK [Make sure that crc-dnsmasq is not running] 2025-10-08 05:47:54.684571 | crc | skipping: Conditional result was False 2025-10-08 05:47:54.700056 | 2025-10-08 05:47:54.700184 | TASK [Start dnsmasq] 2025-10-08 05:47:54.726667 | crc | skipping: Conditional result was False 2025-10-08 05:47:54.743730 | 2025-10-08 05:47:54.744055 | TASK [Wait for CRC to be ready] 2025-10-08 05:47:55.393895 | crc | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-08 05:47:55.564649 | crc | 2025-10-08 05:47:55.564728 | crc | Login successful. 2025-10-08 05:47:55.596603 | crc | 2025-10-08 05:47:55.596661 | crc | You have access to 65 projects, the list has been suppressed. You can list all projects with 'oc projects' 2025-10-08 05:47:55.627562 | crc | 2025-10-08 05:47:55.627616 | crc | Using project "default". 2025-10-08 05:47:55.800561 | crc | changed 2025-10-08 05:47:55.815476 | 2025-10-08 05:47:55.815609 | TASK [Set insecure registry on crc node] 2025-10-08 05:47:55.853039 | crc | skipping: Conditional result was False 2025-10-08 05:47:55.906191 | 2025-10-08 05:47:55.906267 | PLAY [Tweak Controller] 2025-10-08 05:47:55.929735 | 2025-10-08 05:47:55.929817 | TASK [Install other packages] 2025-10-08 05:48:00.681836 | controller | changed 2025-10-08 05:48:00.694852 | 2025-10-08 05:48:00.694977 | LOOP [Ensure we know compute host keys] 2025-10-08 05:48:01.183186 | controller | changed 2025-10-08 05:48:01.183477 | controller | ok: All items complete 2025-10-08 05:48:01.183534 | 2025-10-08 05:48:01.490667 | controller | changed 2025-10-08 05:48:01.510299 | 2025-10-08 05:48:01.510433 | TASK [Generate an ssh keypair] 2025-10-08 05:48:01.843483 | controller | Generating public/private ecdsa key pair. 2025-10-08 05:48:01.843535 | controller | Your identification has been saved in /home/zuul/.ssh/id_cifw 2025-10-08 05:48:01.843546 | controller | Your public key has been saved in /home/zuul/.ssh/id_cifw.pub 2025-10-08 05:48:01.843552 | controller | The key fingerprint is: 2025-10-08 05:48:01.843559 | controller | SHA256:C/wiNmB+9e84hLYWXyeCX/OhuSPa8ZBpA8U9ptka4Bc zuul@np0005475227.novalocal 2025-10-08 05:48:01.843565 | controller | The key's randomart image is: 2025-10-08 05:48:01.843571 | controller | +---[ECDSA 256]---+ 2025-10-08 05:48:01.843577 | controller | | | 2025-10-08 05:48:01.843583 | controller | | . . | 2025-10-08 05:48:01.843589 | controller | | . E + | 2025-10-08 05:48:01.843594 | controller | | o o * . | 2025-10-08 05:48:01.843600 | controller | | o *oS . | 2025-10-08 05:48:01.843606 | controller | | o . .=*o*= o | 2025-10-08 05:48:01.843612 | controller | | . =..*%+ B . | 2025-10-08 05:48:01.843617 | controller | | o oo+=B+ . | 2025-10-08 05:48:01.843623 | controller | | ...o+=o | 2025-10-08 05:48:01.843629 | controller | +----[SHA256]-----+ 2025-10-08 05:48:02.063268 | controller | changed 2025-10-08 05:48:02.076212 | 2025-10-08 05:48:02.076341 | TASK [Get public key] 2025-10-08 05:48:02.380954 | controller | ok 2025-10-08 05:48:02.393396 | 2025-10-08 05:48:02.393525 | TASK [Register pub key as a fact] 2025-10-08 05:48:02.472972 | controller | ok 2025-10-08 05:48:02.484650 | 2025-10-08 05:48:02.484808 | TASK [Load network parameters] 2025-10-08 05:48:02.773567 | controller | ok 2025-10-08 05:48:02.785904 | 2025-10-08 05:48:02.786033 | TASK [Check if cloud-init is overriding NM settings] 2025-10-08 05:48:03.172559 | controller | ok 2025-10-08 05:48:03.185240 | 2025-10-08 05:48:03.185374 | TASK [Remove cloud-init DNS override if present] 2025-10-08 05:48:03.212613 | controller | skipping: Conditional result was False 2025-10-08 05:48:03.225652 | 2025-10-08 05:48:03.225818 | TASK [Reload the NetworkManager to pick the changes] 2025-10-08 05:48:03.253052 | controller | skipping: Conditional result was False 2025-10-08 05:48:03.267958 | 2025-10-08 05:48:03.268092 | TASK [Get the default iface connection] 2025-10-08 05:48:03.689390 | controller | System eth0 2025-10-08 05:48:03.816560 | controller | changed 2025-10-08 05:48:03.828965 | 2025-10-08 05:48:03.829098 | TASK [Prepend CRC DNS server in the controllers default Network Manager connection configuation] 2025-10-08 05:48:04.442806 | controller | Connection successfully activated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/5) 2025-10-08 05:48:04.885203 | controller | changed 2025-10-08 05:48:04.937672 | 2025-10-08 05:48:04.937847 | PLAY [Ensure persistent SSH access] 2025-10-08 05:48:04.991716 | 2025-10-08 05:48:04.991809 | TASK [Inject key in ansible_user] 2025-10-08 05:48:05.625975 | crc | changed 2025-10-08 05:48:05.660515 | controller | changed 2025-10-08 05:48:05.672721 | 2025-10-08 05:48:05.672848 | TASK [Inject key in root] 2025-10-08 05:48:06.184297 | crc | changed 2025-10-08 05:48:06.197605 | controller | changed 2025-10-08 05:48:06.291960 | 2025-10-08 05:48:06.292073 | PLAY [Add cloud-admin user on Compute] 2025-10-08 05:48:06.293155 | 2025-10-08 05:48:06.293200 | PLAY [Set some fancy hostname] 2025-10-08 05:48:06.309412 | 2025-10-08 05:48:06.309469 | TASK [Inject hostname in configuration file] 2025-10-08 05:48:07.300658 | controller | changed 2025-10-08 05:48:07.344629 | 2025-10-08 05:48:07.344734 | PLAY RECAP 2025-10-08 05:48:07.344798 | controller | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-08 05:48:07.344834 | crc | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-08 05:48:07.344859 | 2025-10-08 05:48:07.454917 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-customizations.yml@main] 2025-10-08 05:48:07.457886 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-08 05:48:08.059063 | 2025-10-08 05:48:08.059176 | PLAY [Get all repos on all hosts] 2025-10-08 05:48:08.093522 | 2025-10-08 05:48:08.093611 | TASK [Clone repos in the job workspace] 2025-10-08 05:48:08.126470 | controller | ok 2025-10-08 05:48:08.132638 | crc | ok 2025-10-08 05:48:08.155172 | 2025-10-08 05:48:08.155260 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-08 05:48:08.835037 | controller | ok 2025-10-08 05:48:08.883962 | crc | ok 2025-10-08 05:48:08.892760 | 2025-10-08 05:48:08.892845 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-08 05:48:17.197507 | controller | Output suppressed because no_log was given 2025-10-08 05:48:17.631185 | crc | Output suppressed because no_log was given 2025-10-08 05:48:17.721610 | 2025-10-08 05:48:17.721791 | PLAY [Run ci/playbooks/e2e-prepare.yml] 2025-10-08 05:48:17.738803 | 2025-10-08 05:48:17.738893 | TASK [Read group_vars] 2025-10-08 05:48:17.762841 | controller | ok 2025-10-08 05:48:17.781318 | 2025-10-08 05:48:17.781395 | TASK [cifmw_helpers : Check directory is available] 2025-10-08 05:48:18.190012 | controller | ok 2025-10-08 05:48:18.204277 | 2025-10-08 05:48:18.204424 | TASK [cifmw_helpers : List dir in ansible user home] 2025-10-08 05:48:18.676203 | controller | var one 2025-10-08 05:48:18.679131 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars'$'\n': No such file or directory 2025-10-08 05:48:18.682438 | controller | all.yml 2025-10-08 05:48:18.684976 | controller | molecule 2025-10-08 05:48:18.685017 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied 2025-10-08 05:48:18.685031 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory 2025-10-08 05:48:18.766465 | controller | ERROR 2025-10-08 05:48:18.766985 | controller | { 2025-10-08 05:48:18.767052 | controller | "delta": "0:00:00.013818", 2025-10-08 05:48:18.767094 | controller | "end": "2025-10-08 05:48:18.685318", 2025-10-08 05:48:18.767136 | controller | "msg": "non-zero return code", 2025-10-08 05:48:18.767173 | controller | "rc": 2, 2025-10-08 05:48:18.767209 | controller | "start": "2025-10-08 05:48:18.671500" 2025-10-08 05:48:18.767243 | controller | } 2025-10-08 05:48:18.767293 | controller | ERROR: Ignoring Errors 2025-10-08 05:48:18.782030 | 2025-10-08 05:48:18.782180 | TASK [cifmw_helpers : List available files] 2025-10-08 05:48:19.340076 | controller | skipping: Conditional result was False 2025-10-08 05:48:19.356336 | 2025-10-08 05:48:19.356486 | LOOP [cifmw_helpers : Read vars] 2025-10-08 05:48:19.400889 | 2025-10-08 05:48:19.401298 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-08 05:48:19.458720 | 2025-10-08 05:48:19.458991 | TASK [Create zuul-output directory] 2025-10-08 05:48:19.992710 | controller | ok 2025-10-08 05:48:20.006119 | 2025-10-08 05:48:20.006261 | TASK [Install required packages] 2025-10-08 05:48:21.858748 | controller | ok: Nothing to do 2025-10-08 05:48:21.873007 | 2025-10-08 05:48:21.873150 | TASK [Output pip related things] 2025-10-08 05:48:22.585956 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9) 2025-10-08 05:48:22.932178 | controller | changed 2025-10-08 05:48:22.946034 | 2025-10-08 05:48:22.946175 | TASK [Install requirements] 2025-10-08 05:49:27.450566 | controller | changed 2025-10-08 05:49:27.479062 | 2025-10-08 05:49:27.479208 | TASK [Add cronjob to trigger job stats] 2025-10-08 05:49:27.537826 | controller | skipping: Conditional result was False 2025-10-08 05:49:27.554633 | 2025-10-08 05:49:27.554870 | LOOP [Construct project change list] 2025-10-08 05:49:27.632204 | controller | ok: 2025-10-08 05:49:27.632769 | controller | { 2025-10-08 05:49:27.632846 | controller | "branch": "main", 2025-10-08 05:49:27.632889 | controller | "change": "3237", 2025-10-08 05:49:27.632957 | controller | "change_message": "WIP: Move common variable to group_vars: cifmw_project_dir & cifmw_project_dir_absolute\n\nThere is no need to parse path, or call filters etc. to get the same value. \r\nThis specific PR takes care of ci-framework repo src path (`cifmw_project_dir` and `cifmw_project_dir_absolute`) [Link](https://issues.redhat.com/browse/OSPRH-19599) for tracking.\r\n\r\nDepends-On: https://github.com/openstack-k8s-operators/ci-framework/pull/3332\r\nDepends-On: https://github.com/openstack-k8s-operators/ci-framework/pull/3333", 2025-10-08 05:49:27.633013 | controller | "change_url": "https://github.com/openstack-k8s-operators/ci-framework/pull/3237", 2025-10-08 05:49:27.633245 | controller | "commit_id": "f73256b19c90fb94359fc527fcfcb675474058ed", 2025-10-08 05:49:27.633309 | controller | "patchset": "f73256b19c90fb94359fc527fcfcb675474058ed", 2025-10-08 05:49:27.633347 | controller | "project": { 2025-10-08 05:49:27.633384 | controller | "canonical_hostname": "github.com", 2025-10-08 05:49:27.633419 | controller | "canonical_name": "github.com/openstack-k8s-operators/ci-framework", 2025-10-08 05:49:27.633454 | controller | "name": "openstack-k8s-operators/ci-framework", 2025-10-08 05:49:27.633487 | controller | "short_name": "ci-framework", 2025-10-08 05:49:27.633520 | controller | "src_dir": "src/github.com/openstack-k8s-operators/ci-framework" 2025-10-08 05:49:27.633553 | controller | }, 2025-10-08 05:49:27.633586 | controller | "topic": null 2025-10-08 05:49:27.633618 | controller | } 2025-10-08 05:49:27.633710 | 2025-10-08 05:49:27.720058 | 2025-10-08 05:49:27.720167 | PLAY [Run ci/playbooks/build_runner_image.yml] 2025-10-08 05:49:27.756200 | 2025-10-08 05:49:27.756264 | TASK [Filter out host if needed] 2025-10-08 05:49:27.766568 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-08 05:49:27.774054 | 2025-10-08 05:49:27.774130 | TASK [Filter out host if needed] 2025-10-08 05:49:27.781932 | crc | skipping: end_host conditional evaluated to False, continuing execution for crc 2025-10-08 05:49:27.786854 | 2025-10-08 05:49:27.786907 | TASK [Get git tag for image tagging] 2025-10-08 05:49:28.385836 | controller | skipping: Conditional result was False 2025-10-08 05:49:28.386933 | crc | skipping: Conditional result was False 2025-10-08 05:49:28.400226 | 2025-10-08 05:49:28.400359 | TASK [Set openstack-runner image] 2025-10-08 05:49:28.435781 | controller | skipping: Conditional result was False 2025-10-08 05:49:28.457867 | crc | skipping: Conditional result was False 2025-10-08 05:49:28.472785 | 2025-10-08 05:49:28.472930 | TASK [Build openstack-runner image] 2025-10-08 05:49:28.502046 | controller | skipping: Conditional result was False 2025-10-08 05:49:28.523219 | crc | skipping: Conditional result was False 2025-10-08 05:49:28.532098 | 2025-10-08 05:49:28.532183 | TASK [Push openstack-runner image] 2025-10-08 05:49:28.563614 | controller | skipping: Conditional result was False 2025-10-08 05:49:28.574863 | crc | skipping: Conditional result was False 2025-10-08 05:49:28.585861 | 2025-10-08 05:49:28.585950 | TASK [Make sure ci-framework directory exists] 2025-10-08 05:49:28.618784 | controller | skipping: Conditional result was False 2025-10-08 05:49:28.629768 | crc | skipping: Conditional result was False 2025-10-08 05:49:28.638997 | 2025-10-08 05:49:28.639079 | TASK [Create EDPM ansible var file] 2025-10-08 05:49:28.670718 | controller | skipping: Conditional result was False 2025-10-08 05:49:28.681778 | crc | skipping: Conditional result was False 2025-10-08 05:49:28.739027 | 2025-10-08 05:49:28.739092 | PLAY RECAP 2025-10-08 05:49:28.739135 | controller | ok: 9 changed: 4 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 1 2025-10-08 05:49:28.739160 | crc | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0 2025-10-08 05:49:28.739177 | 2025-10-08 05:49:28.876392 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-08 05:49:28.883519 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-08 05:49:29.503713 | 2025-10-08 05:49:29.503855 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-08 05:49:29.526715 | 2025-10-08 05:49:29.526796 | TASK [Create zuul-output directory] 2025-10-08 05:49:30.205619 | controller | changed 2025-10-08 05:49:30.218257 | 2025-10-08 05:49:30.218429 | TASK [Slurp Zuul inventory test] 2025-10-08 05:49:30.662898 | controller -> localhost | ok 2025-10-08 05:49:30.678385 | 2025-10-08 05:49:30.678537 | TASK [Save zuul inventory] 2025-10-08 05:49:31.768417 | controller | changed 2025-10-08 05:49:31.781025 | 2025-10-08 05:49:31.781160 | TASK [Save zuul vars without the change_message] 2025-10-08 05:49:32.562568 | controller | changed 2025-10-08 05:49:32.606911 | 2025-10-08 05:49:32.606984 | PLAY RECAP 2025-10-08 05:49:32.607039 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 05:49:32.607065 | 2025-10-08 05:49:32.718614 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-08 05:49:32.725130 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-08 05:49:33.289730 | 2025-10-08 05:49:33.289853 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-08 05:49:33.311984 | 2025-10-08 05:49:33.312066 | TASK [Create zuul-output directory] 2025-10-08 05:49:33.848556 | controller | ok 2025-10-08 05:49:33.854190 | 2025-10-08 05:49:33.854263 | TASK [Slurp Zuul inventory test] 2025-10-08 05:49:34.294754 | controller -> localhost | ok 2025-10-08 05:49:34.304359 | 2025-10-08 05:49:34.304447 | TASK [Save zuul inventory] 2025-10-08 05:49:35.188721 | controller | ok 2025-10-08 05:49:35.201361 | 2025-10-08 05:49:35.201504 | TASK [Save zuul vars without the change_message] 2025-10-08 05:49:35.912815 | controller | ok 2025-10-08 05:49:35.962804 | 2025-10-08 05:49:35.962918 | PLAY RECAP 2025-10-08 05:49:35.962992 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 05:49:35.963023 | 2025-10-08 05:49:36.088475 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-08 05:49:36.095087 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/kuttl/run.yml@main] 2025-10-08 05:49:36.667523 | 2025-10-08 05:49:36.667660 | PLAY [Run ci/playbooks/kuttl/run.yml] 2025-10-08 05:49:36.689969 | 2025-10-08 05:49:36.690046 | TASK [Read group_vars] 2025-10-08 05:49:36.711765 | controller | ok 2025-10-08 05:49:36.729243 | 2025-10-08 05:49:36.729318 | TASK [cifmw_helpers : Check directory is available] 2025-10-08 05:49:37.305525 | controller | ok 2025-10-08 05:49:37.319774 | 2025-10-08 05:49:37.319911 | TASK [cifmw_helpers : List dir in ansible user home] 2025-10-08 05:49:37.750122 | controller | var one 2025-10-08 05:49:37.751714 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars'$'\n': No such file or directory 2025-10-08 05:49:37.753710 | controller | all.yml 2025-10-08 05:49:37.754948 | controller | molecule 2025-10-08 05:49:37.754963 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied 2025-10-08 05:49:37.754973 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory 2025-10-08 05:49:37.872529 | controller | ERROR 2025-10-08 05:49:37.872963 | controller | { 2025-10-08 05:49:37.873043 | controller | "delta": "0:00:00.010066", 2025-10-08 05:49:37.873091 | controller | "end": "2025-10-08 05:49:37.755324", 2025-10-08 05:49:37.873131 | controller | "msg": "non-zero return code", 2025-10-08 05:49:37.873167 | controller | "rc": 2, 2025-10-08 05:49:37.873215 | controller | "start": "2025-10-08 05:49:37.745258" 2025-10-08 05:49:37.873252 | controller | } 2025-10-08 05:49:37.873304 | controller | ERROR: Ignoring Errors 2025-10-08 05:49:37.890283 | 2025-10-08 05:49:37.890423 | TASK [cifmw_helpers : List available files] 2025-10-08 05:49:38.449879 | controller | skipping: Conditional result was False 2025-10-08 05:49:38.466104 | 2025-10-08 05:49:38.466330 | LOOP [cifmw_helpers : Read vars] 2025-10-08 05:49:38.510099 | 2025-10-08 05:49:38.510384 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-08 05:49:38.564845 | 2025-10-08 05:49:38.565129 | TASK [Run kuttl tests playbook] 2025-10-08 05:49:49.119541 | controller | ERROR 2025-10-08 05:49:49.120014 | controller | { 2025-10-08 05:49:49.120090 | controller | "msg": "The task includes an option with an undefined variable. The error was: 'cifmw_project_dir_absolute' is undefined. 'cifmw_project_dir_absolute' is undefined\n\nThe error appears to be in '/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/untrusted/project_0/github.com/openstack-k8s-operators/ci-framework/ci/playbooks/kuttl/run.yml': line 17, column 7, but may\nbe elsewhere in the file depending on the exact syntax problem.\n\nThe offending line appears to be:\n\n\n - name: Run kuttl tests playbook\n ^ here\n" 2025-10-08 05:49:49.120141 | controller | } failure 2025-10-08 05:49:49.124150 | 2025-10-08 05:49:49.124261 | PLAY RECAP 2025-10-08 05:49:49.124351 | controller | ok: 2 changed: 1 unreachable: 0 failed: 1 skipped: 3 rescued: 0 ignored: 1 2025-10-08 05:49:49.124398 | 2025-10-08 05:49:49.249338 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/kuttl/run.yml@main] 2025-10-08 05:49:49.252526 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-collect-logs.yml@main] 2025-10-08 05:49:49.838650 | ANSIBLE PARSE ERROR 2025-10-08 05:49:49.838670 | Using /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/ansible/post_playbook_0/ansible.cfg as config file 2025-10-08 05:49:49.838735 | ERROR! We were unable to read either as JSON nor YAML, these are the errors we got from each: 2025-10-08 05:49:49.838743 | JSON: Expecting value: line 1 column 1 (char 0) 2025-10-08 05:49:49.838751 | 2025-10-08 05:49:49.838758 | Syntax Error while loading YAML. 2025-10-08 05:49:49.838764 | did not find expected '-' indicator 2025-10-08 05:49:49.838771 | 2025-10-08 05:49:49.838777 | The error appears to be in '/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/untrusted/project_0/github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-collect-logs.yml': line 50, column 6, but may 2025-10-08 05:49:49.838784 | be elsewhere in the file depending on the exact syntax problem. 2025-10-08 05:49:49.838790 | 2025-10-08 05:49:49.838797 | The offending line appears to be: 2025-10-08 05:49:49.838803 | 2025-10-08 05:49:49.838809 | - logs 2025-10-08 05:49:49.838816 | environment: 2025-10-08 05:49:49.838823 | ^ here 2025-10-08 05:49:49.839330 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-collect-logs.yml@main] 2025-10-08 05:49:49.846311 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-08 05:49:50.478145 | 2025-10-08 05:49:50.478260 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-08 05:49:50.513119 | 2025-10-08 05:49:50.513213 | TASK [Filter out host if needed] 2025-10-08 05:49:50.524142 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-08 05:49:50.530022 | 2025-10-08 05:49:50.530085 | TASK [Filter out host if needed] 2025-10-08 05:49:50.544757 | 2025-10-08 05:49:50.544831 | TASK [Ensure file is present] 2025-10-08 05:49:51.071611 | controller | ok 2025-10-08 05:49:51.084935 | 2025-10-08 05:49:51.085067 | TASK [Manage molecule report file] 2025-10-08 05:49:51.681361 | controller | skipping: Conditional result was False 2025-10-08 05:49:51.694878 | 2025-10-08 05:49:51.695023 | TASK [Check if we get ci-framework-data basedir] 2025-10-08 05:49:51.960112 | controller | ok 2025-10-08 05:49:51.975154 | 2025-10-08 05:49:51.975297 | TASK [Create ci-framework-data log directory for zuul] 2025-10-08 05:49:52.362024 | controller | changed 2025-10-08 05:49:52.375297 | 2025-10-08 05:49:52.375429 | TASK [Copy ci-framework interesting files] 2025-10-08 05:49:52.790376 | controller | cp: cannot stat '/home/zuul/ci-framework-data/logs': No such file or directory 2025-10-08 05:49:52.794871 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-08 05:49:52.982863 | controller | changed 2025-10-08 05:49:52.990879 | 2025-10-08 05:49:52.990967 | TASK [Get SELinux listing] 2025-10-08 05:49:53.580426 | controller | changed 2025-10-08 05:49:53.594829 | 2025-10-08 05:49:53.594959 | TASK [Generate log index] 2025-10-08 05:49:54.489077 | controller | changed 2025-10-08 05:49:54.503123 | 2025-10-08 05:49:54.503252 | TASK [Get some env related data] 2025-10-08 05:49:55.260545 | controller | /home/zuul/.local/bin/ansible 2025-10-08 05:49:56.097837 | controller | changed 2025-10-08 05:49:56.110423 | 2025-10-08 05:49:56.110550 | TASK [Generate list of logs to collect in home directory] 2025-10-08 05:49:56.457343 | controller | ok: All paths examined 2025-10-08 05:49:56.470183 | 2025-10-08 05:49:56.470331 | LOOP [Copy logs from home directory] 2025-10-08 05:49:56.892133 | controller | changed: 2025-10-08 05:49:56.892360 | controller | { 2025-10-08 05:49:56.892385 | controller | "atime": 1759902550.0869, 2025-10-08 05:49:56.892402 | controller | "ctime": 1759902566.923351, 2025-10-08 05:49:56.892419 | controller | "dev": 64513, 2025-10-08 05:49:56.892435 | controller | "gid": 1000, 2025-10-08 05:49:56.892450 | controller | "gr_name": "zuul", 2025-10-08 05:49:56.892465 | controller | "inode": 4519413, 2025-10-08 05:49:56.892479 | controller | "isblk": false, 2025-10-08 05:49:56.892493 | controller | "ischr": false, 2025-10-08 05:49:56.892508 | controller | "isdir": false, 2025-10-08 05:49:56.892522 | controller | "isfifo": false, 2025-10-08 05:49:56.892536 | controller | "isgid": false, 2025-10-08 05:49:56.892551 | controller | "islnk": false, 2025-10-08 05:49:56.892565 | controller | "isreg": true, 2025-10-08 05:49:56.892579 | controller | "issock": false, 2025-10-08 05:49:56.892593 | controller | "isuid": false, 2025-10-08 05:49:56.892607 | controller | "mode": "0644", 2025-10-08 05:49:56.892625 | controller | "mtime": 1759902566.923351, 2025-10-08 05:49:56.892641 | controller | "nlink": 1, 2025-10-08 05:49:56.892657 | controller | "path": "/home/zuul/ansible.log", 2025-10-08 05:49:56.892672 | controller | "pw_name": "zuul", 2025-10-08 05:49:56.892718 | controller | "rgrp": true, 2025-10-08 05:49:56.892734 | controller | "roth": true, 2025-10-08 05:49:56.892749 | controller | "rusr": true, 2025-10-08 05:49:56.892764 | controller | "size": 6749, 2025-10-08 05:49:56.892781 | controller | "uid": 1000, 2025-10-08 05:49:56.892797 | controller | "wgrp": false, 2025-10-08 05:49:56.892812 | controller | "woth": false, 2025-10-08 05:49:56.892827 | controller | "wusr": true, 2025-10-08 05:49:56.892842 | controller | "xgrp": false, 2025-10-08 05:49:56.892857 | controller | "xoth": false, 2025-10-08 05:49:56.892871 | controller | "xusr": false 2025-10-08 05:49:56.892886 | controller | } 2025-10-08 05:49:56.910297 | 2025-10-08 05:49:56.910510 | TASK [Copy crio stats log file] 2025-10-08 05:49:56.938091 | controller | skipping: Conditional result was False 2025-10-08 05:49:56.953592 | 2025-10-08 05:49:56.953759 | TASK [Get SELinux related data] 2025-10-08 05:49:57.341335 | controller | 2025-10-08 05:49:57.581374 | controller | ERROR 2025-10-08 05:49:57.581730 | controller | { 2025-10-08 05:49:57.581801 | controller | "delta": "0:00:00.013873", 2025-10-08 05:49:57.581842 | controller | "end": "2025-10-08 05:49:57.341962", 2025-10-08 05:49:57.581878 | controller | "msg": "non-zero return code", 2025-10-08 05:49:57.581912 | controller | "rc": 1, 2025-10-08 05:49:57.581947 | controller | "start": "2025-10-08 05:49:57.328089" 2025-10-08 05:49:57.581980 | controller | } 2025-10-08 05:49:57.582026 | controller | ERROR: Ignoring Errors 2025-10-08 05:49:57.594651 | 2025-10-08 05:49:57.594833 | TASK [Create system configuration directory] 2025-10-08 05:49:57.829262 | controller | changed 2025-10-08 05:49:57.848820 | 2025-10-08 05:49:57.848956 | TASK [Get some of the system configurations] 2025-10-08 05:49:58.437290 | controller | changed 2025-10-08 05:49:58.450364 | 2025-10-08 05:49:58.450514 | TASK [Copy generated documentation if available] 2025-10-08 05:49:58.478770 | controller | skipping: Conditional result was False 2025-10-08 05:49:58.493039 | 2025-10-08 05:49:58.493176 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-08 05:49:58.521753 | controller | skipping: Conditional result was False 2025-10-08 05:49:58.536442 | 2025-10-08 05:49:58.536573 | TASK [Compress logs bigger than 2MB] 2025-10-08 05:49:59.137291 | controller | changed 2025-10-08 05:49:59.150451 | 2025-10-08 05:49:59.150624 | TASK [Copy files from workspace on node] 2025-10-08 05:49:59.181752 | controller | ok 2025-10-08 05:49:59.224337 | 2025-10-08 05:49:59.224434 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-08 05:49:59.283739 | controller | ok 2025-10-08 05:49:59.295967 | 2025-10-08 05:49:59.296097 | TASK [fetch-output : Set log path for single node] 2025-10-08 05:49:59.323639 | controller | skipping: Conditional result was False 2025-10-08 05:49:59.333081 | 2025-10-08 05:49:59.333172 | LOOP [fetch-output : Ensure local output dirs] 2025-10-08 05:49:59.592342 | controller -> localhost | changed: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/logs/controller" 2025-10-08 05:49:59.592742 | controller -> localhost | changed: All items complete 2025-10-08 05:49:59.592795 | 2025-10-08 05:49:59.805203 | controller -> localhost | changed: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/artifacts" 2025-10-08 05:50:00.021004 | controller -> localhost | changed: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/docs" 2025-10-08 05:50:00.047968 | 2025-10-08 05:50:00.048191 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-08 05:50:00.699526 | controller | changed: 2025-10-08 05:50:00.699769 | controller | .d..t...... ./ 2025-10-08 05:50:00.699800 | controller | >f+++++++++ README.html 2025-10-08 05:50:00.699820 | controller | >f+++++++++ ansible.log 2025-10-08 05:50:00.704769 | controller | >f+++++++++ dmesg.log 2025-10-08 05:50:00.704808 | controller | >f+++++++++ installed-pkgs.log 2025-10-08 05:50:00.704833 | controller | >f+++++++++ python.log 2025-10-08 05:50:00.704858 | controller | >f+++++++++ registries.conf 2025-10-08 05:50:00.704881 | controller | >f+++++++++ selinux-denials.log 2025-10-08 05:50:00.704903 | controller | >f+++++++++ selinux-listing.log 2025-10-08 05:50:00.708717 | controller | cd+++++++++ ci-framework-data/ 2025-10-08 05:50:00.708761 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-08 05:50:00.708783 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-08 05:50:00.708802 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-08 05:50:00.708819 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-08 05:50:00.708836 | controller | cd+++++++++ registries.conf.d/ 2025-10-08 05:50:00.708853 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-08 05:50:00.708873 | controller | cd+++++++++ system-config/ 2025-10-08 05:50:00.708889 | controller | cd+++++++++ system-config/libvirt/ 2025-10-08 05:50:00.708905 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-08 05:50:00.708921 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-08 05:50:01.179552 | controller | changed: .d..t...... ./ 2025-10-08 05:50:01.625666 | controller | changed: .d..t...... ./ 2025-10-08 05:50:01.660916 | 2025-10-08 05:50:01.661144 | TASK [Return artifact to Zuul] 2025-10-08 05:50:01.699760 | controller | skipping: Conditional result was False 2025-10-08 05:50:01.748791 | 2025-10-08 05:50:01.748871 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-08 05:50:01.776793 | 2025-10-08 05:50:01.776897 | TASK [Get kubelet journalctl logs] 2025-10-08 05:50:02.854661 | crc | Output suppressed because no_log was given 2025-10-08 05:50:02.909178 | 2025-10-08 05:50:02.909253 | PLAY RECAP 2025-10-08 05:50:02.909308 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-10-08 05:50:02.909352 | crc | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 05:50:02.909377 | 2025-10-08 05:50:03.032602 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-08 05:50:03.035765 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-autohold.yml@main] 2025-10-08 05:50:03.638105 | 2025-10-08 05:50:03.638218 | PLAY [Run ci/playbooks/multinode-autohold.yml] 2025-10-08 05:50:03.660858 | 2025-10-08 05:50:03.660932 | TASK [Verify if "success" flag exists after successful tests execution] 2025-10-08 05:50:04.159608 | controller | ok 2025-10-08 05:50:04.165309 | 2025-10-08 05:50:04.165378 | TASK [Fetch existing autoholds from zuul] 2025-10-08 05:50:04.234142 | controller | ok 2025-10-08 05:50:04.268123 | 2025-10-08 05:50:04.268308 | TASK [krb_request : Perform the request] 2025-10-08 05:50:04.887170 | controller | ok 2025-10-08 05:50:04.911821 | 2025-10-08 05:50:04.911941 | TASK [Check if any autohold matches] 2025-10-08 05:50:05.008236 | controller | skipping: Conditional result was False 2025-10-08 05:50:05.057422 | 2025-10-08 05:50:05.057528 | PLAY RECAP 2025-10-08 05:50:05.057582 | controller | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-08 05:50:05.057609 | 2025-10-08 05:50:05.165798 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-autohold.yml@main] 2025-10-08 05:50:05.169208 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/print-machineconfigpool.yaml@master] 2025-10-08 05:50:05.734867 | 2025-10-08 05:50:05.734989 | PLAY [crc] 2025-10-08 05:50:05.761840 | 2025-10-08 05:50:05.761938 | TASK [Print machineconfigpool] 2025-10-08 05:50:06.670114 | crc | NAME CONFIG UPDATED UPDATING DEGRADED MACHINECOUNT READYMACHINECOUNT UPDATEDMACHINECOUNT DEGRADEDMACHINECOUNT AGE 2025-10-08 05:50:06.670217 | crc | master rendered-master-f83a149c7490c3b0bf850df839837383 False False True 1 0 0 1 227d 2025-10-08 05:50:06.678882 | crc | worker rendered-worker-594cc07c9feefb5e37f2530ac457d36c True False False 0 0 0 0 227d 2025-10-08 05:50:06.799448 | crc | changed 2025-10-08 05:50:06.849401 | 2025-10-08 05:50:06.849480 | PLAY RECAP 2025-10-08 05:50:06.849540 | crc | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 05:50:06.849568 | 2025-10-08 05:50:06.953758 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/print-machineconfigpool.yaml@master] 2025-10-08 05:50:06.960646 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/compress-crc-cloud-logs.yaml@master] 2025-10-08 05:50:07.546042 | 2025-10-08 05:50:07.546156 | PLAY [crc] 2025-10-08 05:50:07.572332 | 2025-10-08 05:50:07.572422 | TASK [Create compressed log tar gz file - crc-cloud logs] 2025-10-08 05:50:08.337883 | crc | tar: Removing leading `/' from member names 2025-10-08 05:50:08.345314 | crc | tar: /var/home/core/workdir/*log: Cannot stat: No such file or directory 2025-10-08 05:50:08.345373 | crc | tar: Exiting with failure status due to previous errors 2025-10-08 05:50:08.612549 | crc | ok 2025-10-08 05:50:08.627614 | 2025-10-08 05:50:08.627784 | TASK [Copy crc-cloud logs] 2025-10-08 05:50:09.019259 | crc | cp: cannot stat '/var/home/core/workdir/*log': No such file or directory 2025-10-08 05:50:09.193011 | crc | ok 2025-10-08 05:50:09.250456 | 2025-10-08 05:50:09.250563 | PLAY RECAP 2025-10-08 05:50:09.250626 | crc | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-08 05:50:09.250654 | 2025-10-08 05:50:09.361107 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/compress-crc-cloud-logs.yaml@master] 2025-10-08 05:50:09.368239 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/compress-logs.yaml@master] 2025-10-08 05:50:09.970464 | 2025-10-08 05:50:09.970608 | PLAY [all] 2025-10-08 05:50:10.006160 | 2025-10-08 05:50:10.006265 | TASK [Create compressed log tar gz file - ci-framework-data] 2025-10-08 05:50:10.652021 | controller | tar: Removing leading `/' from member names 2025-10-08 05:50:10.660752 | controller | mv: cannot move '/home/zuul/ci-framework-data-controller-all-logs.tar.gz' to '/home/zuul/ci-framework-data/logs/ci-framework-data-controller-all-logs.tar.gz': No such file or directory 2025-10-08 05:50:10.662773 | controller | chown: cannot access '/home/zuul/ci-framework-data/logs/ci-framework-data-controller-all-logs.tar.gz': No such file or directory 2025-10-08 05:50:10.701895 | crc | tar: Removing leading `/' from member names 2025-10-08 05:50:10.702053 | crc | tar: /var/home/core/ci-framework-data: Cannot stat: No such file or directory 2025-10-08 05:50:10.704755 | crc | tar: Exiting with failure status due to previous errors 2025-10-08 05:50:10.708279 | crc | mv: cannot move '/var/home/core/ci-framework-data-crc-all-logs.tar.gz' to '/var/home/core/ci-framework-data/logs/ci-framework-data-crc-all-logs.tar.gz': No such file or directory 2025-10-08 05:50:10.709981 | crc | chown: cannot access '/var/home/core/ci-framework-data/logs/ci-framework-data-crc-all-logs.tar.gz': No such file or directory 2025-10-08 05:50:11.070430 | controller | ERROR 2025-10-08 05:50:11.070951 | controller | { 2025-10-08 05:50:11.071038 | controller | "delta": "0:00:00.023465", 2025-10-08 05:50:11.071094 | controller | "end": "2025-10-08 05:50:10.663160", 2025-10-08 05:50:11.071143 | controller | "msg": "non-zero return code", 2025-10-08 05:50:11.071188 | controller | "rc": 1, 2025-10-08 05:50:11.071232 | controller | "start": "2025-10-08 05:50:10.639695" 2025-10-08 05:50:11.071283 | controller | } 2025-10-08 05:50:11.071364 | controller | ERROR: Ignoring Errors 2025-10-08 05:50:11.086614 | crc | ERROR 2025-10-08 05:50:11.086797 | crc | { 2025-10-08 05:50:11.086856 | crc | "delta": "0:00:00.015512", 2025-10-08 05:50:11.086898 | crc | "end": "2025-10-08 05:50:10.710348", 2025-10-08 05:50:11.086935 | crc | "msg": "non-zero return code", 2025-10-08 05:50:11.086972 | crc | "rc": 1, 2025-10-08 05:50:11.087009 | crc | "start": "2025-10-08 05:50:10.694836" 2025-10-08 05:50:11.087045 | crc | } 2025-10-08 05:50:11.087091 | crc | ERROR: Ignoring Errors 2025-10-08 05:50:11.099268 | 2025-10-08 05:50:11.099403 | TASK [Create compressed log tar gz file - zuul-output] 2025-10-08 05:50:11.524213 | controller | tar: Removing leading `/' from member names 2025-10-08 05:50:11.541785 | crc | tar: Removing leading `/' from member names 2025-10-08 05:50:11.697984 | controller | ok 2025-10-08 05:50:11.714072 | crc | ok 2025-10-08 05:50:11.788873 | 2025-10-08 05:50:11.788955 | PLAY RECAP 2025-10-08 05:50:11.788997 | controller | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2025-10-08 05:50:11.789022 | crc | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2025-10-08 05:50:11.789040 | 2025-10-08 05:50:11.886620 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/compress-logs.yaml@master] 2025-10-08 05:50:11.894212 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup.yml@master] 2025-10-08 05:50:12.478787 | 2025-10-08 05:50:12.478897 | PLAY [Run playbooks/crc/bootstraped-ci-network-cleanup.yml] 2025-10-08 05:50:12.500519 | 2025-10-08 05:50:12.500597 | TASK [Create openstack config dir] 2025-10-08 05:50:13.055963 | controller | ok 2025-10-08 05:50:13.061891 | 2025-10-08 05:50:13.061962 | TASK [Check for cleanup skip flag file presence] 2025-10-08 05:50:13.444570 | controller | ok 2025-10-08 05:50:13.457494 | 2025-10-08 05:50:13.457634 | TASK [Generate clouds config from cloud_secrets secret] 2025-10-08 05:50:14.434093 | controller | changed 2025-10-08 05:50:14.447160 | 2025-10-08 05:50:14.447296 | LOOP [Delete ports from each host] 2025-10-08 05:50:14.524604 | controller | ok: "crc" 2025-10-08 05:50:17.533990 | controller | ok: "controller" 2025-10-08 05:50:17.557433 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup-instance-ports.yml 2025-10-08 05:50:17.564980 | controller | included: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup-instance-ports.yml 2025-10-08 05:50:17.580259 | 2025-10-08 05:50:17.580405 | TASK [Fetch port info] 2025-10-08 05:50:19.408302 | controller | admin_state_up: true 2025-10-08 05:50:19.408791 | controller | allowed_address_pairs: [] 2025-10-08 05:50:19.409028 | controller | binding_host_id: null 2025-10-08 05:50:19.409168 | controller | binding_profile: {} 2025-10-08 05:50:19.409315 | controller | binding_vif_details: {} 2025-10-08 05:50:19.409442 | controller | binding_vif_type: null 2025-10-08 05:50:19.409596 | controller | binding_vnic_type: normal 2025-10-08 05:50:19.409755 | controller | created_at: '2025-10-08T05:40:15Z' 2025-10-08 05:50:19.409886 | controller | data_plane_status: null 2025-10-08 05:50:19.410060 | controller | description: '' 2025-10-08 05:50:19.410212 | controller | device_id: 4394bc66-4ac8-4c29-b7ea-ad1631ce1848 2025-10-08 05:50:19.410337 | controller | device_owner: compute:nova 2025-10-08 05:50:19.410461 | controller | device_profile: null 2025-10-08 05:50:19.410911 | controller | dns_assignment: 2025-10-08 05:50:19.411069 | controller | - fqdn: host-192-168-122-10.openstacklocal. 2025-10-08 05:50:19.411084 | controller | hostname: host-192-168-122-10 2025-10-08 05:50:19.411093 | controller | ip_address: 192.168.122.10 2025-10-08 05:50:19.411104 | controller | dns_domain: '' 2025-10-08 05:50:19.411270 | controller | dns_name: '' 2025-10-08 05:50:19.411438 | controller | extra_dhcp_opts: [] 2025-10-08 05:50:19.411792 | controller | fixed_ips: 2025-10-08 05:50:19.411977 | controller | - ip_address: 192.168.122.10 2025-10-08 05:50:19.411993 | controller | subnet_id: b6567535-aaa0-450c-a406-db46c72e4961 2025-10-08 05:50:19.412005 | controller | hardware_offload_type: null 2025-10-08 05:50:19.412129 | controller | hints: '' 2025-10-08 05:50:19.412265 | controller | id: fc326d07-0057-4feb-bb19-68fa5a43220f 2025-10-08 05:50:19.412410 | controller | ip_allocation: immediate 2025-10-08 05:50:19.412545 | controller | mac_address: fa:16:3e:30:04:94 2025-10-08 05:50:19.412710 | controller | name: crc-4394bc66-4ac8-4c29-b7ea-ad1631ce1848 2025-10-08 05:50:19.412874 | controller | network_id: 210324df-ec00-4234-a83d-72c09c28c095 2025-10-08 05:50:19.413008 | controller | numa_affinity_policy: null 2025-10-08 05:50:19.413170 | controller | port_security_enabled: false 2025-10-08 05:50:19.413326 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-08 05:50:19.413482 | controller | propagate_uplink_status: null 2025-10-08 05:50:19.413610 | controller | resource_request: null 2025-10-08 05:50:19.413810 | controller | revision_number: 4 2025-10-08 05:50:19.413945 | controller | qos_network_policy_id: null 2025-10-08 05:50:19.414068 | controller | qos_policy_id: null 2025-10-08 05:50:19.414193 | controller | security_group_ids: [] 2025-10-08 05:50:19.414312 | controller | status: ACTIVE 2025-10-08 05:50:19.414435 | controller | tags: [] 2025-10-08 05:50:19.414559 | controller | trunk_details: null 2025-10-08 05:50:19.414702 | controller | trusted: null 2025-10-08 05:50:19.414848 | controller | updated_at: '2025-10-08T05:40:28Z' 2025-10-08 05:50:19.637670 | controller | changed 2025-10-08 05:50:19.652043 | 2025-10-08 05:50:19.652181 | TASK [Set port info yaml for further usage] 2025-10-08 05:50:19.746483 | controller | ok 2025-10-08 05:50:19.759362 | 2025-10-08 05:50:19.759495 | TASK [Detach port] 2025-10-08 05:50:22.344051 | controller | changed 2025-10-08 05:50:22.356759 | 2025-10-08 05:50:22.356900 | LOOP [Delete port association with trunk network] 2025-10-08 05:50:22.438726 | 2025-10-08 05:50:22.439030 | LOOP [Delete trunk sub ports (tagged ones)] 2025-10-08 05:50:22.500576 | 2025-10-08 05:50:22.500869 | TASK [Delete the trunk network itself] 2025-10-08 05:50:23.053957 | controller | skipping: Conditional result was False 2025-10-08 05:50:23.068532 | 2025-10-08 05:50:23.068728 | TASK [Remove the parent/trunk port itself] 2025-10-08 05:50:35.666153 | controller | changed 2025-10-08 05:50:35.679541 | 2025-10-08 05:50:35.679733 | TASK [Fetch port info] 2025-10-08 05:50:47.751667 | controller | admin_state_up: true 2025-10-08 05:50:47.751815 | controller | allowed_address_pairs: [] 2025-10-08 05:50:47.751977 | controller | binding_host_id: null 2025-10-08 05:50:47.752080 | controller | binding_profile: {} 2025-10-08 05:50:47.752203 | controller | binding_vif_details: {} 2025-10-08 05:50:47.752326 | controller | binding_vif_type: null 2025-10-08 05:50:47.752505 | controller | binding_vnic_type: normal 2025-10-08 05:50:47.752655 | controller | created_at: '2025-10-08T05:39:58Z' 2025-10-08 05:50:47.752809 | controller | data_plane_status: null 2025-10-08 05:50:47.752931 | controller | description: '' 2025-10-08 05:50:47.753047 | controller | device_id: 64566401-8ea6-4640-9549-ca80c08688ae 2025-10-08 05:50:47.753143 | controller | device_owner: compute:nova 2025-10-08 05:50:47.753236 | controller | device_profile: null 2025-10-08 05:50:47.753532 | controller | dns_assignment: 2025-10-08 05:50:47.753621 | controller | - fqdn: host-192-168-122-11.openstacklocal. 2025-10-08 05:50:47.753628 | controller | hostname: host-192-168-122-11 2025-10-08 05:50:47.753634 | controller | ip_address: 192.168.122.11 2025-10-08 05:50:47.753642 | controller | dns_domain: '' 2025-10-08 05:50:47.753729 | controller | dns_name: '' 2025-10-08 05:50:47.753855 | controller | extra_dhcp_opts: [] 2025-10-08 05:50:47.754078 | controller | fixed_ips: 2025-10-08 05:50:47.754211 | controller | - ip_address: 192.168.122.11 2025-10-08 05:50:47.754219 | controller | subnet_id: b6567535-aaa0-450c-a406-db46c72e4961 2025-10-08 05:50:47.754227 | controller | hardware_offload_type: null 2025-10-08 05:50:47.754319 | controller | hints: '' 2025-10-08 05:50:47.754601 | controller | id: d88421f4-0eff-4188-9863-2bbeafc9e49a 2025-10-08 05:50:47.754719 | controller | ip_allocation: immediate 2025-10-08 05:50:47.754823 | controller | mac_address: fa:16:3e:2a:41:35 2025-10-08 05:50:47.754941 | controller | name: controller-64566401-8ea6-4640-9549-ca80c08688ae 2025-10-08 05:50:47.755086 | controller | network_id: 210324df-ec00-4234-a83d-72c09c28c095 2025-10-08 05:50:47.755191 | controller | numa_affinity_policy: null 2025-10-08 05:50:47.755320 | controller | port_security_enabled: false 2025-10-08 05:50:47.755613 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-08 05:50:47.755730 | controller | propagate_uplink_status: null 2025-10-08 05:50:47.755831 | controller | resource_request: null 2025-10-08 05:50:47.755981 | controller | revision_number: 4 2025-10-08 05:50:47.756110 | controller | qos_network_policy_id: null 2025-10-08 05:50:47.756236 | controller | qos_policy_id: null 2025-10-08 05:50:47.756381 | controller | security_group_ids: [] 2025-10-08 05:50:47.756510 | controller | status: ACTIVE 2025-10-08 05:50:47.756635 | controller | tags: [] 2025-10-08 05:50:47.756837 | controller | trunk_details: null 2025-10-08 05:50:47.756938 | controller | trusted: null 2025-10-08 05:50:47.757082 | controller | updated_at: '2025-10-08T05:40:15Z' 2025-10-08 05:50:48.255757 | controller | changed 2025-10-08 05:50:48.270432 | 2025-10-08 05:50:48.270592 | TASK [Set port info yaml for further usage] 2025-10-08 05:50:48.365289 | controller | ok 2025-10-08 05:50:48.378944 | 2025-10-08 05:50:48.379087 | TASK [Detach port] 2025-10-08 05:51:04.953140 | controller | changed 2025-10-08 05:51:04.966792 | 2025-10-08 05:51:04.966944 | LOOP [Delete port association with trunk network] 2025-10-08 05:51:05.048255 | 2025-10-08 05:51:05.048535 | LOOP [Delete trunk sub ports (tagged ones)] 2025-10-08 05:51:05.119297 | 2025-10-08 05:51:05.119576 | TASK [Delete the trunk network itself] 2025-10-08 05:51:05.703598 | controller | skipping: Conditional result was False 2025-10-08 05:51:05.718600 | 2025-10-08 05:51:05.718787 | TASK [Remove the parent/trunk port itself] 2025-10-08 05:51:18.792211 | controller | changed 2025-10-08 05:51:18.806406 | 2025-10-08 05:51:18.806579 | TASK [Dettach router from subnet] 2025-10-08 05:51:19.365023 | controller | skipping: Conditional result was False 2025-10-08 05:51:19.379094 | 2025-10-08 05:51:19.379264 | TASK [Delete router] 2025-10-08 05:51:19.940339 | controller | skipping: Conditional result was False 2025-10-08 05:51:19.954355 | 2025-10-08 05:51:19.954509 | TASK [Delete subnet] 2025-10-08 05:51:27.540659 | controller | changed 2025-10-08 05:51:27.554232 | 2025-10-08 05:51:27.554372 | TASK [Delete network] 2025-10-08 05:51:41.627128 | controller | changed 2025-10-08 05:51:41.640220 | 2025-10-08 05:51:41.640354 | TASK [Remove clouds.yml secret] 2025-10-08 05:51:41.955959 | controller | changed 2025-10-08 05:51:42.001508 | 2025-10-08 05:51:42.001648 | PLAY RECAP 2025-10-08 05:51:42.001736 | controller | ok: 16 changed: 10 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-08 05:51:42.001767 | 2025-10-08 05:51:42.116405 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup.yml@master] 2025-10-08 05:51:42.123341 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-08 05:51:42.711176 | 2025-10-08 05:51:42.711295 | PLAY [Report DLRN results after job run] 2025-10-08 05:51:42.735392 | 2025-10-08 05:51:42.735490 | TASK [Report job status to DLRN] 2025-10-08 05:51:42.756940 | controller | ok 2025-10-08 05:51:42.781004 | 2025-10-08 05:51:42.781083 | TASK [dlrn_report : Warning if DLRN is not running] 2025-10-08 05:51:42.845644 | controller | skipping: Conditional result was False 2025-10-08 05:51:42.852303 | 2025-10-08 05:51:42.852373 | TASK [dlrn_report : Install dlrnapi-client shyaml package] 2025-10-08 05:51:42.907346 | controller | skipping: Conditional result was False 2025-10-08 05:51:42.922348 | 2025-10-08 05:51:42.922520 | TASK [dlrn_report : Install kinit related package] 2025-10-08 05:51:42.969380 | controller | skipping: Conditional result was False 2025-10-08 05:51:42.983203 | 2025-10-08 05:51:42.983349 | TASK [dlrn_report : Install dlrn kerberos related packages] 2025-10-08 05:51:43.030537 | controller | skipping: Conditional result was False 2025-10-08 05:51:43.044879 | 2025-10-08 05:51:43.045019 | TASK [Set zuul-log-path fact] 2025-10-08 05:51:43.092046 | controller | skipping: Conditional result was False 2025-10-08 05:51:43.109138 | 2025-10-08 05:51:43.109279 | TASK [dlrn_report : Set the the value of cifmw_repo_setup_promotion when multiple dlrn tags are used] 2025-10-08 05:51:43.156191 | controller | skipping: Conditional result was False 2025-10-08 05:51:43.170282 | 2025-10-08 05:51:43.170425 | TASK [Get hash related data from repo_setup role] 2025-10-08 05:51:43.217194 | controller | skipping: Conditional result was False 2025-10-08 05:51:43.232145 | 2025-10-08 05:51:43.232293 | TASK [dlrn_report : Perform kinit for DLRN kerberos authentication] 2025-10-08 05:51:43.787944 | controller | skipping: Conditional result was False 2025-10-08 05:51:43.802220 | 2025-10-08 05:51:43.802362 | TASK [dlrn_report : Set empty value for dlrnapi password] 2025-10-08 05:51:43.879708 | controller | skipping: Conditional result was False 2025-10-08 05:51:43.894045 | 2025-10-08 05:51:43.894184 | TASK [dlrn_report : Report results to dlrn for the tested hash] 2025-10-08 05:51:44.449768 | controller | skipping: Conditional result was False 2025-10-08 05:51:44.506487 | 2025-10-08 05:51:44.506561 | PLAY RECAP 2025-10-08 05:51:44.506613 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 0 2025-10-08 05:51:44.506648 | 2025-10-08 05:51:44.643405 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-08 05:51:44.646739 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-08 05:51:45.225946 | 2025-10-08 05:51:45.226059 | PLAY [all] 2025-10-08 05:51:45.259201 | 2025-10-08 05:51:45.259283 | TASK [include_role : fetch-output] 2025-10-08 05:51:45.301143 | controller | ok 2025-10-08 05:51:45.327436 | crc | ok 2025-10-08 05:51:45.351453 | 2025-10-08 05:51:45.351535 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-08 05:51:45.442079 | controller | ok 2025-10-08 05:51:45.456577 | crc | ok 2025-10-08 05:51:45.465287 | 2025-10-08 05:51:45.465370 | TASK [fetch-output : Set log path for single node] 2025-10-08 05:51:45.495910 | controller | skipping: Conditional result was False 2025-10-08 05:51:45.517045 | crc | skipping: Conditional result was False 2025-10-08 05:51:45.525940 | 2025-10-08 05:51:45.526025 | LOOP [fetch-output : Ensure local output dirs] 2025-10-08 05:51:45.922763 | controller -> localhost | ok: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/logs/controller" 2025-10-08 05:51:45.947639 | crc -> localhost | changed: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/logs/crc" 2025-10-08 05:51:46.145485 | controller -> localhost | ok: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/artifacts" 2025-10-08 05:51:46.170914 | crc -> localhost | ok: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/artifacts" 2025-10-08 05:51:46.376169 | controller -> localhost | ok: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/docs" 2025-10-08 05:51:46.391832 | crc -> localhost | ok: "/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/docs" 2025-10-08 05:51:46.391911 | crc -> localhost | ok: All items complete 2025-10-08 05:51:46.391936 | 2025-10-08 05:51:46.413276 | 2025-10-08 05:51:46.413431 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-08 05:51:47.011829 | controller | changed: 2025-10-08 05:51:47.012445 | controller | .d..t...... ./ 2025-10-08 05:51:47.012522 | controller | >f+++++++++ zuul-output-controller-all-logs.tar.gz 2025-10-08 05:51:47.243442 | crc | changed: 2025-10-08 05:51:47.243562 | crc | .d..t...... ./ 2025-10-08 05:51:47.243588 | crc | >f+++++++++ crc-cloud-workdir-crc-all-logs.tar.gz 2025-10-08 05:51:47.243608 | crc | >f+++++++++ kubelet.log 2025-10-08 05:51:47.243627 | crc | >f+++++++++ zuul-output-crc-all-logs.tar.gz 2025-10-08 05:51:47.243648 | crc | cd+++++++++ crc-cloud/ 2025-10-08 05:51:47.485254 | controller | ok 2025-10-08 05:51:47.833426 | crc | ok 2025-10-08 05:51:47.936629 | controller | ok 2025-10-08 05:51:48.368728 | crc | ok 2025-10-08 05:51:48.368923 | crc | changed: All items complete 2025-10-08 05:51:48.368978 | 2025-10-08 05:51:48.394517 | 2025-10-08 05:51:48.394730 | TASK [include_role : fetch-output-openshift] 2025-10-08 05:51:48.421222 | controller | skipping: Conditional result was False 2025-10-08 05:51:48.432048 | crc | skipping: Conditional result was False 2025-10-08 05:51:48.439492 | 2025-10-08 05:51:48.439563 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-08 05:51:48.868825 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012674 2025-10-08 05:51:49.112921 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012983 2025-10-08 05:51:49.183516 | 2025-10-08 05:51:49.183647 | PLAY [all] 2025-10-08 05:51:49.211956 | 2025-10-08 05:51:49.212018 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-08 05:51:49.872486 | controller | changed 2025-10-08 05:51:50.121192 | crc | changed 2025-10-08 05:51:50.207309 | 2025-10-08 05:51:50.207368 | PLAY RECAP 2025-10-08 05:51:50.207412 | controller | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-08 05:51:50.207438 | crc | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-08 05:51:50.207464 | 2025-10-08 05:51:50.319482 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-08 05:51:50.326595 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-08 05:51:50.947333 | 2025-10-08 05:51:50.947466 | PLAY [localhost] 2025-10-08 05:51:50.964591 | 2025-10-08 05:51:50.964665 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-08 05:51:51.405451 | localhost | changed 2025-10-08 05:51:51.415387 | 2025-10-08 05:51:51.415551 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-08 05:51:51.452557 | localhost | ok 2025-10-08 05:51:51.473356 | 2025-10-08 05:51:51.473528 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-08 05:51:51.882498 | localhost | changed 2025-10-08 05:51:51.887618 | 2025-10-08 05:51:51.887714 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-08 05:51:52.720320 | localhost | changed 2025-10-08 05:51:52.725563 | 2025-10-08 05:51:52.725629 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-08 05:51:53.147926 | localhost | Identity added: /var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/tmp/ansible.2rqpy3ud (/var/lib/zuul/builds/feeb159bff734b26baca9ae077db1cb8/work/tmp/ansible.2rqpy3ud) 2025-10-08 05:51:53.148258 | localhost | ok: Runtime: 0:00:00.007817 2025-10-08 05:51:53.158533 | 2025-10-08 05:51:53.158729 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-08 05:51:53.451216 | localhost | ok: Runtime: 0:00:00.005129 2025-10-08 05:51:53.461735 | 2025-10-08 05:51:53.461902 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-08 05:51:53.519236 | localhost | changed 2025-10-08 05:51:53.528938 | 2025-10-08 05:51:53.529073 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-08 05:51:53.937341 | localhost | changed 2025-10-08 05:51:53.983950 | 2025-10-08 05:51:53.984065 | PLAY [localhost] 2025-10-08 05:51:53.995613 | 2025-10-08 05:51:53.995674 | TASK [Generate bulk log download script] 2025-10-08 05:51:54.014733 | localhost | ok 2025-10-08 05:51:54.027288 | 2025-10-08 05:51:54.027363 | TASK [local-log-download : Check API endpoint is defined] 2025-10-08 05:51:54.065980 | localhost | ok: All assertions passed 2025-10-08 05:51:54.070856 | 2025-10-08 05:51:54.070925 | TASK [local-log-download : Create download script] 2025-10-08 05:51:54.504018 | localhost -> localhost | changed 2025-10-08 05:51:54.514145 | 2025-10-08 05:51:54.514211 | TASK [Register quick-download link] 2025-10-08 05:51:54.542570 | localhost | ok 2025-10-08 05:51:54.557963 | 2025-10-08 05:51:54.558034 | PLAY [logserver.rdoproject.org] 2025-10-08 05:51:54.567849 | 2025-10-08 05:51:54.567915 | TASK [Set zuul-log-path fact] 2025-10-08 05:51:54.586716 | logserver.rdoproject.org | ok 2025-10-08 05:51:54.595747 | 2025-10-08 05:51:54.595829 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-08 05:51:54.632483 | logserver.rdoproject.org | ok 2025-10-08 05:51:54.637699 | 2025-10-08 05:51:54.637766 | TASK [upload-logs : Create log directories] 2025-10-08 05:51:55.534534 | logserver.rdoproject.org | changed 2025-10-08 05:51:55.541782 | 2025-10-08 05:51:55.541917 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-08 05:51:55.847480 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.009081 2025-10-08 05:51:55.857352 | 2025-10-08 05:51:55.857485 | TASK [upload-logs : Upload logs to log server] 2025-10-08 05:51:56.708342 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-08 05:51:56.711380 | 2025-10-08 05:51:56.711442 | LOOP [upload-logs : Compress console log and json output] 2025-10-08 05:51:56.773078 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 05:51:56.785363 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 05:51:56.790276 | 2025-10-08 05:51:56.790388 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-08 05:51:56.859919 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 05:51:56.860421 | 2025-10-08 05:51:56.864838 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-08 05:51:56.873776 | 2025-10-08 05:51:56.873870 | LOOP [upload-logs : Upload console log and json output]