2025-10-01 10:43:13.603927 | Job console starting... 2025-10-01 10:43:13.624832 | Updating repositories 2025-10-01 10:43:14.573595 | Preparing job workspace 2025-10-01 10:43:34.474125 | Running Ansible setup... 2025-10-01 10:43:43.500769 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-01 10:43:44.817355 | 2025-10-01 10:43:44.817507 | PLAY [localhost] 2025-10-01 10:43:44.829306 | 2025-10-01 10:43:44.829437 | TASK [Gathering Facts] 2025-10-01 10:43:46.931556 | localhost | ok 2025-10-01 10:43:46.970464 | 2025-10-01 10:43:46.975874 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-01 10:43:48.001394 | localhost -> localhost | changed 2025-10-01 10:43:48.018596 | 2025-10-01 10:43:48.018763 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-01 10:43:49.678432 | localhost -> localhost | changed 2025-10-01 10:43:49.692322 | 2025-10-01 10:43:49.692440 | TASK [Setup log path fact] 2025-10-01 10:43:49.727468 | localhost | ok 2025-10-01 10:43:49.744730 | 2025-10-01 10:43:49.744881 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-01 10:43:49.773243 | localhost | ok 2025-10-01 10:43:49.781080 | 2025-10-01 10:43:49.781169 | TASK [emit-job-header : Print job information] 2025-10-01 10:43:49.828531 | # Job Information 2025-10-01 10:43:49.828735 | Ansible Version: 2.15.12 2025-10-01 10:43:49.828776 | Job: cifmw-multinode-kuttl 2025-10-01 10:43:49.828808 | Pipeline: github-check 2025-10-01 10:43:49.828838 | Executor: ze01.softwarefactory-project.io 2025-10-01 10:43:49.828868 | Triggered by: https://github.com/openstack-k8s-operators/ci-framework/pull/3237 2025-10-01 10:43:49.828900 | Log URL (when completed): https://logserver.rdoproject.org/eaf/rdoproject.org/eaf3bf33b5094c7293edbd23ebce0adc/ 2025-10-01 10:43:49.828931 | Event ID: 2c962f60-9eb3-11f0-844e-f06c90bcb25f 2025-10-01 10:43:49.834191 | 2025-10-01 10:43:49.834268 | LOOP [emit-job-header : Print node information] 2025-10-01 10:43:49.984193 | localhost | ok: 2025-10-01 10:43:49.984432 | localhost | # Node Information 2025-10-01 10:43:49.984463 | localhost | Inventory Hostname: controller 2025-10-01 10:43:49.984487 | localhost | Hostname: np0005464320 2025-10-01 10:43:49.984506 | localhost | Username: zuul 2025-10-01 10:43:49.984527 | localhost | Distro: CentOS 9 2025-10-01 10:43:49.984545 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-01 10:43:49.984564 | localhost | Region: RegionOne 2025-10-01 10:43:49.984583 | localhost | Label: cloud-centos-9-stream-tripleo-medium 2025-10-01 10:43:49.984602 | localhost | Product Name: OpenStack Nova 2025-10-01 10:43:49.984619 | localhost | Interface IP: 38.102.83.5 2025-10-01 10:43:50.110607 | localhost | ok: 2025-10-01 10:43:50.110744 | localhost | # Node Information 2025-10-01 10:43:50.110775 | localhost | Inventory Hostname: crc 2025-10-01 10:43:50.110899 | localhost | Hostname: crc 2025-10-01 10:43:50.110926 | localhost | Username: core 2025-10-01 10:43:50.110945 | localhost | Distro: RedHat 4.18 2025-10-01 10:43:50.110962 | localhost | Provider: vexxhost-nodepool-tripleo 2025-10-01 10:43:50.110979 | localhost | Region: RegionOne 2025-10-01 10:43:50.110997 | localhost | Label: crc-cloud-ocp-4-18-1-3xl 2025-10-01 10:43:50.111043 | localhost | Product Name: OpenStack Nova 2025-10-01 10:43:50.111068 | localhost | Interface IP: 38.102.83.162 2025-10-01 10:43:50.204456 | 2025-10-01 10:43:50.204549 | PLAY [all] 2025-10-01 10:43:50.217211 | 2025-10-01 10:43:50.217305 | TASK [Gather network facts] 2025-10-01 10:43:50.724300 | controller | ok 2025-10-01 10:43:50.969864 | crc | ok 2025-10-01 10:43:51.122934 | 2025-10-01 10:43:51.123056 | TASK [include_role : start-zuul-console] 2025-10-01 10:43:51.204651 | controller | ok 2025-10-01 10:43:51.221615 | crc | ok 2025-10-01 10:43:51.259904 | 2025-10-01 10:43:51.260031 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-01 10:43:51.868005 | crc | ok 2025-10-01 10:43:51.899923 | controller | ok 2025-10-01 10:43:51.968976 | 2025-10-01 10:43:51.969138 | TASK [include_role : add-build-sshkey] 2025-10-01 10:43:52.042865 | controller | ok 2025-10-01 10:43:52.087196 | crc | ok 2025-10-01 10:43:52.138916 | 2025-10-01 10:43:52.139068 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-01 10:43:52.977540 | controller -> localhost | ok 2025-10-01 10:43:52.984100 | 2025-10-01 10:43:52.984193 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-01 10:43:53.046262 | controller | ok 2025-10-01 10:43:53.062370 | crc | ok 2025-10-01 10:43:53.107033 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-01 10:43:53.107132 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-01 10:43:53.135003 | 2025-10-01 10:43:53.135140 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-01 10:43:55.334719 | controller -> localhost | Generating public/private rsa key pair. 2025-10-01 10:43:55.335185 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/eaf3bf33b5094c7293edbd23ebce0adc_id_rsa. 2025-10-01 10:43:55.335225 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/eaf3bf33b5094c7293edbd23ebce0adc_id_rsa.pub. 2025-10-01 10:43:55.335251 | controller -> localhost | The key fingerprint is: 2025-10-01 10:43:55.335273 | controller -> localhost | SHA256:lmOPbS8UGNarqbG4WSKMh16xiu8o2HXt4Bc4fvZj6NQ zuul-build-sshkey 2025-10-01 10:43:55.335294 | controller -> localhost | The key's randomart image is: 2025-10-01 10:43:55.335314 | controller -> localhost | +---[RSA 3072]----+ 2025-10-01 10:43:55.335334 | controller -> localhost | | . | 2025-10-01 10:43:55.335355 | controller -> localhost | | o . | 2025-10-01 10:43:55.335374 | controller -> localhost | | . o . | 2025-10-01 10:43:55.335392 | controller -> localhost | | ..o | 2025-10-01 10:43:55.335411 | controller -> localhost | | . oSo . | 2025-10-01 10:43:55.335434 | controller -> localhost | | + + *o=*. | 2025-10-01 10:43:55.335459 | controller -> localhost | |+.++.=.Bo+E | 2025-10-01 10:43:55.335485 | controller -> localhost | |=o+..+=.*.+. | 2025-10-01 10:43:55.335509 | controller -> localhost | |+=o o. =.o.o. | 2025-10-01 10:43:55.335532 | controller -> localhost | +----[SHA256]-----+ 2025-10-01 10:43:55.335582 | controller -> localhost | ok: Runtime: 0:00:01.313362 2025-10-01 10:43:55.341606 | 2025-10-01 10:43:55.341714 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-01 10:43:55.426940 | controller | ok 2025-10-01 10:43:55.477869 | crc | ok 2025-10-01 10:43:55.515876 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-01 10:43:55.515972 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-01 10:43:55.549885 | 2025-10-01 10:43:55.549992 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-01 10:43:55.626559 | controller | skipping: Conditional result was False 2025-10-01 10:43:55.690435 | crc | skipping: Conditional result was False 2025-10-01 10:43:55.696547 | 2025-10-01 10:43:55.696645 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-01 10:43:56.413194 | controller | changed 2025-10-01 10:43:56.603140 | crc | changed 2025-10-01 10:43:56.615537 | 2025-10-01 10:43:56.615639 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-01 10:43:56.944154 | controller | ok 2025-10-01 10:43:56.996309 | crc | ok 2025-10-01 10:43:57.025702 | 2025-10-01 10:43:57.025813 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-01 10:43:58.197734 | crc | changed 2025-10-01 10:43:58.223702 | controller | changed 2025-10-01 10:43:58.228958 | 2025-10-01 10:43:58.229060 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-01 10:43:59.077514 | controller | changed 2025-10-01 10:43:59.196769 | crc | changed 2025-10-01 10:43:59.205582 | 2025-10-01 10:43:59.205715 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-01 10:43:59.242184 | controller | skipping: Conditional result was False 2025-10-01 10:43:59.264625 | crc | skipping: Conditional result was False 2025-10-01 10:43:59.270517 | 2025-10-01 10:43:59.270604 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-01 10:43:59.700458 | controller -> localhost | changed 2025-10-01 10:43:59.722183 | 2025-10-01 10:43:59.722298 | TASK [add-build-sshkey : Add back temp key] 2025-10-01 10:44:00.211407 | controller -> localhost | Identity added: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/eaf3bf33b5094c7293edbd23ebce0adc_id_rsa (zuul-build-sshkey) 2025-10-01 10:44:00.211626 | controller -> localhost | ok: Runtime: 0:00:00.008764 2025-10-01 10:44:00.219458 | 2025-10-01 10:44:00.219570 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-01 10:44:00.719742 | controller | ok 2025-10-01 10:44:00.760656 | crc | ok 2025-10-01 10:44:00.765626 | 2025-10-01 10:44:00.765717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-01 10:44:00.820203 | controller | skipping: Conditional result was False 2025-10-01 10:44:00.851490 | crc | skipping: Conditional result was False 2025-10-01 10:44:00.890814 | 2025-10-01 10:44:00.890938 | TASK [include_role : validate-host] 2025-10-01 10:44:00.941125 | controller | ok 2025-10-01 10:44:00.967727 | crc | ok 2025-10-01 10:44:00.999769 | 2025-10-01 10:44:00.999887 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-01 10:44:01.043772 | crc | ok 2025-10-01 10:44:01.059371 | controller | ok 2025-10-01 10:44:01.064178 | 2025-10-01 10:44:01.064239 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-01 10:44:01.591825 | controller -> localhost | ok 2025-10-01 10:44:01.598338 | 2025-10-01 10:44:01.598432 | TASK [validate-host : Collect information about the host] 2025-10-01 10:44:02.408133 | controller | ok 2025-10-01 10:44:03.691563 | crc | ok 2025-10-01 10:44:03.732556 | 2025-10-01 10:44:03.732668 | TASK [validate-host : Sanitize hostname] 2025-10-01 10:44:03.833552 | controller | ok 2025-10-01 10:44:03.860038 | crc | ok 2025-10-01 10:44:03.866557 | 2025-10-01 10:44:03.866647 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-01 10:44:04.849069 | controller -> localhost | changed 2025-10-01 10:44:04.941531 | crc -> localhost | changed 2025-10-01 10:44:04.954924 | 2025-10-01 10:44:04.955038 | TASK [validate-host : Collect information about zuul worker] 2025-10-01 10:44:05.618482 | controller | ok 2025-10-01 10:44:05.633677 | crc | ok 2025-10-01 10:44:05.653387 | 2025-10-01 10:44:05.653537 | TASK [validate-host : Write out all zuul information for each host] 2025-10-01 10:44:06.410664 | controller -> localhost | changed 2025-10-01 10:44:06.594621 | crc -> localhost | changed 2025-10-01 10:44:06.616502 | 2025-10-01 10:44:06.616607 | TASK [include_role : prepare-workspace-openshift] 2025-10-01 10:44:06.667253 | controller | skipping: Conditional result was False 2025-10-01 10:44:06.674597 | 2025-10-01 10:44:06.674674 | TASK [include_role : remove-zuul-sshkey] 2025-10-01 10:44:06.739571 | controller | skipping: Conditional result was False 2025-10-01 10:44:06.822405 | 2025-10-01 10:44:06.822525 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-01 10:44:07.160316 | controller | ok: "logs" 2025-10-01 10:44:07.160552 | controller | ok: All items complete 2025-10-01 10:44:07.160580 | 2025-10-01 10:44:07.170318 | crc | ok: "logs" 2025-10-01 10:44:07.402374 | crc | ok: "artifacts" 2025-10-01 10:44:07.428573 | controller | ok: "artifacts" 2025-10-01 10:44:07.678693 | crc | ok: "docs" 2025-10-01 10:44:07.692665 | controller | ok: "docs" 2025-10-01 10:44:07.713566 | 2025-10-01 10:44:07.713642 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-01 10:44:08.036163 | controller | changed: "logs" 2025-10-01 10:44:08.036383 | controller | ok: All items complete 2025-10-01 10:44:08.036413 | 2025-10-01 10:44:08.112509 | crc | changed: "logs" 2025-10-01 10:44:08.289746 | controller | changed: "artifacts" 2025-10-01 10:44:08.384362 | crc | changed: "artifacts" 2025-10-01 10:44:08.518600 | controller | changed: "docs" 2025-10-01 10:44:08.633050 | crc | changed: "docs" 2025-10-01 10:44:08.690629 | 2025-10-01 10:44:08.690716 | PLAY RECAP 2025-10-01 10:44:08.690759 | controller | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-01 10:44:08.690785 | crc | ok: 17 changed: 6 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-10-01 10:44:08.690807 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-01 10:44:08.690824 | 2025-10-01 10:44:08.811753 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-10-01 10:44:08.815362 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-01 10:44:10.207802 | 2025-10-01 10:44:10.207936 | PLAY [all] 2025-10-01 10:44:10.274255 | 2025-10-01 10:44:10.274390 | TASK [mirror-info-fork : Set mirror_fqdn if not defined] 2025-10-01 10:44:10.369467 | controller | ok 2025-10-01 10:44:10.522338 | crc | ok 2025-10-01 10:44:10.544769 | 2025-10-01 10:44:10.544912 | TASK [mirror-info-fork : Create /etc/ci] 2025-10-01 10:44:11.318405 | controller | changed 2025-10-01 10:44:11.332182 | crc | changed 2025-10-01 10:44:11.397659 | 2025-10-01 10:44:11.397774 | TASK [mirror-info-fork : Install ci_mirror script] 2025-10-01 10:44:12.892037 | crc | changed 2025-10-01 10:44:12.908581 | controller | changed 2025-10-01 10:44:12.956383 | 2025-10-01 10:44:12.956524 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-10-01 10:44:13.775431 | controller | changed: 2025-10-01 10:44:13.775864 | controller | { 2025-10-01 10:44:13.775906 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-01 10:44:13.775931 | controller | } 2025-10-01 10:44:13.828633 | crc | changed: 2025-10-01 10:44:13.828735 | crc | { 2025-10-01 10:44:13.828760 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAABIwAAAQEA4Z/c9osaGGtU6X8fgELwfj/yayRurfcKA0HMFfdpPxev2dbwljysMuzoVp4OZmW1gvGtyYPSNRvnzgsaabPNKNo2ym5NToCP6UM+KSe93aln4BcM/24mXChYAbXJQ5Bqq/pIzsGs/pKetQN+vwvMxLOwTvpcsCJBXaa981RKML6xj9l/UZ7IIq1HSEKMvPLxZMWdu0Ut8DkCd5F4nOw9Wgml2uYpDCj5LLCrQQ9ChdOMz8hz6SighhNlRpPkvPaet3OXxr/ytFMu7j7vv06CaEnuMMiY2aTWN1Imin9eHAylIqFHta/3gFfQSWt9jXM7owkBLKL7ATzhaAn+fjNupw== arxcruz@redhat.com" 2025-10-01 10:44:13.830485 | crc | } 2025-10-01 10:44:14.043912 | controller | changed: 2025-10-01 10:44:14.044123 | controller | { 2025-10-01 10:44:14.044355 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-01 10:44:14.044406 | controller | } 2025-10-01 10:44:14.172996 | crc | changed: 2025-10-01 10:44:14.173348 | crc | { 2025-10-01 10:44:14.173381 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDS4Fn6k4deCnIlOtLWqZJyksbepjQt04j8Ed8CGx9EKkj0fKiAxiI4TadXQYPuNHMixZy4Nevjb6aDhL5Z906TfvNHKUrjrG7G26a0k8vdc61NEQ7FmcGMWRLwwc6ReDO7lFpzYKBMk4YqfWgBuGU/K6WLKiVW2cVvwIuGIaYrE1OiiX0iVUUk7KApXlDJMXn7qjSYynfO4mF629NIp8FJal38+Kv+HA+0QkE5Y2xXnzD4Lar5+keymiCHRntPppXHeLIRzbt0gxC7v3L72hpQ3BTBEzwHpeS8KY+SX1y5lRMN45thCHfJqGmARJREDjBvWG8JXOPmVIKQtZmVcD5b mandreou@redhat.com" 2025-10-01 10:44:14.173413 | crc | } 2025-10-01 10:44:14.338624 | controller | changed: 2025-10-01 10:44:14.338739 | controller | { 2025-10-01 10:44:14.338774 | 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-01 10:44:14.338802 | controller | } 2025-10-01 10:44:14.606345 | crc | changed: 2025-10-01 10:44:14.606420 | crc | { 2025-10-01 10:44:14.606442 | 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-01 10:44:14.606461 | crc | } 2025-10-01 10:44:14.611296 | controller | changed: 2025-10-01 10:44:14.611342 | controller | { 2025-10-01 10:44:14.611365 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-01 10:44:14.611384 | controller | } 2025-10-01 10:44:14.887208 | controller | changed: 2025-10-01 10:44:14.887311 | controller | { 2025-10-01 10:44:14.887335 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-01 10:44:14.887359 | controller | } 2025-10-01 10:44:14.959578 | crc | changed: 2025-10-01 10:44:14.959670 | crc | { 2025-10-01 10:44:14.959692 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIFCbgz8gdERiJlk2IKOtkjQxEXejrio6ZYMJAVJYpOIp raukadah@gmail.com" 2025-10-01 10:44:14.959711 | crc | } 2025-10-01 10:44:15.180336 | controller | changed: 2025-10-01 10:44:15.180439 | controller | { 2025-10-01 10:44:15.180462 | controller | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-01 10:44:15.180480 | controller | } 2025-10-01 10:44:15.340032 | crc | changed: 2025-10-01 10:44:15.340184 | crc | { 2025-10-01 10:44:15.340217 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIBqb3Q/9uDf4LmihQ7xeJ9gA/STIQUFPSfyyV0m8AoQi bshewale@redhat.com" 2025-10-01 10:44:15.340240 | crc | } 2025-10-01 10:44:15.473519 | controller | changed: 2025-10-01 10:44:15.473644 | controller | { 2025-10-01 10:44:15.473684 | 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-01 10:44:15.473717 | controller | } 2025-10-01 10:44:15.682627 | crc | changed: 2025-10-01 10:44:15.682723 | crc | { 2025-10-01 10:44:15.682747 | crc | "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC0I8QqQx0Az2ysJt2JuffucLijhBqnsXKEIx5GyHwxVULROa8VtNFXUDH6ZKZavhiMcmfHB2+TBTda+lDP4FldYj06dGmzCY+IYGa+uDRdxHNGYjvCfLFcmLlzRK6fNbTcui+KlUFUdKe0fb9CRoGKyhlJD5GRkM1Dv+Yb6Bj+RNnmm1fVGYxzmrD2utvffYEb0SZGWxq2R9gefx1q/3wCGjeqvufEV+AskPhVGc5T7t9eyZ4qmslkLh1/nMuaIBFcr9AUACRajsvk6mXrAN1g3HlBf2gQlhi1UEyfbqIQvzzFtsbLDlSum/KmKjy818GzvWjERfQ0VkGzCd9bSLVL dviroel@redhat.com" 2025-10-01 10:44:15.682766 | crc | } 2025-10-01 10:44:15.802274 | controller | changed: 2025-10-01 10:44:15.802368 | controller | { 2025-10-01 10:44:15.802391 | 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-01 10:44:15.802411 | controller | } 2025-10-01 10:44:16.078612 | crc | changed: 2025-10-01 10:44:16.078737 | crc | { 2025-10-01 10:44:16.078772 | 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-01 10:44:16.078803 | crc | } 2025-10-01 10:44:16.146959 | controller | changed: 2025-10-01 10:44:16.147120 | controller | { 2025-10-01 10:44:16.147164 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-01 10:44:16.147199 | controller | } 2025-10-01 10:44:16.431141 | crc | changed: 2025-10-01 10:44:16.431273 | crc | { 2025-10-01 10:44:16.431300 | 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-01 10:44:16.431324 | crc | } 2025-10-01 10:44:16.468758 | controller | changed: 2025-10-01 10:44:16.469090 | controller | { 2025-10-01 10:44:16.469120 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-01 10:44:16.469142 | controller | } 2025-10-01 10:44:16.754423 | controller | changed: 2025-10-01 10:44:16.754526 | controller | { 2025-10-01 10:44:16.754549 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-01 10:44:16.754567 | controller | } 2025-10-01 10:44:16.820500 | crc | changed: 2025-10-01 10:44:16.820593 | crc | { 2025-10-01 10:44:16.820619 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIHUnwjB20UKmsSed9X73eGNV5AOEFccQ3NYrRW776pEk cjeanner" 2025-10-01 10:44:16.820637 | crc | } 2025-10-01 10:44:17.060124 | controller | changed: 2025-10-01 10:44:17.060223 | controller | { 2025-10-01 10:44:17.060260 | controller | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-01 10:44:17.060289 | controller | } 2025-10-01 10:44:17.154519 | crc | changed: 2025-10-01 10:44:17.154612 | crc | { 2025-10-01 10:44:17.154635 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDercCMGn8rW1C4P67tHgtflPdTeXlpyUJYH+6XDd2lR jgilaber@redhat.com" 2025-10-01 10:44:17.154654 | crc | } 2025-10-01 10:44:17.358938 | controller | changed: 2025-10-01 10:44:17.359280 | controller | { 2025-10-01 10:44:17.359315 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-01 10:44:17.359335 | controller | } 2025-10-01 10:44:17.509778 | crc | changed: 2025-10-01 10:44:17.509879 | crc | { 2025-10-01 10:44:17.509902 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIAMI6kkg9Wg0sG7jIJmyZemEBwUn1yzNpQQd3gnulOmZ adrianfuscoarnejo@gmail.com" 2025-10-01 10:44:17.509919 | crc | } 2025-10-01 10:44:17.662968 | controller | changed: 2025-10-01 10:44:17.663082 | controller | { 2025-10-01 10:44:17.663107 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-01 10:44:17.663126 | controller | } 2025-10-01 10:44:17.931872 | controller | changed: 2025-10-01 10:44:17.932085 | controller | { 2025-10-01 10:44:17.932119 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-01 10:44:17.932139 | controller | } 2025-10-01 10:44:17.943138 | crc | changed: 2025-10-01 10:44:17.943220 | crc | { 2025-10-01 10:44:17.943242 | crc | "public_key": "ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBPijwpQu/3jhhhBZInXNOLEH57DrknPc3PLbsRvYyJIFzwYjX+WD4a7+nGnMYS42MuZk6TJcVqgnqofVx4isoD4= ramishra@redhat.com" 2025-10-01 10:44:17.943261 | crc | } 2025-10-01 10:44:18.171079 | controller | changed: 2025-10-01 10:44:18.171215 | controller | { 2025-10-01 10:44:18.171239 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-01 10:44:18.171257 | controller | } 2025-10-01 10:44:18.354043 | crc | changed: 2025-10-01 10:44:18.354159 | crc | { 2025-10-01 10:44:18.354190 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIGpU/BepK3qX0NRf5Np+dOBDqzQEefhNrw2DCZaH3uWW rebtoor@monolith" 2025-10-01 10:44:18.354217 | crc | } 2025-10-01 10:44:18.441620 | controller | changed: 2025-10-01 10:44:18.441718 | controller | { 2025-10-01 10:44:18.441743 | 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-01 10:44:18.441767 | controller | } 2025-10-01 10:44:18.708369 | crc | changed: 2025-10-01 10:44:18.708465 | crc | { 2025-10-01 10:44:18.708488 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDK0iKdi8jQTpQrDdLVH/AAgLVYyTXF7AQ1gjc/5uT3t ykarel@yatinkarel" 2025-10-01 10:44:18.708505 | crc | } 2025-10-01 10:44:18.742559 | controller | changed: 2025-10-01 10:44:18.742654 | controller | { 2025-10-01 10:44:18.742677 | 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-01 10:44:18.742704 | controller | } 2025-10-01 10:44:19.012391 | controller | changed: 2025-10-01 10:44:19.012513 | controller | { 2025-10-01 10:44:19.012563 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-01 10:44:19.012582 | controller | } 2025-10-01 10:44:19.076862 | crc | changed: 2025-10-01 10:44:19.077105 | crc | { 2025-10-01 10:44:19.077158 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIF/V/cLotA6LZeO32VL45Hd78skuA2lJA425Sm2LlQeZ fmount@horcrux" 2025-10-01 10:44:19.077189 | crc | } 2025-10-01 10:44:19.261243 | controller | changed: 2025-10-01 10:44:19.261377 | controller | { 2025-10-01 10:44:19.261416 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-01 10:44:19.261454 | controller | } 2025-10-01 10:44:19.452098 | crc | changed: 2025-10-01 10:44:19.452185 | crc | { 2025-10-01 10:44:19.452209 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIDa7QCjuDMVmRPo1rREbGwzYeBCYVN+Ou/3WKXZEC6Sr" 2025-10-01 10:44:19.452227 | crc | } 2025-10-01 10:44:19.511115 | controller | changed: 2025-10-01 10:44:19.511213 | controller | { 2025-10-01 10:44:19.511247 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-01 10:44:19.511275 | controller | } 2025-10-01 10:44:19.759465 | controller | changed: 2025-10-01 10:44:19.759607 | controller | { 2025-10-01 10:44:19.759637 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-01 10:44:19.759659 | controller | } 2025-10-01 10:44:19.785313 | crc | changed: 2025-10-01 10:44:19.785555 | crc | { 2025-10-01 10:44:19.785601 | 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-01 10:44:19.785631 | crc | } 2025-10-01 10:44:19.982215 | controller | changed: 2025-10-01 10:44:19.982305 | controller | { 2025-10-01 10:44:19.982329 | 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-01 10:44:19.982348 | controller | } 2025-10-01 10:44:20.185922 | crc | changed: 2025-10-01 10:44:20.186079 | crc | { 2025-10-01 10:44:20.186119 | 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-01 10:44:20.186149 | crc | } 2025-10-01 10:44:20.209071 | controller | changed: 2025-10-01 10:44:20.209180 | controller | { 2025-10-01 10:44:20.209212 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-01 10:44:20.209238 | controller | } 2025-10-01 10:44:20.436330 | controller | changed: 2025-10-01 10:44:20.436445 | controller | { 2025-10-01 10:44:20.436475 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-01 10:44:20.436501 | controller | } 2025-10-01 10:44:20.480378 | crc | changed: 2025-10-01 10:44:20.480486 | crc | { 2025-10-01 10:44:20.480516 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIOKLl0NYKwoZ/JY5KeZU8VwRAggeOxqQJeoqp3dsAaY9" 2025-10-01 10:44:20.480542 | crc | } 2025-10-01 10:44:20.663920 | controller | changed: 2025-10-01 10:44:20.664107 | controller | { 2025-10-01 10:44:20.664144 | controller | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-01 10:44:20.664171 | controller | } 2025-10-01 10:44:20.833562 | crc | changed: 2025-10-01 10:44:20.834507 | crc | { 2025-10-01 10:44:20.834546 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIASASQOH2BcOyLKuuDOdWZlPi2orcjcA8q4400T73DLH evallesp@fedora" 2025-10-01 10:44:20.834566 | crc | } 2025-10-01 10:44:20.834594 | crc | changed: All items complete 2025-10-01 10:44:20.834613 | 2025-10-01 10:44:21.205847 | crc | changed: 2025-10-01 10:44:21.205945 | crc | { 2025-10-01 10:44:21.205967 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILeBWlamUph+jRKV2qrx1PGU7vWuGIt5+z9k96I8WehW amsinha@amsinha-mac" 2025-10-01 10:44:21.205985 | crc | } 2025-10-01 10:44:21.530188 | crc | changed: 2025-10-01 10:44:21.531061 | crc | { 2025-10-01 10:44:21.531114 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIANvVgvJBlK3gb1yz5uef/JqIGq4HLEmY2dYA8e37swb morenod@redhat-laptop" 2025-10-01 10:44:21.531144 | crc | } 2025-10-01 10:44:21.914311 | crc | changed: 2025-10-01 10:44:21.914459 | crc | { 2025-10-01 10:44:21.914483 | 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-01 10:44:21.914503 | crc | } 2025-10-01 10:44:22.265124 | crc | changed: 2025-10-01 10:44:22.265226 | crc | { 2025-10-01 10:44:22.265251 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIKwedoZ0TWPJX/z/4TAbO/kKcDZOQVgRH0hAqrL5UCI1 vcastell@redhat.com" 2025-10-01 10:44:22.265268 | crc | } 2025-10-01 10:44:22.595883 | crc | changed: 2025-10-01 10:44:22.596061 | crc | { 2025-10-01 10:44:22.596352 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIEmv8sE8GCk6ZTPIqF0FQrttBdL3mq7rCm/IJy0xDFh7 michburk@redhat.com" 2025-10-01 10:44:22.596420 | crc | } 2025-10-01 10:44:22.986786 | crc | changed: 2025-10-01 10:44:22.986881 | crc | { 2025-10-01 10:44:22.986913 | crc | "public_key": "ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICy6GpGEtwevXEEn4mmLR5lmSLe23dGgAvzkB9DMNbkf rsafrono@rsafrono" 2025-10-01 10:44:22.986939 | crc | } 2025-10-01 10:44:23.021009 | 2025-10-01 10:44:23.021194 | TASK [Set timezone to UTC] 2025-10-01 10:44:23.624305 | crc | ok 2025-10-01 10:44:23.691648 | controller | changed: executed `/bin/timedatectl set-timezone UTC` 2025-10-01 10:44:23.696517 | 2025-10-01 10:44:23.696589 | TASK [Create nodepool directory] 2025-10-01 10:44:23.978304 | controller | changed 2025-10-01 10:44:24.027066 | crc | changed 2025-10-01 10:44:24.033052 | 2025-10-01 10:44:24.033119 | TASK [Create nodepool sub_nodes file] 2025-10-01 10:44:24.755952 | controller | changed 2025-10-01 10:44:24.870571 | crc | changed 2025-10-01 10:44:24.878132 | 2025-10-01 10:44:24.878222 | TASK [Create nodepool sub_nodes_private file] 2025-10-01 10:44:25.585471 | controller | changed 2025-10-01 10:44:25.674641 | crc | changed 2025-10-01 10:44:25.679676 | 2025-10-01 10:44:25.679732 | LOOP [Populate nodepool sub_nodes file] 2025-10-01 10:44:25.745494 | 2025-10-01 10:44:25.745656 | LOOP [Populate nodepool sub_nodes_private file] 2025-10-01 10:44:25.801480 | 2025-10-01 10:44:25.801652 | TASK [Create nodepool primary file] 2025-10-01 10:44:25.846792 | crc | skipping: Conditional result was False 2025-10-01 10:44:25.857710 | controller | skipping: Conditional result was False 2025-10-01 10:44:25.863444 | 2025-10-01 10:44:25.863506 | TASK [Create nodepool node_private for this node] 2025-10-01 10:44:26.625038 | controller | changed 2025-10-01 10:44:26.746539 | crc | changed 2025-10-01 10:44:26.752535 | 2025-10-01 10:44:26.752596 | LOOP [Copy ssh keys to nodepool directory] 2025-10-01 10:44:27.179696 | controller | ok: Item: id_rsa Runtime: 0:00:00.007039 2025-10-01 10:44:27.179991 | 2025-10-01 10:44:27.280742 | crc | ok: Item: id_rsa Runtime: 0:00:00.007685 2025-10-01 10:44:27.422760 | controller | ok: Item: id_rsa.pub Runtime: 0:00:00.007827 2025-10-01 10:44:27.457990 | crc | ok: Item: id_rsa.pub Runtime: 0:00:00.007049 2025-10-01 10:44:27.472868 | 2025-10-01 10:44:27.472976 | TASK [Add sudoers role for zuul-sudo-grep.sh] 2025-10-01 10:44:28.234186 | controller | changed 2025-10-01 10:44:28.336259 | crc | changed 2025-10-01 10:44:28.353500 | 2025-10-01 10:44:28.353611 | TASK [Validate sudoers config after edits] 2025-10-01 10:44:28.684862 | controller | /etc/sudoers: parsed OK 2025-10-01 10:44:28.685049 | controller | /etc/sudoers.d/90-cloud-init-users: parsed OK 2025-10-01 10:44:28.685125 | controller | /etc/sudoers.d/zuul: parsed OK 2025-10-01 10:44:28.685133 | controller | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-01 10:44:28.779010 | crc | /etc/sudoers: parsed OK 2025-10-01 10:44:28.779326 | crc | /etc/sudoers.d/coreos-sudo-group: parsed OK 2025-10-01 10:44:28.779339 | crc | /etc/sudoers.d/zuul-sudo-grep: parsed OK 2025-10-01 10:44:28.965453 | controller | ok: Runtime: 0:00:00.008378 2025-10-01 10:44:28.974319 | crc | ok: Runtime: 0:00:00.012358 2025-10-01 10:44:28.981179 | 2025-10-01 10:44:28.981256 | TASK [Show the environment passed in to job shell scripts] 2025-10-01 10:44:29.388822 | controller | SHELL=/bin/bash 2025-10-01 10:44:29.388878 | controller | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-01 10:44:29.388905 | controller | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-01 10:44:29.388914 | controller | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/9f82bbc44cf7fa37a2cf6305277fe598af8c6e39 2025-10-01 10:44:29.388920 | controller | PWD=/home/zuul 2025-10-01 10:44:29.388927 | controller | ZUUL_PIPELINE=github-check 2025-10-01 10:44:29.388933 | controller | LOGNAME=zuul 2025-10-01 10:44:29.388939 | controller | XDG_SESSION_TYPE=tty 2025-10-01 10:44:29.388945 | controller | _=/usr/bin/env 2025-10-01 10:44:29.388951 | controller | MOTD_SHOWN=pam 2025-10-01 10:44:29.388957 | controller | HOME=/home/zuul 2025-10-01 10:44:29.388963 | controller | LANG=en_US.UTF-8 2025-10-01 10:44:29.388969 | controller | SSH_CONNECTION=38.102.83.114 52608 38.102.83.5 22 2025-10-01 10:44:29.388975 | 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-01 10:44:29.388985 | controller | ZUUL_CHANGE_IDS=3237,9f82bbc44cf7fa37a2cf6305277fe598af8c6e39 2025-10-01 10:44:29.388991 | controller | WORKSPACE=/home/zuul/workspace 2025-10-01 10:44:29.388997 | controller | XDG_SESSION_CLASS=user 2025-10-01 10:44:29.389003 | controller | SELINUX_ROLE_REQUESTED= 2025-10-01 10:44:29.389009 | controller | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-01 10:44:29.389015 | controller | USER=zuul 2025-10-01 10:44:29.389021 | controller | ZUUL_VOTING=True 2025-10-01 10:44:29.392918 | controller | BUILD_TIMEOUT=9000000 2025-10-01 10:44:29.392927 | controller | SELINUX_USE_CURRENT_RANGE= 2025-10-01 10:44:29.392933 | controller | SHLVL=1 2025-10-01 10:44:29.393021 | controller | ZUUL_PATCHSET=9f82bbc44cf7fa37a2cf6305277fe598af8c6e39 2025-10-01 10:44:29.393030 | controller | XDG_SESSION_ID=1 2025-10-01 10:44:29.393036 | controller | ZUUL_BRANCH=main 2025-10-01 10:44:29.393042 | controller | XDG_RUNTIME_DIR=/run/user/1000 2025-10-01 10:44:29.393048 | controller | SSH_CLIENT=38.102.83.114 52608 22 2025-10-01 10:44:29.393054 | controller | DEBUGINFOD_URLS=https://debuginfod.centos.org/ 2025-10-01 10:44:29.393060 | controller | DEBUGINFOD_IMA_CERT_PATH=/etc/keys/ima: 2025-10-01 10:44:29.393068 | controller | which_declare=declare -f 2025-10-01 10:44:29.393075 | controller | PATH=/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-01 10:44:29.393081 | controller | SELINUX_LEVEL_REQUESTED= 2025-10-01 10:44:29.393087 | controller | ZUUL_CHANGE=3237 2025-10-01 10:44:29.393093 | controller | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-01 10:44:29.393098 | controller | ZUUL_UUID=eaf3bf33b5094c7293edbd23ebce0adc 2025-10-01 10:44:29.393105 | controller | BASH_FUNC_which%%=() { ( alias; 2025-10-01 10:44:29.393110 | controller | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-01 10:44:29.393116 | controller | } 2025-10-01 10:44:29.419911 | crc | SHELL=/bin/bash 2025-10-01 10:44:29.419970 | crc | ZUUL_PROJECT=openstack-k8s-operators/ci-framework 2025-10-01 10:44:29.419979 | crc | ZUUL_SHORT_PROJECT_NAME=ci-framework 2025-10-01 10:44:29.419985 | crc | ZUUL_CHANGES=openstack-k8s-operators/ci-framework:main:refs/changes/37/3237/9f82bbc44cf7fa37a2cf6305277fe598af8c6e39 2025-10-01 10:44:29.419991 | crc | PWD=/var/home/core 2025-10-01 10:44:29.419996 | crc | ZUUL_PIPELINE=github-check 2025-10-01 10:44:29.420002 | crc | LOGNAME=core 2025-10-01 10:44:29.420008 | crc | XDG_SESSION_TYPE=tty 2025-10-01 10:44:29.420013 | crc | _=/usr/bin/env 2025-10-01 10:44:29.420019 | crc | MOTD_SHOWN=pam 2025-10-01 10:44:29.420024 | crc | HOME=/var/home/core 2025-10-01 10:44:29.420029 | crc | LANG=C.UTF-8 2025-10-01 10:44:29.420035 | crc | SSH_CONNECTION=38.102.83.114 55116 38.102.83.162 22 2025-10-01 10:44:29.420041 | 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-01 10:44:29.420049 | crc | ZUUL_CHANGE_IDS=3237,9f82bbc44cf7fa37a2cf6305277fe598af8c6e39 2025-10-01 10:44:29.420055 | crc | WORKSPACE=/home/zuul/workspace 2025-10-01 10:44:29.420060 | crc | XDG_SESSION_CLASS=user 2025-10-01 10:44:29.420066 | crc | SELINUX_ROLE_REQUESTED= 2025-10-01 10:44:29.420071 | crc | LESSOPEN=||/usr/bin/lesspipe.sh %s 2025-10-01 10:44:29.420077 | crc | USER=core 2025-10-01 10:44:29.420083 | crc | ZUUL_VOTING=True 2025-10-01 10:44:29.420088 | crc | BUILD_TIMEOUT=9000000 2025-10-01 10:44:29.420093 | crc | SELINUX_USE_CURRENT_RANGE= 2025-10-01 10:44:29.420099 | crc | SHLVL=1 2025-10-01 10:44:29.420105 | crc | ZUUL_PATCHSET=9f82bbc44cf7fa37a2cf6305277fe598af8c6e39 2025-10-01 10:44:29.420110 | crc | XDG_SESSION_ID=2 2025-10-01 10:44:29.420116 | crc | ZUUL_BRANCH=main 2025-10-01 10:44:29.420121 | crc | XDG_RUNTIME_DIR=/run/user/1000 2025-10-01 10:44:29.420127 | crc | SSH_CLIENT=38.102.83.114 55116 22 2025-10-01 10:44:29.420132 | crc | which_declare=declare -f 2025-10-01 10:44:29.420138 | crc | PATH=/var/home/core/.local/bin:/var/home/core/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-10-01 10:44:29.420144 | crc | SELINUX_LEVEL_REQUESTED= 2025-10-01 10:44:29.420150 | crc | ZUUL_CHANGE=3237 2025-10-01 10:44:29.420155 | crc | DBUS_SESSION_BUS_ADDRESS=unix:path=/run/user/1000/bus 2025-10-01 10:44:29.420161 | crc | ZUUL_UUID=eaf3bf33b5094c7293edbd23ebce0adc 2025-10-01 10:44:29.420166 | crc | BASH_FUNC_which%%=() { ( alias; 2025-10-01 10:44:29.420173 | crc | eval ${which_declare} ) | /usr/bin/which --tty-only --read-alias --read-functions --show-tilde --show-dot $@ 2025-10-01 10:44:29.420178 | crc | } 2025-10-01 10:44:29.600466 | controller | ok: Runtime: 0:00:00.012946 2025-10-01 10:44:29.609376 | crc | ok: Runtime: 0:00:00.013766 2025-10-01 10:44:29.619863 | 2025-10-01 10:44:29.620083 | TASK [Workaround hardcoded /home/zuul/workspace in zuul_legacy_vars] 2025-10-01 10:44:29.670440 | controller | skipping: Conditional result was False 2025-10-01 10:44:29.682550 | crc | skipping: Conditional result was False 2025-10-01 10:44:29.691390 | 2025-10-01 10:44:29.691556 | TASK [Symlink /home/zuul-worker/workspace] 2025-10-01 10:44:30.336791 | controller | skipping: Conditional result was False 2025-10-01 10:44:30.337345 | crc | skipping: Conditional result was False 2025-10-01 10:44:30.348281 | 2025-10-01 10:44:30.348412 | TASK [Ensure legacy workspace directory] 2025-10-01 10:44:30.633163 | controller | changed 2025-10-01 10:44:30.764663 | crc | changed 2025-10-01 10:44:30.932916 | 2025-10-01 10:44:30.933043 | PLAY RECAP 2025-10-01 10:44:30.933099 | controller | ok: 14 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-01 10:44:30.933126 | crc | ok: 14 changed: 10 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-01 10:44:30.933145 | 2025-10-01 10:44:31.290132 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/pre.yaml@master] 2025-10-01 10:44:31.295676 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network.yml@master] 2025-10-01 10:44:32.194996 | 2025-10-01 10:44:32.195131 | PLAY [controller] 2025-10-01 10:44:32.217691 | 2025-10-01 10:44:32.217811 | TASK [Debug parameters] 2025-10-01 10:44:32.268519 | controller | ok 2025-10-01 10:44:32.275818 | 2025-10-01 10:44:32.275918 | TASK [Assert crc_ci_bootstrap_cloud_name is defined] 2025-10-01 10:44:32.307498 | controller | ok: All assertions passed 2025-10-01 10:44:32.313153 | 2025-10-01 10:44:32.313228 | TASK [Assert crc_ci_bootstrap_networking is defined and contains the minimum fields] 2025-10-01 10:44:32.341992 | controller | ok: All assertions passed 2025-10-01 10:44:32.347256 | 2025-10-01 10:44:32.347333 | TASK [Assert that the default network exists and has no VLAN tag] 2025-10-01 10:44:32.378317 | controller | ok: All assertions passed 2025-10-01 10:44:32.383598 | 2025-10-01 10:44:32.383679 | LOOP [Assert that all instances has a given fixed IP for each net and default net is present] 2025-10-01 10:44:32.492612 | controller | ok: All assertions passed 2025-10-01 10:44:32.497625 | controller | ok: All assertions passed 2025-10-01 10:44:32.506755 | 2025-10-01 10:44:32.506826 | LOOP [Assert that every host references an valid/declared network] 2025-10-01 10:44:32.602619 | controller | ok: All assertions passed 2025-10-01 10:44:32.602886 | controller | ok: All items complete 2025-10-01 10:44:32.602919 | 2025-10-01 10:44:32.609347 | controller | ok: All assertions passed 2025-10-01 10:44:32.626669 | 2025-10-01 10:44:32.626782 | LOOP [Assert that all instances has in range fixed IP for each net] 2025-10-01 10:44:32.736760 | controller | ok: All assertions passed 2025-10-01 10:44:32.741924 | controller | ok: All assertions passed 2025-10-01 10:44:32.748432 | 2025-10-01 10:44:32.748573 | TASK [Assert that all non-default nets has the vlan tag] 2025-10-01 10:44:32.883523 | controller | ok: All assertions passed 2025-10-01 10:44:32.888866 | 2025-10-01 10:44:32.888927 | TASK [Install required packages] 2025-10-01 10:44:49.784724 | controller | changed 2025-10-01 10:44:49.798835 | 2025-10-01 10:44:49.799115 | TASK [Create openstack config dir] 2025-10-01 10:44:50.242053 | controller | changed 2025-10-01 10:44:50.247087 | 2025-10-01 10:44:50.247153 | LOOP [Create ci dir in etc folder in the controller] 2025-10-01 10:44:50.590490 | controller -> 38.102.83.162 | changed: "crc" 2025-10-01 10:44:50.590729 | controller -> 38.102.83.162 | ok: All items complete 2025-10-01 10:44:50.590756 | 2025-10-01 10:44:50.883749 | controller -> 38.102.83.5 | changed: "controller" 2025-10-01 10:44:50.902082 | 2025-10-01 10:44:50.902199 | TASK [Set global resource names as facts] 2025-10-01 10:44:50.969856 | controller | ok 2025-10-01 10:44:50.978544 | 2025-10-01 10:44:50.978684 | TASK [Generate CA cert file] 2025-10-01 10:44:51.014339 | controller | skipping: Conditional result was False 2025-10-01 10:44:51.024235 | 2025-10-01 10:44:51.024383 | TASK [Update CA certs] 2025-10-01 10:44:51.586334 | controller | skipping: Conditional result was False 2025-10-01 10:44:51.598915 | 2025-10-01 10:44:51.599099 | TASK [Generate clouds config from cloud_secrets secret] 2025-10-01 10:44:53.468003 | controller | changed 2025-10-01 10:44:53.473736 | 2025-10-01 10:44:53.473800 | TASK [Create the default network] 2025-10-01 10:44:57.229495 | controller | admin_state_up: true 2025-10-01 10:44:57.229778 | controller | availability_zone_hints: 2025-10-01 10:44:57.230023 | controller | - nova 2025-10-01 10:44:57.230036 | controller | availability_zones: [] 2025-10-01 10:44:57.230409 | controller | created_at: '2025-10-01T10:44:55Z' 2025-10-01 10:44:57.230610 | controller | description: '' 2025-10-01 10:44:57.230803 | controller | dns_domain: '' 2025-10-01 10:44:57.231071 | controller | id: 61a51c87-5f05-4878-bd5a-345961382f59 2025-10-01 10:44:57.231360 | controller | ipv4_address_scope: null 2025-10-01 10:44:57.231568 | controller | ipv6_address_scope: null 2025-10-01 10:44:57.231833 | controller | is_default: false 2025-10-01 10:44:57.232129 | controller | is_vlan_qinq: null 2025-10-01 10:44:57.232431 | controller | is_vlan_transparent: true 2025-10-01 10:44:57.232647 | controller | l2_adjacency: true 2025-10-01 10:44:57.232956 | controller | mtu: 1500 2025-10-01 10:44:57.233192 | controller | name: zuul-ci-net-eaf3bf33 2025-10-01 10:44:57.233480 | controller | port_security_enabled: false 2025-10-01 10:44:57.233765 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-01 10:44:57.234092 | controller | provider:network_type: null 2025-10-01 10:44:57.234349 | controller | provider:physical_network: null 2025-10-01 10:44:57.234671 | controller | provider:segmentation_id: null 2025-10-01 10:44:57.235028 | controller | qos_policy_id: null 2025-10-01 10:44:57.235285 | controller | revision_number: 1 2025-10-01 10:44:57.235501 | controller | router:external: false 2025-10-01 10:44:57.235742 | controller | segments: null 2025-10-01 10:44:57.236017 | controller | shared: false 2025-10-01 10:44:57.236218 | controller | status: ACTIVE 2025-10-01 10:44:57.236408 | controller | subnets: [] 2025-10-01 10:44:57.236601 | controller | tags: [] 2025-10-01 10:44:57.236865 | controller | updated_at: '2025-10-01T10:44:55Z' 2025-10-01 10:44:57.508266 | controller | changed 2025-10-01 10:44:57.523489 | 2025-10-01 10:44:57.523644 | TASK [Create subnet - ipv4] 2025-10-01 10:44:59.659397 | controller | allocation_pools: 2025-10-01 10:44:59.659563 | controller | - end: 192.168.122.254 2025-10-01 10:44:59.659574 | controller | start: 192.168.122.2 2025-10-01 10:44:59.659583 | controller | cidr: 192.168.122.0/24 2025-10-01 10:44:59.659683 | controller | created_at: '2025-10-01T10:44:59Z' 2025-10-01 10:44:59.659777 | controller | description: '' 2025-10-01 10:44:59.659871 | controller | dns_nameservers: [] 2025-10-01 10:44:59.660020 | controller | dns_publish_fixed_ip: null 2025-10-01 10:44:59.660160 | controller | enable_dhcp: false 2025-10-01 10:44:59.660259 | controller | gateway_ip: 192.168.122.1 2025-10-01 10:44:59.660349 | controller | host_routes: [] 2025-10-01 10:44:59.660459 | controller | id: 2dadc595-7d2f-4545-88a6-efa798fda4f9 2025-10-01 10:44:59.660618 | controller | ip_version: 4 2025-10-01 10:44:59.660724 | controller | ipv6_address_mode: null 2025-10-01 10:44:59.660818 | controller | ipv6_ra_mode: null 2025-10-01 10:44:59.660933 | controller | name: zuul-ci-subnet-eaf3bf33 2025-10-01 10:44:59.661054 | controller | network_id: 61a51c87-5f05-4878-bd5a-345961382f59 2025-10-01 10:44:59.661183 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-01 10:44:59.661281 | controller | revision_number: 0 2025-10-01 10:44:59.661373 | controller | segment_id: null 2025-10-01 10:44:59.661466 | controller | service_types: [] 2025-10-01 10:44:59.661560 | controller | subnetpool_id: null 2025-10-01 10:44:59.661662 | controller | tags: [] 2025-10-01 10:44:59.661819 | controller | updated_at: '2025-10-01T10:44:59Z' 2025-10-01 10:45:00.089139 | controller | changed 2025-10-01 10:45:00.094860 | 2025-10-01 10:45:00.094934 | TASK [Set yaml returned data for further usage] 2025-10-01 10:45:00.145243 | controller | ok 2025-10-01 10:45:00.151517 | 2025-10-01 10:45:00.151575 | TASK [Create router] 2025-10-01 10:45:00.686718 | controller | skipping: Conditional result was False 2025-10-01 10:45:00.695620 | 2025-10-01 10:45:00.695752 | TASK [Set router yaml returned data for further usage] 2025-10-01 10:45:00.755366 | controller | skipping: Conditional result was False 2025-10-01 10:45:00.762374 | 2025-10-01 10:45:00.762747 | TASK [Add router to subnet] 2025-10-01 10:45:01.307556 | controller | skipping: Conditional result was False 2025-10-01 10:45:01.324832 | 2025-10-01 10:45:01.325069 | LOOP [Create ports, VLANs and configure them on the instance] 2025-10-01 10:45:01.385605 | controller | ok: 2025-10-01 10:45:01.386167 | controller | { 2025-10-01 10:45:01.386213 | controller | "key": "controller", 2025-10-01 10:45:01.386241 | controller | "value": { 2025-10-01 10:45:01.386267 | controller | "networks": { 2025-10-01 10:45:01.386291 | controller | "default": { 2025-10-01 10:45:01.386314 | controller | "ip": "192.168.122.11" 2025-10-01 10:45:01.386337 | controller | } 2025-10-01 10:45:01.386360 | controller | } 2025-10-01 10:45:01.386384 | controller | } 2025-10-01 10:45:01.386407 | controller | } 2025-10-01 10:45:04.440264 | controller | ok: 2025-10-01 10:45:04.440371 | controller | { 2025-10-01 10:45:04.440395 | controller | "key": "crc", 2025-10-01 10:45:04.440414 | controller | "value": { 2025-10-01 10:45:04.440430 | controller | "networks": { 2025-10-01 10:45:04.440447 | controller | "default": { 2025-10-01 10:45:04.440463 | controller | "ip": "192.168.122.10" 2025-10-01 10:45:04.440479 | controller | }, 2025-10-01 10:45:04.440495 | controller | "internal-api": { 2025-10-01 10:45:04.440509 | controller | "ip": "172.17.0.5" 2025-10-01 10:45:04.440524 | controller | }, 2025-10-01 10:45:04.440539 | controller | "storage": { 2025-10-01 10:45:04.440553 | controller | "ip": "172.18.0.5" 2025-10-01 10:45:04.440568 | controller | }, 2025-10-01 10:45:04.440582 | controller | "tenant": { 2025-10-01 10:45:04.440597 | controller | "ip": "172.19.0.5" 2025-10-01 10:45:04.440611 | controller | } 2025-10-01 10:45:04.440626 | controller | } 2025-10-01 10:45:04.440641 | controller | } 2025-10-01 10:45:04.440657 | controller | } 2025-10-01 10:45:04.472199 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance.yml 2025-10-01 10:45:04.477343 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance.yml 2025-10-01 10:45:04.492230 | 2025-10-01 10:45:04.492372 | TASK [Create instance ports and attach if necessary] 2025-10-01 10:45:04.515089 | controller | ok 2025-10-01 10:45:04.563905 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance-create-attach-port.yml 2025-10-01 10:45:04.569981 | 2025-10-01 10:45:04.570087 | TASK [Print the host networking data] 2025-10-01 10:45:04.599216 | controller | ok 2025-10-01 10:45:04.604230 | 2025-10-01 10:45:04.604319 | TASK [Create the private network parent port] 2025-10-01 10:45:09.907465 | controller | admin_state_up: true 2025-10-01 10:45:09.907675 | controller | allowed_address_pairs: [] 2025-10-01 10:45:09.907865 | controller | binding_host_id: null 2025-10-01 10:45:09.908008 | controller | binding_profile: {} 2025-10-01 10:45:09.908136 | controller | binding_vif_details: {} 2025-10-01 10:45:09.908262 | controller | binding_vif_type: null 2025-10-01 10:45:09.908413 | controller | binding_vnic_type: normal 2025-10-01 10:45:09.908551 | controller | created_at: '2025-10-01T10:45:08Z' 2025-10-01 10:45:09.908676 | controller | data_plane_status: null 2025-10-01 10:45:09.908791 | controller | description: '' 2025-10-01 10:45:09.908919 | controller | device_id: '' 2025-10-01 10:45:09.909040 | controller | device_owner: '' 2025-10-01 10:45:09.909161 | controller | device_profile: null 2025-10-01 10:45:09.909473 | controller | dns_assignment: 2025-10-01 10:45:09.909588 | controller | - fqdn: host-192-168-122-11.openstacklocal. 2025-10-01 10:45:09.909601 | controller | hostname: host-192-168-122-11 2025-10-01 10:45:09.909608 | controller | ip_address: 192.168.122.11 2025-10-01 10:45:09.909617 | controller | dns_domain: '' 2025-10-01 10:45:09.909727 | controller | dns_name: '' 2025-10-01 10:45:09.909844 | controller | extra_dhcp_opts: [] 2025-10-01 10:45:09.910120 | controller | fixed_ips: 2025-10-01 10:45:09.910262 | controller | - ip_address: 192.168.122.11 2025-10-01 10:45:09.910273 | controller | subnet_id: 2dadc595-7d2f-4545-88a6-efa798fda4f9 2025-10-01 10:45:09.910281 | controller | hardware_offload_type: null 2025-10-01 10:45:09.910389 | controller | hints: '' 2025-10-01 10:45:09.910522 | controller | id: f9909ed2-d900-4b8a-b5a3-7672a64256c9 2025-10-01 10:45:09.910643 | controller | ip_allocation: immediate 2025-10-01 10:45:09.910769 | controller | mac_address: fa:16:3e:da:44:fe 2025-10-01 10:45:09.910925 | controller | name: controller-24dc23bb-0233-40ff-9563-1477c30f8289 2025-10-01 10:45:09.911071 | controller | network_id: 61a51c87-5f05-4878-bd5a-345961382f59 2025-10-01 10:45:09.911196 | controller | numa_affinity_policy: null 2025-10-01 10:45:09.911375 | controller | port_security_enabled: false 2025-10-01 10:45:09.911517 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-01 10:45:09.911644 | controller | propagate_uplink_status: null 2025-10-01 10:45:09.911764 | controller | resource_request: null 2025-10-01 10:45:09.911924 | controller | revision_number: 1 2025-10-01 10:45:09.912054 | controller | qos_network_policy_id: null 2025-10-01 10:45:09.912172 | controller | qos_policy_id: null 2025-10-01 10:45:09.912291 | controller | security_group_ids: [] 2025-10-01 10:45:09.912403 | controller | status: DOWN 2025-10-01 10:45:09.912512 | controller | tags: [] 2025-10-01 10:45:09.912631 | controller | trunk_details: null 2025-10-01 10:45:09.912746 | controller | trusted: null 2025-10-01 10:45:09.912879 | controller | updated_at: '2025-10-01T10:45:08Z' 2025-10-01 10:45:10.147158 | controller | changed 2025-10-01 10:45:10.161751 | 2025-10-01 10:45:10.161896 | TASK [Set common facts for further usage] 2025-10-01 10:45:10.268183 | controller | ok 2025-10-01 10:45:10.282239 | 2025-10-01 10:45:10.282375 | TASK [Create the trunk port] 2025-10-01 10:45:10.835107 | controller | skipping: Conditional result was False 2025-10-01 10:45:10.847675 | 2025-10-01 10:45:10.847858 | TASK [Avoid NetworkManager to automatically picked up the new interface] 2025-10-01 10:45:10.923245 | controller | skipping: Conditional result was False 2025-10-01 10:45:10.938786 | 2025-10-01 10:45:10.938972 | TASK [Refresh NetworkManager] 2025-10-01 10:45:11.015205 | controller | skipping: Conditional result was False 2025-10-01 10:45:11.026968 | 2025-10-01 10:45:11.027137 | TASK [Attach the port to the instance] 2025-10-01 10:45:22.605215 | controller | changed 2025-10-01 10:45:22.611606 | 2025-10-01 10:45:22.611691 | TASK [Wait till the interface exists] 2025-10-01 10:45:22.915759 | controller -> 38.102.83.5 | changed 2025-10-01 10:45:22.924521 | 2025-10-01 10:45:22.924647 | TASK [Prepare interface data to be used configuring trunk and vlan ifaces] 2025-10-01 10:45:23.060188 | controller | ok 2025-10-01 10:45:23.073811 | 2025-10-01 10:45:23.073972 | LOOP [Create VLANs ports and attach them to the trunk] 2025-10-01 10:45:23.106002 | 2025-10-01 10:45:23.106320 | LOOP [Prepare VLANs interface data to be used configuring] 2025-10-01 10:45:23.137619 | 2025-10-01 10:45:23.137901 | LOOP [Create NetworkManager configuration file for the trunk port] 2025-10-01 10:45:23.990078 | controller -> 38.102.83.5 | changed: 2025-10-01 10:45:23.990729 | controller -> 38.102.83.5 | { 2025-10-01 10:45:23.990812 | controller -> 38.102.83.5 | "key": "default", 2025-10-01 10:45:23.990858 | controller -> 38.102.83.5 | "value": { 2025-10-01 10:45:23.991266 | controller -> 38.102.83.5 | "connection": "ci-private-network", 2025-10-01 10:45:23.991377 | controller -> 38.102.83.5 | "gw": "192.168.122.1", 2025-10-01 10:45:23.991475 | controller -> 38.102.83.5 | "iface": "eth1", 2025-10-01 10:45:23.991537 | controller -> 38.102.83.5 | "ip": "192.168.122.11/24", 2025-10-01 10:45:23.991595 | controller -> 38.102.83.5 | "mac": "fa:16:3e:da:44:fe", 2025-10-01 10:45:23.991655 | controller -> 38.102.83.5 | "mtu": "1500" 2025-10-01 10:45:23.991714 | controller -> 38.102.83.5 | } 2025-10-01 10:45:23.991774 | controller -> 38.102.83.5 | } 2025-10-01 10:45:23.991887 | 2025-10-01 10:45:24.011003 | 2025-10-01 10:45:24.011175 | TASK [Refresh NetworkManager] 2025-10-01 10:45:24.959844 | controller -> 38.102.83.5 | changed 2025-10-01 10:45:24.977634 | 2025-10-01 10:45:24.977763 | TASK [Debug fetch IP routes] 2025-10-01 10:45:25.271831 | controller -> 38.102.83.5 | changed 2025-10-01 10:45:25.285900 | 2025-10-01 10:45:25.286073 | TASK [Debug IP routes] 2025-10-01 10:45:25.336099 | controller -> 38.102.83.5 | ok 2025-10-01 10:45:25.351616 | 2025-10-01 10:45:25.351762 | TASK [Create instance ports and attach if necessary] 2025-10-01 10:45:25.398468 | controller | ok 2025-10-01 10:45:25.414950 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-instance-create-attach-port.yml 2025-10-01 10:45:25.423344 | 2025-10-01 10:45:25.423435 | TASK [Print the host networking data] 2025-10-01 10:45:25.476600 | controller | ok 2025-10-01 10:45:25.484236 | 2025-10-01 10:45:25.484317 | TASK [Create the private network parent port] 2025-10-01 10:45:28.802120 | controller | admin_state_up: true 2025-10-01 10:45:28.802228 | controller | allowed_address_pairs: [] 2025-10-01 10:45:28.802449 | controller | binding_host_id: null 2025-10-01 10:45:28.802588 | controller | binding_profile: {} 2025-10-01 10:45:28.802723 | controller | binding_vif_details: {} 2025-10-01 10:45:28.802861 | controller | binding_vif_type: null 2025-10-01 10:45:28.803067 | controller | binding_vnic_type: normal 2025-10-01 10:45:28.803223 | controller | created_at: '2025-10-01T10:45:28Z' 2025-10-01 10:45:28.803368 | controller | data_plane_status: null 2025-10-01 10:45:28.803503 | controller | description: '' 2025-10-01 10:45:28.803635 | controller | device_id: '' 2025-10-01 10:45:28.803764 | controller | device_owner: '' 2025-10-01 10:45:28.803911 | controller | device_profile: null 2025-10-01 10:45:28.804338 | controller | dns_assignment: 2025-10-01 10:45:28.804489 | controller | - fqdn: host-192-168-122-10.openstacklocal. 2025-10-01 10:45:28.804500 | controller | hostname: host-192-168-122-10 2025-10-01 10:45:28.804506 | controller | ip_address: 192.168.122.10 2025-10-01 10:45:28.804514 | controller | dns_domain: '' 2025-10-01 10:45:28.804622 | controller | dns_name: '' 2025-10-01 10:45:28.804784 | controller | extra_dhcp_opts: [] 2025-10-01 10:45:28.805110 | controller | fixed_ips: 2025-10-01 10:45:28.805222 | controller | - ip_address: 192.168.122.10 2025-10-01 10:45:28.805230 | controller | subnet_id: 2dadc595-7d2f-4545-88a6-efa798fda4f9 2025-10-01 10:45:28.805238 | controller | hardware_offload_type: null 2025-10-01 10:45:28.805310 | controller | hints: '' 2025-10-01 10:45:28.805416 | controller | id: b9af134e-9558-4588-bde4-a47fa354a644 2025-10-01 10:45:28.805525 | controller | ip_allocation: immediate 2025-10-01 10:45:28.805689 | controller | mac_address: fa:16:3e:bf:73:6c 2025-10-01 10:45:28.805864 | controller | name: crc-11eb6671-4cb8-4e95-a5bc-2d3f1389495c 2025-10-01 10:45:28.806061 | controller | network_id: 61a51c87-5f05-4878-bd5a-345961382f59 2025-10-01 10:45:28.806227 | controller | numa_affinity_policy: null 2025-10-01 10:45:28.806424 | controller | port_security_enabled: false 2025-10-01 10:45:28.806618 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-01 10:45:28.806776 | controller | propagate_uplink_status: null 2025-10-01 10:45:28.806942 | controller | resource_request: null 2025-10-01 10:45:28.807138 | controller | revision_number: 1 2025-10-01 10:45:28.807285 | controller | qos_network_policy_id: null 2025-10-01 10:45:28.807434 | controller | qos_policy_id: null 2025-10-01 10:45:28.807575 | controller | security_group_ids: [] 2025-10-01 10:45:28.807705 | controller | status: DOWN 2025-10-01 10:45:28.807842 | controller | tags: [] 2025-10-01 10:45:28.808015 | controller | trunk_details: null 2025-10-01 10:45:28.808168 | controller | trusted: null 2025-10-01 10:45:28.808335 | controller | updated_at: '2025-10-01T10:45:28Z' 2025-10-01 10:45:29.032085 | controller | changed 2025-10-01 10:45:29.051216 | 2025-10-01 10:45:29.051423 | TASK [Set common facts for further usage] 2025-10-01 10:45:29.147096 | controller | ok 2025-10-01 10:45:29.162193 | 2025-10-01 10:45:29.162331 | TASK [Create the trunk port] 2025-10-01 10:45:29.710456 | controller | skipping: Conditional result was False 2025-10-01 10:45:29.726127 | 2025-10-01 10:45:29.726320 | TASK [Avoid NetworkManager to automatically picked up the new interface] 2025-10-01 10:45:29.805070 | controller | skipping: Conditional result was False 2025-10-01 10:45:29.822448 | 2025-10-01 10:45:29.822648 | TASK [Refresh NetworkManager] 2025-10-01 10:45:29.891914 | controller | skipping: Conditional result was False 2025-10-01 10:45:29.906606 | 2025-10-01 10:45:29.906752 | TASK [Attach the port to the instance] 2025-10-01 10:45:42.483817 | controller | changed 2025-10-01 10:45:42.490044 | 2025-10-01 10:45:42.490107 | TASK [Wait till the interface exists] 2025-10-01 10:45:42.850050 | controller -> 38.102.83.162 | changed 2025-10-01 10:45:42.857185 | 2025-10-01 10:45:42.857309 | TASK [Prepare interface data to be used configuring trunk and vlan ifaces] 2025-10-01 10:45:43.084260 | controller | ok 2025-10-01 10:45:43.123393 | 2025-10-01 10:45:43.123497 | LOOP [Create VLANs ports and attach them to the trunk] 2025-10-01 10:45:43.171704 | controller | skipping: Conditional result was False 2025-10-01 10:45:46.182048 | controller | skipping: Conditional result was False 2025-10-01 10:45:49.198583 | controller | skipping: Conditional result was False 2025-10-01 10:45:49.215353 | 2025-10-01 10:45:49.215515 | LOOP [Prepare VLANs interface data to be used configuring] 2025-10-01 10:45:49.465476 | controller | ok: 2025-10-01 10:45:49.465679 | controller | { 2025-10-01 10:45:49.465705 | controller | "key": "internal-api", 2025-10-01 10:45:49.465728 | controller | "value": { 2025-10-01 10:45:49.465745 | controller | "ip": "172.17.0.5" 2025-10-01 10:45:49.465761 | controller | } 2025-10-01 10:45:49.465776 | controller | } 2025-10-01 10:45:49.465799 | 2025-10-01 10:45:49.516933 | controller | ok: 2025-10-01 10:45:49.517051 | controller | { 2025-10-01 10:45:49.517076 | controller | "key": "storage", 2025-10-01 10:45:49.517094 | controller | "value": { 2025-10-01 10:45:49.517110 | controller | "ip": "172.18.0.5" 2025-10-01 10:45:49.517126 | controller | } 2025-10-01 10:45:49.517141 | controller | } 2025-10-01 10:45:49.571157 | controller | ok: 2025-10-01 10:45:49.571259 | controller | { 2025-10-01 10:45:49.571281 | controller | "key": "tenant", 2025-10-01 10:45:49.571299 | controller | "value": { 2025-10-01 10:45:49.571316 | controller | "ip": "172.19.0.5" 2025-10-01 10:45:49.571332 | controller | } 2025-10-01 10:45:49.571347 | controller | } 2025-10-01 10:45:49.586474 | 2025-10-01 10:45:49.586626 | LOOP [Create NetworkManager configuration file for the trunk port] 2025-10-01 10:45:50.570621 | controller -> 38.102.83.162 | changed: 2025-10-01 10:45:50.570837 | controller -> 38.102.83.162 | { 2025-10-01 10:45:50.570864 | controller -> 38.102.83.162 | "key": "default", 2025-10-01 10:45:50.570883 | controller -> 38.102.83.162 | "value": { 2025-10-01 10:45:50.570899 | controller -> 38.102.83.162 | "connection": "ci-private-network", 2025-10-01 10:45:50.570915 | controller -> 38.102.83.162 | "gw": "192.168.122.1", 2025-10-01 10:45:50.570930 | controller -> 38.102.83.162 | "iface": "ens7", 2025-10-01 10:45:50.570945 | controller -> 38.102.83.162 | "ip": "192.168.122.10/24", 2025-10-01 10:45:50.570960 | controller -> 38.102.83.162 | "mac": "fa:16:3e:bf:73:6c", 2025-10-01 10:45:50.570975 | controller -> 38.102.83.162 | "mtu": "1500" 2025-10-01 10:45:50.570990 | controller -> 38.102.83.162 | } 2025-10-01 10:45:50.571004 | controller -> 38.102.83.162 | } 2025-10-01 10:45:51.435904 | controller -> 38.102.83.162 | changed: 2025-10-01 10:45:51.436054 | controller -> 38.102.83.162 | { 2025-10-01 10:45:51.436082 | controller -> 38.102.83.162 | "key": "internal-api", 2025-10-01 10:45:51.436100 | controller -> 38.102.83.162 | "value": { 2025-10-01 10:45:51.436116 | controller -> 38.102.83.162 | "connection": "ci-private-network-20", 2025-10-01 10:45:51.436132 | controller -> 38.102.83.162 | "iface": "ens7.20", 2025-10-01 10:45:51.436147 | controller -> 38.102.83.162 | "ip": "172.17.0.5/24", 2025-10-01 10:45:51.436162 | controller -> 38.102.83.162 | "mac": "52:54:00:56:c9:d5", 2025-10-01 10:45:51.436177 | controller -> 38.102.83.162 | "mtu": "1496", 2025-10-01 10:45:51.436191 | controller -> 38.102.83.162 | "parent_iface": "ens7", 2025-10-01 10:45:51.436206 | controller -> 38.102.83.162 | "vlan": 20 2025-10-01 10:45:51.436220 | controller -> 38.102.83.162 | } 2025-10-01 10:45:51.436235 | controller -> 38.102.83.162 | } 2025-10-01 10:45:52.318097 | controller -> 38.102.83.162 | changed: 2025-10-01 10:45:52.318201 | controller -> 38.102.83.162 | { 2025-10-01 10:45:52.318225 | controller -> 38.102.83.162 | "key": "storage", 2025-10-01 10:45:52.318242 | controller -> 38.102.83.162 | "value": { 2025-10-01 10:45:52.318259 | controller -> 38.102.83.162 | "connection": "ci-private-network-21", 2025-10-01 10:45:52.318275 | controller -> 38.102.83.162 | "iface": "ens7.21", 2025-10-01 10:45:52.318290 | controller -> 38.102.83.162 | "ip": "172.18.0.5/24", 2025-10-01 10:45:52.318306 | controller -> 38.102.83.162 | "mac": "52:54:00:ad:ea:19", 2025-10-01 10:45:52.318320 | controller -> 38.102.83.162 | "mtu": "1496", 2025-10-01 10:45:52.318335 | controller -> 38.102.83.162 | "parent_iface": "ens7", 2025-10-01 10:45:52.318349 | controller -> 38.102.83.162 | "vlan": 21 2025-10-01 10:45:52.318363 | controller -> 38.102.83.162 | } 2025-10-01 10:45:52.318484 | controller -> 38.102.83.162 | } 2025-10-01 10:45:53.229113 | controller -> 38.102.83.162 | changed: 2025-10-01 10:45:53.229382 | controller -> 38.102.83.162 | { 2025-10-01 10:45:53.229414 | controller -> 38.102.83.162 | "key": "tenant", 2025-10-01 10:45:53.229432 | controller -> 38.102.83.162 | "value": { 2025-10-01 10:45:53.229449 | controller -> 38.102.83.162 | "connection": "ci-private-network-22", 2025-10-01 10:45:53.229483 | controller -> 38.102.83.162 | "iface": "ens7.22", 2025-10-01 10:45:53.229501 | controller -> 38.102.83.162 | "ip": "172.19.0.5/24", 2025-10-01 10:45:53.229517 | controller -> 38.102.83.162 | "mac": "52:54:00:47:f2:25", 2025-10-01 10:45:53.229533 | controller -> 38.102.83.162 | "mtu": "1496", 2025-10-01 10:45:53.229548 | controller -> 38.102.83.162 | "parent_iface": "ens7", 2025-10-01 10:45:53.229563 | controller -> 38.102.83.162 | "vlan": 22 2025-10-01 10:45:53.229578 | controller -> 38.102.83.162 | } 2025-10-01 10:45:53.229593 | controller -> 38.102.83.162 | } 2025-10-01 10:45:53.250699 | 2025-10-01 10:45:53.250832 | TASK [Refresh NetworkManager] 2025-10-01 10:45:53.979184 | controller -> 38.102.83.162 | changed 2025-10-01 10:45:53.987716 | 2025-10-01 10:45:53.987821 | TASK [Debug fetch IP routes] 2025-10-01 10:45:54.257140 | controller -> 38.102.83.162 | changed 2025-10-01 10:45:54.270309 | 2025-10-01 10:45:54.270547 | TASK [Debug IP routes] 2025-10-01 10:45:54.320977 | controller -> 38.102.83.162 | ok 2025-10-01 10:45:54.331533 | 2025-10-01 10:45:54.331643 | TASK [Display some data about network ports] 2025-10-01 10:45:56.138865 | controller | +--------------------------------------+-------------------------------------------------+-------------------+-------------------------------------------------------------------------------+--------+ 2025-10-01 10:45:56.249689 | controller | | ID | Name | MAC Address | Fixed IP Addresses | Status | 2025-10-01 10:45:56.249847 | controller | +--------------------------------------+-------------------------------------------------+-------------------+-------------------------------------------------------------------------------+--------+ 2025-10-01 10:45:56.249856 | controller | | b9af134e-9558-4588-bde4-a47fa354a644 | crc-11eb6671-4cb8-4e95-a5bc-2d3f1389495c | fa:16:3e:bf:73:6c | ip_address='192.168.122.10', subnet_id='2dadc595-7d2f-4545-88a6-efa798fda4f9' | ACTIVE | 2025-10-01 10:45:56.249862 | controller | | e14532ab-82aa-409c-837a-47e8dcd5d368 | | fa:16:3e:7c:3e:1e | | DOWN | 2025-10-01 10:45:56.249868 | controller | | f9909ed2-d900-4b8a-b5a3-7672a64256c9 | controller-24dc23bb-0233-40ff-9563-1477c30f8289 | fa:16:3e:da:44:fe | ip_address='192.168.122.11', subnet_id='2dadc595-7d2f-4545-88a6-efa798fda4f9' | ACTIVE | 2025-10-01 10:45:56.249874 | controller | +--------------------------------------+-------------------------------------------------+-------------------+-------------------------------------------------------------------------------+--------+ 2025-10-01 10:45:56.381447 | controller | changed 2025-10-01 10:45:56.394445 | 2025-10-01 10:45:56.395164 | LOOP [Display server configuration] 2025-10-01 10:45:58.676579 | controller | changed 2025-10-01 10:45:58.676869 | controller | changed: All items complete 2025-10-01 10:45:58.676906 | 2025-10-01 10:46:03.837634 | controller | changed 2025-10-01 10:46:03.864190 | 2025-10-01 10:46:03.864470 | TASK [Fetch underneath provider DNSs] 2025-10-01 10:46:03.908297 | controller | ok 2025-10-01 10:46:03.931474 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network-fetch-provider-dns.yml 2025-10-01 10:46:03.944435 | 2025-10-01 10:46:03.944543 | TASK [Fetch the DNS list of the default interface] 2025-10-01 10:46:04.312169 | controller | ok 2025-10-01 10:46:04.319279 | 2025-10-01 10:46:04.319361 | TASK [Set provider DNS for further usage] 2025-10-01 10:46:04.408672 | controller | ok 2025-10-01 10:46:04.420471 | 2025-10-01 10:46:04.420593 | LOOP [Save networking data to file for further usage] 2025-10-01 10:46:05.388066 | controller -> 38.102.83.162 | changed: "crc" 2025-10-01 10:46:06.138847 | controller -> 38.102.83.5 | changed: "controller" 2025-10-01 10:46:06.158555 | 2025-10-01 10:46:06.158771 | TASK [Remove cloud_secrets file] 2025-10-01 10:46:06.417914 | controller | changed 2025-10-01 10:46:06.473694 | 2025-10-01 10:46:06.473858 | PLAY RECAP 2025-10-01 10:46:06.473906 | controller | ok: 48 changed: 22 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-01 10:46:06.473927 | 2025-10-01 10:46:06.595610 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/bootstrap-ci-network.yml@master] 2025-10-01 10:46:06.600885 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/prepare-crc.yaml@master] 2025-10-01 10:46:07.273525 | 2025-10-01 10:46:07.273650 | PLAY [Prefer ipv4 over ipv6] 2025-10-01 10:46:07.311211 | 2025-10-01 10:46:07.311349 | TASK [Configure /etc/gai.conf to prever ipv4 over ipv6] 2025-10-01 10:46:07.365162 | controller | skipping: Conditional result was False 2025-10-01 10:46:07.386274 | crc | skipping: Conditional result was False 2025-10-01 10:46:07.437730 | 2025-10-01 10:46:07.437884 | PLAY [Generic task for migration time to crc-cloud] 2025-10-01 10:46:07.465489 | 2025-10-01 10:46:07.465611 | TASK [Check if there is a image build date file] 2025-10-01 10:46:07.955216 | crc | ok 2025-10-01 10:46:07.964592 | 2025-10-01 10:46:07.964707 | TASK [Print image date] 2025-10-01 10:46:08.480501 | crc | Tue Sep 30 21:34:10 UTC 2025 | Image type: crc-cloud 2025-10-01 10:46:08.526479 | crc | ok 2025-10-01 10:46:08.576277 | 2025-10-01 10:46:08.576419 | TASK [Run crc-cloud preparation] 2025-10-01 10:46:08.611330 | crc | ok 2025-10-01 10:46:08.649701 | 2025-10-01 10:46:08.649839 | TASK [prepare-crc-cloud : Print build date] 2025-10-01 10:46:08.681612 | crc | ok 2025-10-01 10:46:08.691292 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/build_date.yaml 2025-10-01 10:46:08.701391 | 2025-10-01 10:46:08.701457 | TASK [prepare-crc-cloud : Check if there is a image build date file] 2025-10-01 10:46:08.981761 | crc | ok 2025-10-01 10:46:08.991354 | 2025-10-01 10:46:08.991486 | TASK [prepare-crc-cloud : Print image date if available] 2025-10-01 10:46:09.347833 | crc | Tue Sep 30 21:34:10 UTC 2025 | Image type: crc-cloud 2025-10-01 10:46:09.550109 | crc | ok 2025-10-01 10:46:09.560557 | 2025-10-01 10:46:09.560692 | TASK [prepare-crc-cloud : Tune Kubelet config file] 2025-10-01 10:46:09.596361 | crc | skipping: Conditional result was False 2025-10-01 10:46:09.606978 | 2025-10-01 10:46:09.607120 | TASK [prepare-crc-cloud : Reboot CRC host to get the network interfaces] 2025-10-01 10:46:09.640700 | crc | ok 2025-10-01 10:46:09.649942 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/reboot_crc.yaml 2025-10-01 10:46:09.662225 | 2025-10-01 10:46:09.662295 | TASK [prepare-crc-cloud : Reboot host after adding pull secret and changing kubelet node params] 2025-10-01 10:46:28.532974 | crc | changed 2025-10-01 10:46:28.544383 | 2025-10-01 10:46:28.544983 | TASK [Start Zuul console after reboot] 2025-10-01 10:46:28.569831 | crc | ok 2025-10-01 10:46:28.627515 | 2025-10-01 10:46:28.627647 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-01 10:46:29.230470 | crc | ok 2025-10-01 10:46:29.263695 | 2025-10-01 10:46:29.263831 | TASK [prepare-crc-cloud : Prepare for executing crc-cloud] 2025-10-01 10:46:29.298916 | crc | ok 2025-10-01 10:46:29.311543 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/pre.yaml 2025-10-01 10:46:29.329513 | 2025-10-01 10:46:29.329609 | TASK [prepare-crc-cloud : Disable overwriting /etc/resolv.conf by the NetworkManager] 2025-10-01 10:46:30.491798 | crc | changed 2025-10-01 10:46:30.511342 | 2025-10-01 10:46:30.511536 | TASK [prepare-crc-cloud : Reload NetworkManager after creating custom rules] 2025-10-01 10:46:31.422318 | crc | changed 2025-10-01 10:46:31.444084 | 2025-10-01 10:46:31.444313 | TASK [prepare-crc-cloud : Inject pull secret into /var/lib/kubelet/config.json] 2025-10-01 10:46:32.459198 | crc | changed 2025-10-01 10:46:32.467859 | 2025-10-01 10:46:32.467970 | TASK [prepare-crc-cloud : Check if etcd slow profile set] 2025-10-01 10:46:32.492412 | crc | skipping: Conditional result was False 2025-10-01 10:46:32.504288 | 2025-10-01 10:46:32.504421 | TASK [prepare-crc-cloud : Use ramdisk for etcd] 2025-10-01 10:46:32.536552 | crc | ok 2025-10-01 10:46:32.548206 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/ramdisk.yaml 2025-10-01 10:46:32.560398 | 2025-10-01 10:46:32.560463 | TASK [prepare-crc-cloud : Move current etcd to other place] 2025-10-01 10:46:33.143801 | crc | ok 2025-10-01 10:46:33.160079 | 2025-10-01 10:46:33.160236 | TASK [prepare-crc-cloud : Mount ramdisk] 2025-10-01 10:46:33.642960 | crc | changed 2025-10-01 10:46:33.659580 | 2025-10-01 10:46:33.659718 | TASK [prepare-crc-cloud : Set proper permissions after mount] 2025-10-01 10:46:34.176959 | crc | changed 2025-10-01 10:46:34.193513 | 2025-10-01 10:46:34.193691 | TASK [prepare-crc-cloud : Copy content from old location to ramdisk] 2025-10-01 10:46:36.328373 | crc | changed 2025-10-01 10:46:36.336302 | 2025-10-01 10:46:36.336405 | TASK [prepare-crc-cloud : Set proper SELinux context] 2025-10-01 10:46:36.974922 | crc | ok 2025-10-01 10:46:36.989693 | 2025-10-01 10:46:36.989831 | TASK [prepare-crc-cloud : Block crc.testing domains] 2025-10-01 10:46:37.018367 | crc | ok 2025-10-01 10:46:37.035217 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/block_crc_domains.yaml 2025-10-01 10:46:37.059556 | 2025-10-01 10:46:37.059710 | LOOP [prepare-crc-cloud : Set crc.testing domains into /etc/hosts] 2025-10-01 10:46:37.479603 | crc | changed: line added 2025-10-01 10:46:37.758335 | crc | changed: line added 2025-10-01 10:46:38.039180 | crc | changed: line added 2025-10-01 10:46:38.305051 | crc | changed: line added 2025-10-01 10:46:38.626262 | crc | changed: line added 2025-10-01 10:46:38.940225 | crc | changed: line added 2025-10-01 10:46:39.219202 | crc | changed: line added 2025-10-01 10:46:39.510918 | crc | changed: line added 2025-10-01 10:46:39.531566 | 2025-10-01 10:46:39.531678 | TASK [prepare-crc-cloud : Get default interface name] 2025-10-01 10:46:39.873256 | crc | ens3 2025-10-01 10:46:40.082806 | crc | ok 2025-10-01 10:46:40.093403 | 2025-10-01 10:46:40.093476 | LOOP [prepare-crc-cloud : Block CRC domains also using iptables] 2025-10-01 10:46:40.780488 | crc | ok 2025-10-01 10:46:40.780854 | crc | changed: All items complete 2025-10-01 10:46:40.780912 | 2025-10-01 10:46:41.103836 | crc | ok 2025-10-01 10:46:41.419512 | crc | ok 2025-10-01 10:46:41.748716 | crc | ok 2025-10-01 10:46:42.033951 | crc | ok 2025-10-01 10:46:42.329958 | crc | ok 2025-10-01 10:46:42.623811 | crc | ok 2025-10-01 10:46:42.926551 | crc | ok 2025-10-01 10:46:42.946290 | 2025-10-01 10:46:42.946409 | TASK [prepare-crc-cloud : Set required facts] 2025-10-01 10:46:42.967777 | crc | ok 2025-10-01 10:46:42.981430 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/set_vars.yaml 2025-10-01 10:46:42.997803 | 2025-10-01 10:46:42.997917 | TASK [prepare-crc-cloud : Set required facts] 2025-10-01 10:46:43.049545 | crc | Output suppressed because no_log was given 2025-10-01 10:46:43.056381 | 2025-10-01 10:46:43.056484 | TASK [Start crc-cloud role when Zuul defined] 2025-10-01 10:46:43.134250 | crc | ok 2025-10-01 10:46:43.180083 | 2025-10-01 10:46:43.180190 | TASK [deploy-crc-cloud : Check if pull-secret is provided] 2025-10-01 10:46:43.203944 | crc | skipping: Conditional result was False 2025-10-01 10:46:43.211593 | 2025-10-01 10:46:43.211658 | TASK [deploy-crc-cloud : Create kubeconfig] 2025-10-01 10:46:43.242184 | crc | ok 2025-10-01 10:46:43.251490 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/kubeconfig.yaml 2025-10-01 10:46:43.263982 | 2025-10-01 10:46:43.264061 | TASK [deploy-crc-cloud : Create kube directory] 2025-10-01 10:46:43.573622 | crc | changed 2025-10-01 10:46:43.582310 | 2025-10-01 10:46:43.582441 | TASK [deploy-crc-cloud : Copy kubeconfig to user dir] 2025-10-01 10:46:44.063236 | crc | changed 2025-10-01 10:46:44.078438 | 2025-10-01 10:46:44.078573 | TASK [deploy-crc-cloud : Setup dnsmasq] 2025-10-01 10:46:44.100544 | crc | ok 2025-10-01 10:46:44.114690 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/dnsmasq.yaml 2025-10-01 10:46:44.128906 | 2025-10-01 10:46:44.128993 | TASK [deploy-crc-cloud : Create crc-dnsmasq.conf] 2025-10-01 10:46:45.022836 | crc | changed 2025-10-01 10:46:45.033655 | 2025-10-01 10:46:45.033783 | LOOP [deploy-crc-cloud : Set this host as first nameserver in /etc/resolv.conf] 2025-10-01 10:46:45.429830 | crc | changed: line replaced 2025-10-01 10:46:45.728478 | crc | ok 2025-10-01 10:46:45.988480 | crc | ok 2025-10-01 10:46:46.004488 | 2025-10-01 10:46:46.004609 | TASK [deploy-crc-cloud : Disable overwriting /etc/resolv.conf by the NetworkManager] 2025-10-01 10:46:46.866136 | crc | ok 2025-10-01 10:46:46.876765 | 2025-10-01 10:46:46.876850 | TASK [deploy-crc-cloud : Restart NetworkManager when its needed] 2025-10-01 10:46:46.902498 | crc | skipping: Conditional result was False 2025-10-01 10:46:46.920546 | 2025-10-01 10:46:46.920730 | TASK [deploy-crc-cloud : Restart dnsmasq] 2025-10-01 10:46:47.767472 | crc | changed 2025-10-01 10:46:47.783173 | 2025-10-01 10:46:47.783301 | TASK [deploy-crc-cloud : Start kubelet] 2025-10-01 10:46:47.819910 | crc | ok 2025-10-01 10:46:47.834986 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/kubelet.yaml 2025-10-01 10:46:47.866452 | 2025-10-01 10:46:47.866593 | TASK [deploy-crc-cloud : Start and enable kubelet] 2025-10-01 10:47:02.058362 | crc | changed 2025-10-01 10:47:02.083678 | 2025-10-01 10:47:02.083797 | TASK [deploy-crc-cloud : Wait for port 6443 to be up] 2025-10-01 10:48:02.584875 | crc | ok 2025-10-01 10:48:02.595778 | 2025-10-01 10:48:02.595902 | TASK [deploy-crc-cloud : Wait for API to start before continue] 2025-10-01 10:48:04.658918 | crc | NAMESPACE NAME READY STATUS RESTARTS AGE 2025-10-01 10:48:04.659007 | crc | openshift-apiserver-operator openshift-apiserver-operator-796bbdcf4f-82cpb 0/1 Pending 0 43s 2025-10-01 10:48:04.659019 | crc | openshift-apiserver apiserver-76f77b778f-g7ngh 0/2 Pending 0 43s 2025-10-01 10:48:04.659028 | crc | openshift-authentication-operator authentication-operator-69f744f599-bfk7h 0/1 Pending 0 43s 2025-10-01 10:48:04.659041 | crc | openshift-authentication oauth-openshift-558db77b4-lt8z5 0/1 Pending 0 43s 2025-10-01 10:48:04.659049 | crc | openshift-cluster-machine-approver machine-approver-56656f9798-fhg78 0/2 Pending 0 43s 2025-10-01 10:48:04.659057 | crc | openshift-cluster-samples-operator cluster-samples-operator-665b6dd947-dkcsf 0/2 Pending 0 42s 2025-10-01 10:48:04.659091 | crc | openshift-cluster-version cluster-version-operator-5c965bbfc6-cvkhc 0/1 Pending 0 42s 2025-10-01 10:48:04.659100 | crc | openshift-config-operator openshift-config-operator-7777fb866f-v6qsx 0/1 Pending 0 42s 2025-10-01 10:48:04.659107 | crc | openshift-console-operator console-operator-58897d9998-r57r6 0/1 Pending 0 42s 2025-10-01 10:48:04.659116 | crc | openshift-console console-f9d7485db-g9b56 0/1 Pending 0 42s 2025-10-01 10:48:04.659124 | crc | openshift-console downloads-7954f5f757-zjz96 0/1 Pending 0 42s 2025-10-01 10:48:04.659132 | crc | openshift-controller-manager-operator openshift-controller-manager-operator-756b6f6bc6-jvr9f 0/1 Pending 0 42s 2025-10-01 10:48:04.659204 | crc | openshift-controller-manager controller-manager-879f6c89f-rmh4p 0/1 Pending 0 42s 2025-10-01 10:48:04.659217 | crc | openshift-dns-operator dns-operator-744455d44c-9kd56 0/2 Pending 0 42s 2025-10-01 10:48:04.659231 | crc | openshift-dns node-resolver-m4tbl 0/1 Pending 0 43s 2025-10-01 10:48:04.659240 | crc | openshift-etcd-operator etcd-operator-b45778765-g6tcb 0/1 Pending 0 42s 2025-10-01 10:48:04.659248 | crc | openshift-image-registry cluster-image-registry-operator-dc59b4c8b-w44nv 0/1 Pending 0 42s 2025-10-01 10:48:04.659256 | crc | openshift-image-registry image-registry-697d97f7c8-b87zf 0/1 Pending 0 42s 2025-10-01 10:48:04.659309 | crc | openshift-image-registry node-ca-m7wwm 0/1 Pending 0 43s 2025-10-01 10:48:04.659322 | crc | openshift-ingress-operator ingress-operator-5b745b69d9-vz7lb 0/2 Pending 0 42s 2025-10-01 10:48:04.659333 | crc | openshift-ingress router-default-5444994796-nd5ll 0/1 Pending 0 42s 2025-10-01 10:48:04.659398 | crc | openshift-kube-apiserver-operator kube-apiserver-operator-766d6c64bb-thpxt 0/1 Pending 0 42s 2025-10-01 10:48:04.659459 | crc | openshift-kube-apiserver kube-apiserver-crc 0/5 Pending 0 42s 2025-10-01 10:48:04.659474 | crc | openshift-kube-controller-manager-operator kube-controller-manager-operator-78b949d7b-89qgb 0/1 Pending 0 42s 2025-10-01 10:48:04.659496 | crc | openshift-kube-controller-manager kube-controller-manager-crc 0/4 Pending 0 37s 2025-10-01 10:48:04.659550 | crc | openshift-kube-scheduler-operator openshift-kube-scheduler-operator-5fdd9b5758-tbpkc 0/1 Pending 0 42s 2025-10-01 10:48:04.659563 | crc | openshift-kube-scheduler openshift-kube-scheduler-crc 0/3 Pending 0 10s 2025-10-01 10:48:04.659573 | crc | openshift-kube-storage-version-migrator-operator kube-storage-version-migrator-operator-b67b599dd-7489b 0/1 Pending 0 42s 2025-10-01 10:48:04.659584 | crc | openshift-kube-storage-version-migrator migrator-59844c95c7-z5w2q 0/2 Pending 0 42s 2025-10-01 10:48:04.659593 | crc | openshift-machine-api control-plane-machine-set-operator-78cbb6b69f-pzrdj 0/1 Pending 0 42s 2025-10-01 10:48:04.659602 | crc | openshift-machine-api machine-api-operator-5694c8668f-zzdq8 0/2 Pending 0 42s 2025-10-01 10:48:04.659617 | crc | openshift-machine-config-operator machine-config-controller-84d6567774-52tbf 0/2 Pending 0 42s 2025-10-01 10:48:04.659627 | crc | openshift-machine-config-operator machine-config-daemon-x9mft 0/2 Pending 0 43s 2025-10-01 10:48:04.659637 | crc | openshift-machine-config-operator machine-config-operator-74547568cd-sqqlj 0/2 Pending 0 42s 2025-10-01 10:48:04.659647 | crc | openshift-marketplace marketplace-operator-79b997595-f4vhs 0/1 Pending 0 42s 2025-10-01 10:48:04.659656 | crc | openshift-multus multus-additional-cni-plugins-qcgwj 0/1 Pending 0 42s 2025-10-01 10:48:04.659672 | crc | openshift-multus multus-admission-controller-857f4d67dd-kvvwm 0/2 Pending 0 42s 2025-10-01 10:48:04.659680 | crc | openshift-multus multus-f7mt8 0/1 Pending 0 42s 2025-10-01 10:48:04.659688 | crc | openshift-multus network-metrics-daemon-2rxz5 0/2 Pending 0 42s 2025-10-01 10:48:04.659696 | crc | openshift-network-console networking-console-plugin-85b44fc459-gdk6g 1/1 Running 2 220d 2025-10-01 10:48:04.659708 | crc | openshift-network-diagnostics network-check-source-55646444c4-trplf 1/1 Running 2 220d 2025-10-01 10:48:04.659718 | crc | openshift-network-diagnostics network-check-target-xd92c 1/1 Running 2 220d 2025-10-01 10:48:04.659726 | crc | openshift-network-node-identity network-node-identity-vrzqb 2/2 Running 7 220d 2025-10-01 10:48:04.659734 | crc | openshift-network-operator iptables-alerter-4ln5h 1/1 Running 2 220d 2025-10-01 10:48:04.659742 | crc | openshift-network-operator network-operator-58b4c7f79c-55gtf 1/1 Running 4 220d 2025-10-01 10:48:04.659749 | crc | openshift-oauth-apiserver apiserver-7bbb656c7d-lmcwp 0/1 Pending 0 42s 2025-10-01 10:48:04.659757 | crc | openshift-operator-lifecycle-manager catalog-operator-68c6474976-mrpdc 0/1 Pending 0 42s 2025-10-01 10:48:04.659765 | crc | openshift-operator-lifecycle-manager collect-profiles-29321925-ml446 0/1 Pending 0 42s 2025-10-01 10:48:04.659783 | crc | openshift-operator-lifecycle-manager olm-operator-6b444d44fb-qkt89 0/1 Pending 0 42s 2025-10-01 10:48:04.659791 | crc | openshift-operator-lifecycle-manager package-server-manager-789f6589d5-nrqmk 0/2 Pending 0 42s 2025-10-01 10:48:04.659799 | crc | openshift-operator-lifecycle-manager packageserver-d55dfcdfc-rl2hx 0/1 Pending 0 42s 2025-10-01 10:48:04.659807 | crc | openshift-ovn-kubernetes ovnkube-control-plane-749d76644c-dvmjn 0/2 Pending 0 42s 2025-10-01 10:48:04.659817 | crc | openshift-ovn-kubernetes ovnkube-node-tbh97 0/8 Pending 0 42s 2025-10-01 10:48:04.659828 | crc | openshift-route-controller-manager route-controller-manager-6576b87f9c-m4fq2 0/1 Pending 0 42s 2025-10-01 10:48:04.659839 | crc | openshift-service-ca-operator service-ca-operator-777779d784-9l8qf 0/1 Pending 0 42s 2025-10-01 10:48:04.659867 | crc | openshift-service-ca service-ca-9c57cc56f-lktg6 0/1 Pending 0 42s 2025-10-01 10:48:05.156731 | crc | ok 2025-10-01 10:48:05.165862 | 2025-10-01 10:48:05.165972 | TASK [deploy-crc-cloud : Replace default pubkey] 2025-10-01 10:48:05.188114 | crc | ok 2025-10-01 10:48:05.199498 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/pubkey.yaml 2025-10-01 10:48:05.218880 | 2025-10-01 10:48:05.219181 | TASK [deploy-crc-cloud : Check if id_rsa.pub exists] 2025-10-01 10:48:05.515097 | crc | ok 2025-10-01 10:48:05.530975 | 2025-10-01 10:48:05.531176 | TASK [deploy-crc-cloud : Read pub key] 2025-10-01 10:48:06.119931 | crc | skipping: Conditional result was False 2025-10-01 10:48:06.141514 | 2025-10-01 10:48:06.141664 | TASK [deploy-crc-cloud : Wait for machineconfig] 2025-10-01 10:48:06.166973 | crc | skipping: Conditional result was False 2025-10-01 10:48:06.175661 | 2025-10-01 10:48:06.175762 | TASK [deploy-crc-cloud : Patch machineconfig 99-master-ssh] 2025-10-01 10:48:06.718838 | crc | skipping: Conditional result was False 2025-10-01 10:48:06.753495 | 2025-10-01 10:48:06.753741 | TASK [deploy-crc-cloud : Wait for cluster become healthy] 2025-10-01 10:48:06.795284 | crc | ok 2025-10-01 10:48:06.810421 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-01 10:48:06.843526 | 2025-10-01 10:48:06.843715 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy etcd|openshift-apiserver] 2025-10-01 10:48:07.343981 | crc | True 2025-10-01 10:48:07.345182 | crc | False 2025-10-01 10:49:40.454917 | crc | changed 2025-10-01 10:49:40.468504 | 2025-10-01 10:49:40.468700 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-01 10:49:40.566052 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-01 10:49:40.575405 | 2025-10-01 10:49:40.575493 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-01 10:49:40.600102 | crc | skipping: Conditional result was False 2025-10-01 10:49:40.609530 | 2025-10-01 10:49:40.609657 | TASK [deploy-crc-cloud : Set credentials] 2025-10-01 10:49:40.643959 | crc | ok 2025-10-01 10:49:40.659494 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/set_credentials.yaml 2025-10-01 10:49:40.683674 | 2025-10-01 10:49:40.683787 | TASK [deploy-crc-cloud : Ensure htpasswd.txt does not exists] 2025-10-01 10:49:40.950028 | crc | ok 2025-10-01 10:49:40.958061 | 2025-10-01 10:49:40.958146 | TASK [deploy-crc-cloud : Create temporary directory] 2025-10-01 10:49:41.358586 | crc | changed 2025-10-01 10:49:41.374404 | 2025-10-01 10:49:41.374548 | TASK [deploy-crc-cloud : Create Dockerfile] 2025-10-01 10:49:42.135960 | crc | changed 2025-10-01 10:49:42.152560 | 2025-10-01 10:49:42.152698 | TASK [deploy-crc-cloud : Build container image for htpasswd] 2025-10-01 10:50:05.819603 | crc | STEP 1/3: FROM quay.io/centos/centos:stream9-minimal 2025-10-01 10:50:05.823820 | crc | Trying to pull quay.io/centos/centos:stream9-minimal... 2025-10-01 10:50:06.362926 | crc | Getting image source signatures 2025-10-01 10:50:06.363076 | crc | Copying blob sha256:d8c0dbbf20f3017cc356fa40af20d191b0e85e25d7706ee63c2a0cb5ebf6fc7a 2025-10-01 10:50:08.178224 | crc | Copying config sha256:20aff0b003bb92b55d5d701079b860731e831f5cb1708e195790448697d67e85 2025-10-01 10:50:08.200011 | crc | Writing manifest to image destination 2025-10-01 10:50:08.273701 | crc | STEP 2/3: RUN microdnf --setopt=tsflags=nodocs --setopt=install_weak_deps=0 install -y httpd-tools 2025-10-01 10:50:08.883686 | crc | Downloading metadata... 2025-10-01 10:50:09.660584 | crc | Downloading metadata... 2025-10-01 10:50:12.341919 | crc | Downloading metadata... 2025-10-01 10:50:20.433490 | crc | Package Repository Size 2025-10-01 10:50:20.588514 | crc | Installing: 2025-10-01 10:50:20.588565 | crc | apr-1.7.0-12.el9.x86_64 appstream 126.2 kB 2025-10-01 10:50:20.588571 | crc | apr-util-1.6.1-23.el9.x86_64 appstream 97.3 kB 2025-10-01 10:50:20.588577 | crc | apr-util-bdb-1.6.1-23.el9.x86_64 appstream 13.3 kB 2025-10-01 10:50:20.588583 | crc | expat-2.5.0-5.el9.x86_64 baseos 118.6 kB 2025-10-01 10:50:20.588588 | crc | httpd-tools-2.4.62-7.el9.x86_64 appstream 81.5 kB 2025-10-01 10:50:20.588594 | crc | libdb-5.3.28-57.el9.x86_64 baseos 752.9 kB 2025-10-01 10:50:20.588600 | crc | Transaction Summary: 2025-10-01 10:50:20.588605 | crc | Installing: 6 packages 2025-10-01 10:50:20.588612 | crc | Reinstalling: 0 packages 2025-10-01 10:50:20.588619 | crc | Upgrading: 0 packages 2025-10-01 10:50:20.588626 | crc | Obsoleting: 0 packages 2025-10-01 10:50:20.588633 | crc | Removing: 0 packages 2025-10-01 10:50:20.588645 | crc | Downgrading: 0 packages 2025-10-01 10:50:20.588660 | crc | Downloading packages... 2025-10-01 10:50:21.703237 | crc | warning: Signature not supported. Hash algorithm SHA1 not available. 2025-10-01 10:50:21.725066 | crc | 2025-10-01 10:50:21.725129 | crc | (microdnf:1): libdnf-WARNING **: 10:50:21.702: failed to parse public key for /etc/pki/rpm-gpg/RPM-GPG-KEY-CentOS-SIG-Extras 2025-10-01 10:50:21.725162 | crc | Running transaction test... 2025-10-01 10:50:21.918155 | crc | Installing: apr;1.7.0-12.el9;x86_64;appstream 2025-10-01 10:50:21.925996 | crc | Installing: expat;2.5.0-5.el9;x86_64;baseos 2025-10-01 10:50:21.933875 | crc | Installing: libdb;5.3.28-57.el9;x86_64;baseos 2025-10-01 10:50:21.945469 | crc | Installing: apr-util-bdb;1.6.1-23.el9;x86_64;appstream 2025-10-01 10:50:21.949657 | crc | Installing: apr-util;1.6.1-23.el9;x86_64;appstream 2025-10-01 10:50:21.952457 | crc | Installing: httpd-tools;2.4.62-7.el9;x86_64;appstream 2025-10-01 10:50:21.999855 | crc | Complete. 2025-10-01 10:50:23.387272 | crc | --> 00d07daa3d35 2025-10-01 10:50:23.405141 | crc | STEP 3/3: ENTRYPOINT ["htpasswd", "-Bbn"] 2025-10-01 10:50:23.437284 | crc | COMMIT localhost/htpasswd:latest 2025-10-01 10:50:23.437335 | crc | --> 5d72a0fcde8d 2025-10-01 10:50:23.475052 | crc | Successfully tagged localhost/htpasswd:latest 2025-10-01 10:50:23.475103 | crc | 5d72a0fcde8d26d54ae9b56c11d1e7e5170b172a73c80350b9e2999b3917dfbb 2025-10-01 10:50:23.771639 | crc | changed 2025-10-01 10:50:23.793258 | 2025-10-01 10:50:23.793468 | LOOP [deploy-crc-cloud : Get htpasswd] 2025-10-01 10:50:23.859648 | crc | Output suppressed because no_log was given 2025-10-01 10:50:23.885482 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/get_htpasswd.yaml 2025-10-01 10:50:23.887653 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/get_htpasswd.yaml 2025-10-01 10:50:23.889697 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/get_htpasswd.yaml 2025-10-01 10:50:23.914530 | 2025-10-01 10:50:23.914782 | TASK [deploy-crc-cloud : Get htpasswd for developer] 2025-10-01 10:50:24.378055 | crc | time="2025-10-01T10:50:24Z" level=warning msg="The input device is not a TTY. The --tty and --interactive flags might not work properly" 2025-10-01 10:50:24.996479 | crc | changed 2025-10-01 10:50:25.007350 | 2025-10-01 10:50:25.007498 | TASK [deploy-crc-cloud : Get htpasswd for kubeadmin] 2025-10-01 10:50:25.473261 | crc | time="2025-10-01T10:50:25Z" level=warning msg="The input device is not a TTY. The --tty and --interactive flags might not work properly" 2025-10-01 10:50:26.054559 | crc | changed 2025-10-01 10:50:26.068604 | 2025-10-01 10:50:26.068728 | TASK [deploy-crc-cloud : Get htpasswd for redhat] 2025-10-01 10:50:26.498943 | crc | time="2025-10-01T10:50:26Z" level=warning msg="The input device is not a TTY. The --tty and --interactive flags might not work properly" 2025-10-01 10:50:28.645724 | crc | changed 2025-10-01 10:50:28.665297 | 2025-10-01 10:50:28.665510 | TASK [deploy-crc-cloud : Cleanup htpasswd.txt file] 2025-10-01 10:50:29.233701 | crc | changed 2025-10-01 10:50:29.250344 | 2025-10-01 10:50:29.250523 | TASK [deploy-crc-cloud : Create secret with generic htpass-secret] 2025-10-01 10:50:29.836625 | crc | changed 2025-10-01 10:50:29.855131 | 2025-10-01 10:50:29.855303 | TASK [deploy-crc-cloud : Replace htpass-secret] 2025-10-01 10:50:30.379778 | crc | secret/htpass-secret replaced 2025-10-01 10:50:30.443419 | crc | changed 2025-10-01 10:50:30.503871 | 2025-10-01 10:50:30.504127 | TASK [deploy-crc-cloud : Remove temporary directory] 2025-10-01 10:50:30.765163 | crc | changed 2025-10-01 10:50:30.772338 | 2025-10-01 10:50:30.772427 | TASK [deploy-crc-cloud : Replace default CA] 2025-10-01 10:50:30.805642 | crc | ok 2025-10-01 10:50:30.817057 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/replace_default_ca.yaml 2025-10-01 10:50:30.843394 | 2025-10-01 10:50:30.843515 | TASK [deploy-crc-cloud : Generate key] 2025-10-01 10:50:32.393135 | crc | changed 2025-10-01 10:50:32.414351 | 2025-10-01 10:50:32.414507 | TASK [deploy-crc-cloud : Generate cert] 2025-10-01 10:50:32.982714 | crc | changed 2025-10-01 10:50:32.993386 | 2025-10-01 10:50:32.993478 | TASK [deploy-crc-cloud : Generate csr] 2025-10-01 10:50:33.391830 | crc | ....+......+..............+.+..+.+.....+................+...+..+...............+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*..+.........+............+.........+.........+.+..+..........+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*.+........+.............+.........+..+.+...+............+...............+..+.......+.....+.+...+.....+......+...+...+....+...+..+...+......+.+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++ 2025-10-01 10:50:33.429072 | crc | .+...+...+.+........+.......+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*..+.............+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++*....+.................+....+...+........+....+...+..................+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++ 2025-10-01 10:50:33.432985 | crc | ----- 2025-10-01 10:50:33.552439 | crc | changed 2025-10-01 10:50:33.568801 | 2025-10-01 10:50:33.568938 | TASK [deploy-crc-cloud : Generate user cert] 2025-10-01 10:50:33.950452 | crc | Certificate request self-signature ok 2025-10-01 10:50:33.962046 | crc | subject=O = ${GROUP}, CN = core 2025-10-01 10:50:34.125492 | crc | changed 2025-10-01 10:50:34.141583 | 2025-10-01 10:50:34.141734 | TASK [deploy-crc-cloud : Create configmap] 2025-10-01 10:50:34.724479 | crc | configmap/client-ca-custom created 2025-10-01 10:50:35.210715 | crc | changed 2025-10-01 10:50:35.277445 | 2025-10-01 10:50:35.277612 | TASK [deploy-crc-cloud : Patch apiserver] 2025-10-01 10:50:35.759044 | crc | apiserver.config.openshift.io/cluster patched 2025-10-01 10:50:35.840376 | crc | changed 2025-10-01 10:50:35.857172 | 2025-10-01 10:50:35.857322 | TASK [deploy-crc-cloud : Create configmap] 2025-10-01 10:50:36.342613 | crc | W1001 10:50:36.342507 13853 helpers.go:703] --dry-run is deprecated and can be replaced with --dry-run=client. 2025-10-01 10:50:36.423585 | crc | configmap/admin-kubeconfig-client-ca replaced 2025-10-01 10:50:36.920844 | crc | changed 2025-10-01 10:50:36.937450 | 2025-10-01 10:50:36.937648 | TASK [deploy-crc-cloud : Login to the OpenShift cluster] 2025-10-01 10:50:36.981785 | crc | ok 2025-10-01 10:50:37.001232 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/login.yaml 2025-10-01 10:50:37.048530 | 2025-10-01 10:50:37.048675 | TASK [deploy-crc-cloud : Try to login after all changes] 2025-10-01 10:50:37.546925 | crc | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-01 10:50:37.705220 | crc | 2025-10-01 10:50:37.705286 | crc | Login failed (401 Unauthorized) 2025-10-01 10:50:37.712322 | crc | Verify you have provided the correct credentials. 2025-10-01 10:51:19.876619 | crc | ok 2025-10-01 10:51:19.888211 | 2025-10-01 10:51:19.888298 | TASK [deploy-crc-cloud : Patch pull secret] 2025-10-01 10:51:19.977591 | crc | ok 2025-10-01 10:51:20.002389 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/patch_pull_secret.yaml 2025-10-01 10:51:20.065351 | 2025-10-01 10:51:20.065494 | TASK [deploy-crc-cloud : Patch pull secret] 2025-10-01 10:51:21.243507 | crc | Output suppressed because no_log was given 2025-10-01 10:51:21.259723 | 2025-10-01 10:51:21.259926 | TASK [deploy-crc-cloud : Wait for cluster become healthy after patching CA and pull secret] 2025-10-01 10:51:21.293655 | crc | ok 2025-10-01 10:51:21.311193 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-01 10:51:21.349294 | 2025-10-01 10:51:21.349432 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy etcd|openshift-apiserver] 2025-10-01 10:51:21.830966 | crc | True 2025-10-01 10:51:21.831860 | crc | True 2025-10-01 10:51:21.896406 | crc | changed 2025-10-01 10:51:21.913372 | 2025-10-01 10:51:21.913563 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-01 10:51:21.966247 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-01 10:51:21.977510 | 2025-10-01 10:51:21.977635 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-01 10:51:22.013313 | crc | skipping: Conditional result was False 2025-10-01 10:51:22.025614 | 2025-10-01 10:51:22.025758 | TASK [deploy-crc-cloud : Create certificate and patch secret] 2025-10-01 10:51:22.052753 | crc | skipping: Conditional result was False 2025-10-01 10:51:22.065414 | 2025-10-01 10:51:22.065521 | TASK [deploy-crc-cloud : Wait for cluster become healthy after adding domain] 2025-10-01 10:51:22.104515 | crc | ok 2025-10-01 10:51:22.116976 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-01 10:51:22.158824 | 2025-10-01 10:51:22.158951 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy etcd|openshift-apiserver] 2025-10-01 10:51:22.655726 | crc | True 2025-10-01 10:51:22.657007 | crc | True 2025-10-01 10:51:22.699469 | crc | changed 2025-10-01 10:51:22.716191 | 2025-10-01 10:51:22.716400 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-01 10:51:22.772298 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-01 10:51:22.787722 | 2025-10-01 10:51:22.787901 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-01 10:51:22.823956 | crc | skipping: Conditional result was False 2025-10-01 10:51:22.841925 | 2025-10-01 10:51:22.842145 | TASK [deploy-crc-cloud : Patch ingress config] 2025-10-01 10:51:22.890156 | crc | skipping: Conditional result was False 2025-10-01 10:51:22.902002 | 2025-10-01 10:51:22.902129 | TASK [deploy-crc-cloud : Patch api server] 2025-10-01 10:51:22.927507 | crc | skipping: Conditional result was False 2025-10-01 10:51:22.937986 | 2025-10-01 10:51:22.938103 | TASK [deploy-crc-cloud : Patch default route] 2025-10-01 10:51:22.962108 | crc | skipping: Conditional result was False 2025-10-01 10:51:22.970586 | 2025-10-01 10:51:22.970699 | TASK [deploy-crc-cloud : Wait for cluster become healthy after changing ingress api server and default route] 2025-10-01 10:51:22.992334 | crc | ok 2025-10-01 10:51:23.000488 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/src/github.com/crc-org/crc-cloud/ansible/roles/deploy-crc-cloud/tasks/wait_cluster_become_healthy.yaml 2025-10-01 10:51:23.034783 | 2025-10-01 10:51:23.034921 | TASK [deploy-crc-cloud : Check if specified OpenShift components are healthy authentication|console|etcd|ingress|openshift-apiserver] 2025-10-01 10:51:23.560109 | crc | True 2025-10-01 10:51:23.561468 | crc | True 2025-10-01 10:51:23.561481 | crc | True 2025-10-01 10:51:23.561488 | crc | True 2025-10-01 10:51:23.561495 | crc | True 2025-10-01 10:51:23.618079 | crc | changed 2025-10-01 10:51:23.626726 | 2025-10-01 10:51:23.626851 | TASK [deploy-crc-cloud : Output success message if components are healthy] 2025-10-01 10:51:23.658893 | crc | ok: OpenShift cluster components have become healthy in approximately 20 * 15 seconds. 2025-10-01 10:51:23.666175 | 2025-10-01 10:51:23.666247 | TASK [deploy-crc-cloud : Fail if any components are still unhealthy] 2025-10-01 10:51:23.690975 | crc | skipping: Conditional result was False 2025-10-01 10:51:23.699214 | 2025-10-01 10:51:23.699325 | TASK [deploy-crc-cloud : Get console route] 2025-10-01 10:51:23.713647 | crc | skipping: Conditional result was False 2025-10-01 10:51:23.736255 | 2025-10-01 10:51:23.736412 | TASK [Start crc-cloud role when Zuul is not defined] 2025-10-01 10:51:23.762798 | crc | skipping: Conditional result was False 2025-10-01 10:51:23.773927 | 2025-10-01 10:51:23.774082 | TASK [prepare-crc-cloud : Recreate kubelet config.json] 2025-10-01 10:51:23.799523 | crc | ok 2025-10-01 10:51:23.817703 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/inject-pull-secret.yaml 2025-10-01 10:51:23.849640 | 2025-10-01 10:51:23.849804 | TASK [prepare-crc-cloud : Fail when openshift_pull_sec not provided] 2025-10-01 10:51:23.895788 | crc | skipping: Conditional result was False 2025-10-01 10:51:23.904650 | 2025-10-01 10:51:23.904865 | TASK [prepare-crc-cloud : Cleanup file] 2025-10-01 10:51:24.455901 | crc | Output suppressed because no_log was given 2025-10-01 10:51:24.463554 | 2025-10-01 10:51:24.463635 | TASK [prepare-crc-cloud : Copy pull-secret to kubelet config.json] 2025-10-01 10:51:24.836388 | crc | Output suppressed because no_log was given 2025-10-01 10:51:24.846842 | 2025-10-01 10:51:24.846928 | TASK [prepare-crc-cloud : Replace singleqoute with doublequote] 2025-10-01 10:51:25.408950 | crc | changed: 42 replacements made 2025-10-01 10:51:25.425739 | 2025-10-01 10:51:25.425914 | TASK [prepare-crc-cloud : Remove spaces] 2025-10-01 10:51:25.821089 | crc | changed: 20 replacements made 2025-10-01 10:51:25.829064 | 2025-10-01 10:51:25.829150 | TASK [prepare-crc-cloud : Ensure you are logged in to the OpenShift] 2025-10-01 10:51:25.851613 | crc | ok 2025-10-01 10:51:25.861839 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/openshift_login.yaml 2025-10-01 10:51:25.891790 | 2025-10-01 10:51:25.891917 | TASK [prepare-crc-cloud : Login to the OpenShift] 2025-10-01 10:51:26.341888 | crc | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-01 10:51:26.435931 | crc | 2025-10-01 10:51:26.436003 | crc | Login successful. 2025-10-01 10:51:26.455532 | crc | 2025-10-01 10:51:26.455598 | crc | You have access to 65 projects, the list has been suppressed. You can list all projects with 'oc projects' 2025-10-01 10:51:26.489428 | crc | 2025-10-01 10:51:26.489483 | crc | Using project "default". 2025-10-01 10:51:26.932893 | crc | ok 2025-10-01 10:51:26.945619 | 2025-10-01 10:51:26.945818 | TASK [prepare-crc-cloud : Post tasks after crc-cloud script execution] 2025-10-01 10:51:26.984787 | crc | ok 2025-10-01 10:51:27.001862 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/post.yaml 2025-10-01 10:51:27.136963 | 2025-10-01 10:51:27.137202 | LOOP [prepare-crc-cloud : Set DNS nameservers provided by cloud provider] 2025-10-01 10:51:27.456452 | crc | changed: line added 2025-10-01 10:51:27.456776 | crc | changed: All items complete 2025-10-01 10:51:27.456817 | 2025-10-01 10:51:27.734131 | crc | changed: line added 2025-10-01 10:51:27.757947 | 2025-10-01 10:51:27.758317 | TASK [prepare-crc-cloud : Increase dnsmasq cache size] 2025-10-01 10:51:28.121761 | crc | changed: line added 2025-10-01 10:51:28.141091 | 2025-10-01 10:51:28.141271 | TASK [prepare-crc-cloud : Reload NetworkManager after adding cache and DNS server] 2025-10-01 10:51:28.946836 | crc | changed 2025-10-01 10:51:28.960446 | 2025-10-01 10:51:28.960530 | TASK [prepare-crc-cloud : Ensure kube config does not exists] 2025-10-01 10:51:29.252271 | crc | ok 2025-10-01 10:51:29.260310 | 2025-10-01 10:51:29.260377 | TASK [prepare-crc-cloud : Copy new generated KUBECONFIG] 2025-10-01 10:51:29.274692 | crc | skipping: Conditional result was False 2025-10-01 10:51:29.283418 | 2025-10-01 10:51:29.283486 | TASK [prepare-crc-cloud : Delete all openshift-marketplace pods] 2025-10-01 10:51:29.747644 | crc | pod "certified-operators-j8mrp" deleted 2025-10-01 10:51:29.753222 | crc | pod "community-operators-6hk5v" deleted 2025-10-01 10:51:29.758166 | crc | pod "marketplace-operator-79b997595-f4vhs" deleted 2025-10-01 10:51:29.770286 | crc | pod "redhat-marketplace-n7mfw" deleted 2025-10-01 10:51:29.782224 | crc | pod "redhat-operators-9jqvr" deleted 2025-10-01 10:51:31.339169 | crc | ok 2025-10-01 10:51:31.355261 | 2025-10-01 10:51:31.355438 | TASK [prepare-crc-cloud : Pause machineconfigpool] 2025-10-01 10:51:31.398122 | crc | ok 2025-10-01 10:51:31.416582 | crc | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/roles/prepare-crc-cloud/tasks/pause_mcp.yaml 2025-10-01 10:51:31.452117 | 2025-10-01 10:51:31.452208 | LOOP [prepare-crc-cloud : Pause the machineconfig configuration if mcp is not needed] 2025-10-01 10:51:32.003945 | crc | ok 2025-10-01 10:51:32.469343 | crc | ok 2025-10-01 10:51:32.486962 | 2025-10-01 10:51:32.487066 | TASK [prepare-crc-cloud : Print current machineconfigpool] 2025-10-01 10:51:33.037647 | crc | NAME CONFIG UPDATED UPDATING DEGRADED MACHINECOUNT READYMACHINECOUNT UPDATEDMACHINECOUNT DEGRADEDMACHINECOUNT AGE 2025-10-01 10:51:33.037728 | crc | master rendered-master-f83a149c7490c3b0bf850df839837383 False True True 1 0 0 1 220d 2025-10-01 10:51:33.042101 | crc | worker rendered-worker-594cc07c9feefb5e37f2530ac457d36c True False False 0 0 0 0 220d 2025-10-01 10:51:33.535360 | crc | ok 2025-10-01 10:51:33.545936 | 2025-10-01 10:51:33.546084 | TASK [prepare-crc-cloud : Set low profile to etcd to avoid flakiness] 2025-10-01 10:51:33.560334 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.570516 | 2025-10-01 10:51:33.570662 | TASK [prepare-crc-cloud : Fix machineconfigpool degradation] 2025-10-01 10:51:33.594897 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.604223 | 2025-10-01 10:51:33.604358 | TASK [prepare-crc-cloud : Remove drain machineconfig for the node] 2025-10-01 10:51:33.629560 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.641998 | 2025-10-01 10:51:33.642180 | TASK [prepare-crc-cloud : Post machineconfigpool tasks] 2025-10-01 10:51:33.657653 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.667104 | 2025-10-01 10:51:33.667242 | TASK [prepare-crc-cloud : Enable monitoring and cluster-monitoring-operator] 2025-10-01 10:51:33.681991 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.699891 | 2025-10-01 10:51:33.700033 | TASK [Run crc-extracted preparation] 2025-10-01 10:51:33.714616 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.776135 | 2025-10-01 10:51:33.776395 | TASK [Fail when image build date does not exists] 2025-10-01 10:51:33.811928 | crc | skipping: Conditional result was False 2025-10-01 10:51:33.842879 | 2025-10-01 10:51:33.842989 | PLAY [Set IOPS and Read/Write disk limitation] 2025-10-01 10:51:33.874089 | 2025-10-01 10:51:33.874214 | TASK [Set limit for disk usage - IOPS and Read/Write] 2025-10-01 10:51:33.939238 | crc | ok 2025-10-01 10:51:33.955240 | controller | ok 2025-10-01 10:51:33.992514 | 2025-10-01 10:51:33.992621 | TASK [disk-usage-limitation : Get block device major:minor] 2025-10-01 10:51:34.399503 | crc | 252:0 2025-10-01 10:51:34.562026 | controller | 252:0 2025-10-01 10:51:34.578350 | crc | ok 2025-10-01 10:51:34.598007 | controller | ok 2025-10-01 10:51:34.607626 | 2025-10-01 10:51:34.607734 | LOOP [disk-usage-limitation : Ensure that some cgroup dirs exists] 2025-10-01 10:51:34.882081 | controller | ok: "/sys/fs/cgroup/init.scope" 2025-10-01 10:51:34.882361 | controller | ok: All items complete 2025-10-01 10:51:34.882390 | 2025-10-01 10:51:34.969347 | crc | ok: "/sys/fs/cgroup/init.scope" 2025-10-01 10:51:35.125229 | controller | changed: "/sys/fs/cgroup/machine.slice" 2025-10-01 10:51:35.280680 | crc | ok: "/sys/fs/cgroup/machine.slice" 2025-10-01 10:51:35.327359 | controller | ok: "/sys/fs/cgroup/system.slice" 2025-10-01 10:51:35.531749 | controller | ok: "/sys/fs/cgroup/user.slice" 2025-10-01 10:51:35.558614 | crc | ok: "/sys/fs/cgroup/system.slice" 2025-10-01 10:51:35.861247 | crc | ok: "/sys/fs/cgroup/user.slice" 2025-10-01 10:51:35.875904 | 2025-10-01 10:51:35.876441 | TASK [disk-usage-limitation : Enable IO limit] 2025-10-01 10:51:36.176762 | controller | changed: line replaced 2025-10-01 10:51:36.290157 | crc | changed: line replaced 2025-10-01 10:51:36.299390 | 2025-10-01 10:51:36.299479 | TASK [disk-usage-limitation : Flush handlers that will call systemd daemon-reload] 2025-10-01 10:51:36.315208 | 2025-10-01 10:51:36.315292 | TASK [disk-usage-limitation : Flush handlers that will call systemd daemon-reload] 2025-10-01 10:51:36.328712 | 2025-10-01 10:51:36.328775 | TASK [disk-usage-limitation : Reload systemd daemon after enabling IOAccounting] 2025-10-01 10:51:37.441387 | controller | ok 2025-10-01 10:51:38.510775 | crc | ok 2025-10-01 10:51:38.525189 | 2025-10-01 10:51:38.525341 | TASK [disk-usage-limitation : Wait for system.slice cgroup to have io.max file] 2025-10-01 10:51:38.848136 | controller | ok 2025-10-01 10:51:38.899509 | crc | ok 2025-10-01 10:51:38.915587 | 2025-10-01 10:51:38.915749 | LOOP [disk-usage-limitation : Set IOPS limit in the root cgroup] 2025-10-01 10:51:39.218144 | controller | ok 2025-10-01 10:51:39.218927 | controller | ok: All items complete 2025-10-01 10:51:39.219081 | 2025-10-01 10:51:39.296943 | crc | ok 2025-10-01 10:51:39.460866 | controller | ok 2025-10-01 10:51:39.618688 | crc | ok 2025-10-01 10:51:39.691373 | controller | ok 2025-10-01 10:51:39.899830 | crc | ok 2025-10-01 10:51:39.917001 | controller | ok 2025-10-01 10:51:40.254865 | crc | ok 2025-10-01 10:51:40.275623 | 2025-10-01 10:51:40.275775 | TASK [disk-usage-limitation : Verify the IOPS limit] 2025-10-01 10:51:40.684141 | crc | init 2025-10-01 10:51:40.686468 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.686772 | crc | machine 2025-10-01 10:51:40.688876 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.689156 | crc | system 2025-10-01 10:51:40.690116 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.690274 | crc | user 2025-10-01 10:51:40.691123 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.611377 | controller | init 2025-10-01 10:51:40.615919 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.615943 | controller | machine 2025-10-01 10:51:40.615960 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.615968 | controller | system 2025-10-01 10:51:40.615977 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.615983 | controller | user 2025-10-01 10:51:40.615989 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:40.876106 | controller | ok 2025-10-01 10:51:40.893096 | crc | ok 2025-10-01 10:51:40.907394 | 2025-10-01 10:51:40.907583 | TASK [disk-usage-limitation : Check if kubepods.slice exists] 2025-10-01 10:51:41.235355 | controller | ok 2025-10-01 10:51:41.271197 | crc | ok 2025-10-01 10:51:41.283172 | 2025-10-01 10:51:41.283273 | TASK [disk-usage-limitation : Set the limit] 2025-10-01 10:51:41.866824 | controller | skipping: Conditional result was False 2025-10-01 10:51:41.925223 | crc | ok 2025-10-01 10:51:41.933768 | 2025-10-01 10:51:41.933858 | TASK [disk-usage-limitation : Verify the IOPS limit - kubepods slice] 2025-10-01 10:51:42.252393 | crc | kubepods 2025-10-01 10:51:42.254195 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.508424 | controller | skipping: Conditional result was False 2025-10-01 10:51:42.524270 | crc | ok 2025-10-01 10:51:42.538192 | 2025-10-01 10:51:42.538370 | TASK [disk-usage-limitation : Print the current io.max value] 2025-10-01 10:51:42.631377 | crc | ok: 2025-10-01 10:51:42.631529 | crc | init 2025-10-01 10:51:42.631554 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.631575 | crc | machine 2025-10-01 10:51:42.631593 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.631611 | crc | system 2025-10-01 10:51:42.631628 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.631646 | crc | user 2025-10-01 10:51:42.631664 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 kubepods 2025-10-01 10:51:42.631681 | crc | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.636710 | controller | ok: 2025-10-01 10:51:42.636757 | controller | init 2025-10-01 10:51:42.636780 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.636799 | controller | machine 2025-10-01 10:51:42.636817 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.636834 | controller | system 2025-10-01 10:51:42.636851 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.636867 | controller | user 2025-10-01 10:51:42.636883 | controller | 252:0 rbps=262144000 wbps=262144000 riops=18000 wiops=18000 2025-10-01 10:51:42.693298 | 2025-10-01 10:51:42.693400 | PLAY RECAP 2025-10-01 10:51:42.693440 | controller | ok: 9 changed: 2 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2025-10-01 10:51:42.693466 | crc | ok: 104 changed: 43 unreachable: 0 failed: 0 skipped: 27 rescued: 0 ignored: 0 2025-10-01 10:51:42.693484 | 2025-10-01 10:51:42.814324 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/prepare-crc.yaml@master] 2025-10-01 10:51:42.822733 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-01 10:51:43.420366 | 2025-10-01 10:51:43.420494 | PLAY [all,!compute] 2025-10-01 10:51:43.468037 | 2025-10-01 10:51:43.468163 | TASK [Enable container-tools rhel-modules for c8/crc node] 2025-10-01 10:51:44.030811 | crc | skipping: Conditional result was False 2025-10-01 10:51:44.031350 | controller | skipping: Conditional result was False 2025-10-01 10:51:44.037715 | 2025-10-01 10:51:44.037784 | TASK [Install podman] 2025-10-01 10:51:44.143293 | crc | skipping: Conditional result was False 2025-10-01 10:53:25.221776 | controller | changed 2025-10-01 10:53:25.236513 | 2025-10-01 10:53:25.236665 | TASK [Set var name for quay login zuul secret] 2025-10-01 10:53:25.286272 | controller | skipping: Conditional result was False 2025-10-01 10:53:25.317661 | crc | skipping: Conditional result was False 2025-10-01 10:53:25.331692 | 2025-10-01 10:53:25.331871 | TASK [Print the username] 2025-10-01 10:53:25.830302 | controller | openstack-k8s-operators+cirobot 2025-10-01 10:53:25.932338 | crc | skipping: Conditional result was False 2025-10-01 10:53:25.945177 | controller | ok: Runtime: 0:00:00.008498 2025-10-01 10:53:25.958245 | 2025-10-01 10:53:25.958399 | TASK [Fail when user or password is not set] 2025-10-01 10:53:26.038082 | controller | skipping: Conditional result was False 2025-10-01 10:53:26.059677 | crc | skipping: Conditional result was False 2025-10-01 10:53:26.075208 | 2025-10-01 10:53:26.075361 | TASK [Set vars for quay login] 2025-10-01 10:53:26.158449 | controller | Output suppressed because no_log was given 2025-10-01 10:53:26.171080 | 2025-10-01 10:53:26.171228 | LOOP [Perform container registry login(s) with podman] 2025-10-01 10:53:27.066264 | controller | Output suppressed because no_log was given 2025-10-01 10:53:27.080005 | 2025-10-01 10:53:27.080239 | LOOP [Perform container registry login(s) with buildah] 2025-10-01 10:53:27.156048 | controller | Output suppressed because no_log was given 2025-10-01 10:53:27.156302 | 2025-10-01 10:53:27.173034 | 2025-10-01 10:53:27.173174 | TASK [Set Insecure registry for content provider] 2025-10-01 10:53:27.231264 | controller | skipping: Conditional result was False 2025-10-01 10:53:27.242209 | crc | skipping: Conditional result was False 2025-10-01 10:53:27.306478 | 2025-10-01 10:53:27.306610 | PLAY RECAP 2025-10-01 10:53:27.306658 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-10-01 10:53:27.306684 | crc | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 9 rescued: 0 ignored: 0 2025-10-01 10:53:27.306702 | 2025-10-01 10:53:27.415295 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/podman.yaml@master] 2025-10-01 10:53:27.422301 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/data_plane_adoption/dpa_RH_subscription_registry_login.yaml@master] 2025-10-01 10:53:28.054726 | 2025-10-01 10:53:28.054828 | PLAY [rh-subscription] 2025-10-01 10:53:28.054915 | 2025-10-01 10:53:28.054948 | PLAY RECAP 2025-10-01 10:53:28.054977 | 2025-10-01 10:53:28.129631 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/data_plane_adoption/dpa_RH_subscription_registry_login.yaml@master] 2025-10-01 10:53:28.136878 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-customizations.yml@main] 2025-10-01 10:53:28.815593 | 2025-10-01 10:53:28.815715 | PLAY [Tweak CRC node] 2025-10-01 10:53:28.841994 | 2025-10-01 10:53:28.842114 | TASK [Load network parameters] 2025-10-01 10:53:29.495163 | crc | ok 2025-10-01 10:53:29.509567 | 2025-10-01 10:53:29.509724 | TASK [Check which dnsmasq config we must edit] 2025-10-01 10:53:29.970974 | crc | ok 2025-10-01 10:53:29.985807 | 2025-10-01 10:53:29.985999 | TASK [Ensure crc knows about its second NIC] 2025-10-01 10:53:30.964971 | crc | changed 2025-10-01 10:53:31.017376 | 2025-10-01 10:53:31.017520 | TASK [Ensure crc does not get "public" DNS] 2025-10-01 10:53:31.821675 | crc | changed 2025-10-01 10:53:31.838386 | 2025-10-01 10:53:31.838555 | TASK [Restart NetworkManager] 2025-10-01 10:53:32.950887 | crc | changed 2025-10-01 10:53:32.970783 | 2025-10-01 10:53:32.970921 | LOOP [Configure dns forwarders] 2025-10-01 10:53:33.434232 | crc | ok 2025-10-01 10:53:33.708050 | crc | ok 2025-10-01 10:53:33.734791 | 2025-10-01 10:53:33.734928 | TASK [Configure local DNS for CRC pod] 2025-10-01 10:53:34.304264 | crc | ok 2025-10-01 10:53:34.322978 | 2025-10-01 10:53:34.323214 | TASK [Configure dnsmasq listen-address to listen on both br-ex and ci-private-network] 2025-10-01 10:53:34.788770 | crc | changed: line added 2025-10-01 10:53:34.798562 | 2025-10-01 10:53:34.798649 | TASK [Restart native dnsmasq service] 2025-10-01 10:53:35.369417 | crc | changed 2025-10-01 10:53:35.390381 | 2025-10-01 10:53:35.390523 | TASK [Stop dnsmasq] 2025-10-01 10:53:35.418296 | crc | skipping: Conditional result was False 2025-10-01 10:53:35.436430 | 2025-10-01 10:53:35.436602 | TASK [Make sure that crc-dnsmasq is not running] 2025-10-01 10:53:35.463454 | crc | skipping: Conditional result was False 2025-10-01 10:53:35.480587 | 2025-10-01 10:53:35.480729 | TASK [Start dnsmasq] 2025-10-01 10:53:35.506993 | crc | skipping: Conditional result was False 2025-10-01 10:53:35.525522 | 2025-10-01 10:53:35.525675 | TASK [Wait for CRC to be ready] 2025-10-01 10:53:36.146215 | crc | WARNING: Using insecure TLS client config. Setting this option is not supported! 2025-10-01 10:53:36.281572 | crc | 2025-10-01 10:53:36.281632 | crc | Login successful. 2025-10-01 10:53:36.306982 | crc | 2025-10-01 10:53:36.307035 | crc | You have access to 65 projects, the list has been suppressed. You can list all projects with 'oc projects' 2025-10-01 10:53:36.333056 | crc | 2025-10-01 10:53:36.333121 | crc | Using project "default". 2025-10-01 10:53:36.585894 | crc | changed 2025-10-01 10:53:36.603376 | 2025-10-01 10:53:36.603542 | TASK [Set insecure registry on crc node] 2025-10-01 10:53:36.640901 | crc | skipping: Conditional result was False 2025-10-01 10:53:36.695942 | 2025-10-01 10:53:36.696084 | PLAY [Tweak Controller] 2025-10-01 10:53:36.722779 | 2025-10-01 10:53:36.722883 | TASK [Install other packages] 2025-10-01 10:53:46.606672 | controller | changed 2025-10-01 10:53:46.615656 | 2025-10-01 10:53:46.615779 | LOOP [Ensure we know compute host keys] 2025-10-01 10:53:47.219248 | controller | changed 2025-10-01 10:53:47.219522 | controller | ok: All items complete 2025-10-01 10:53:47.219583 | 2025-10-01 10:53:47.684074 | controller | changed 2025-10-01 10:53:47.707689 | 2025-10-01 10:53:47.707852 | TASK [Generate an ssh keypair] 2025-10-01 10:53:48.013573 | controller | Generating public/private ecdsa key pair. 2025-10-01 10:53:48.013981 | controller | Your identification has been saved in /home/zuul/.ssh/id_cifw 2025-10-01 10:53:48.013998 | controller | Your public key has been saved in /home/zuul/.ssh/id_cifw.pub 2025-10-01 10:53:48.014005 | controller | The key fingerprint is: 2025-10-01 10:53:48.014012 | controller | SHA256:MyX6fJmxMmVXUchOXy0Ew+UDxjyXSWCnMvjvBNuL6vc zuul@np0005464320.novalocal 2025-10-01 10:53:48.014056 | controller | The key's randomart image is: 2025-10-01 10:53:48.014064 | controller | +---[ECDSA 256]---+ 2025-10-01 10:53:48.014070 | controller | | +BB*=o| 2025-10-01 10:53:48.014076 | controller | | . o=*O.o| 2025-10-01 10:53:48.014082 | controller | | o + .=+o.| 2025-10-01 10:53:48.014087 | controller | | . + o ....| 2025-10-01 10:53:48.014093 | controller | | . S * . | 2025-10-01 10:53:48.014099 | controller | | o = @ | 2025-10-01 10:53:48.014105 | controller | | = * + | 2025-10-01 10:53:48.014110 | controller | | +.+ . | 2025-10-01 10:53:48.014116 | controller | | .oo..E | 2025-10-01 10:53:48.014122 | controller | +----[SHA256]-----+ 2025-10-01 10:53:48.267520 | controller | changed 2025-10-01 10:53:48.281339 | 2025-10-01 10:53:48.281513 | TASK [Get public key] 2025-10-01 10:53:48.575192 | controller | ok 2025-10-01 10:53:48.588005 | 2025-10-01 10:53:48.588220 | TASK [Register pub key as a fact] 2025-10-01 10:53:48.668431 | controller | ok 2025-10-01 10:53:48.680416 | 2025-10-01 10:53:48.680539 | TASK [Load network parameters] 2025-10-01 10:53:48.977359 | controller | ok 2025-10-01 10:53:48.989605 | 2025-10-01 10:53:48.989734 | TASK [Check if cloud-init is overriding NM settings] 2025-10-01 10:53:49.347517 | controller | ok 2025-10-01 10:53:49.360818 | 2025-10-01 10:53:49.360979 | TASK [Remove cloud-init DNS override if present] 2025-10-01 10:53:49.388233 | controller | skipping: Conditional result was False 2025-10-01 10:53:49.403936 | 2025-10-01 10:53:49.404123 | TASK [Reload the NetworkManager to pick the changes] 2025-10-01 10:53:49.431938 | controller | skipping: Conditional result was False 2025-10-01 10:53:49.447318 | 2025-10-01 10:53:49.447504 | TASK [Get the default iface connection] 2025-10-01 10:53:49.896004 | controller | System eth0 2025-10-01 10:53:49.998672 | controller | changed 2025-10-01 10:53:50.011410 | 2025-10-01 10:53:50.011542 | TASK [Prepend CRC DNS server in the controllers default Network Manager connection configuation] 2025-10-01 10:53:50.578624 | controller | Connection successfully activated (D-Bus active path: /org/freedesktop/NetworkManager/ActiveConnection/5) 2025-10-01 10:53:51.070473 | controller | changed 2025-10-01 10:53:51.121221 | 2025-10-01 10:53:51.121342 | PLAY [Ensure persistent SSH access] 2025-10-01 10:53:51.161394 | 2025-10-01 10:53:51.161510 | TASK [Inject key in ansible_user] 2025-10-01 10:53:51.772611 | controller | changed 2025-10-01 10:53:51.971888 | crc | changed 2025-10-01 10:53:51.982527 | 2025-10-01 10:53:51.982787 | TASK [Inject key in root] 2025-10-01 10:53:52.448290 | controller | changed 2025-10-01 10:53:52.566074 | crc | changed 2025-10-01 10:53:52.624640 | 2025-10-01 10:53:52.624746 | PLAY [Add cloud-admin user on Compute] 2025-10-01 10:53:52.625621 | 2025-10-01 10:53:52.625665 | PLAY [Set some fancy hostname] 2025-10-01 10:53:52.641676 | 2025-10-01 10:53:52.641734 | TASK [Inject hostname in configuration file] 2025-10-01 10:53:53.649436 | controller | changed 2025-10-01 10:53:53.688846 | 2025-10-01 10:53:53.688932 | PLAY RECAP 2025-10-01 10:53:53.688989 | controller | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-01 10:53:53.689052 | crc | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-01 10:53:53.689080 | 2025-10-01 10:53:53.799247 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-customizations.yml@main] 2025-10-01 10:53:53.805674 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-01 10:53:54.451404 | 2025-10-01 10:53:54.451528 | PLAY [Get all repos on all hosts] 2025-10-01 10:53:54.491948 | 2025-10-01 10:53:54.492107 | TASK [Clone repos in the job workspace] 2025-10-01 10:53:54.518455 | controller | ok 2025-10-01 10:53:54.525147 | crc | ok 2025-10-01 10:53:54.550167 | 2025-10-01 10:53:54.550331 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-01 10:53:55.234518 | controller | ok 2025-10-01 10:53:55.278464 | crc | ok 2025-10-01 10:53:55.287252 | 2025-10-01 10:53:55.287341 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-01 10:54:07.225910 | crc | Output suppressed because no_log was given 2025-10-01 10:54:14.299674 | controller | Output suppressed because no_log was given 2025-10-01 10:54:14.361519 | 2025-10-01 10:54:14.361658 | PLAY [Run ci/playbooks/e2e-prepare.yml] 2025-10-01 10:54:14.378371 | 2025-10-01 10:54:14.378430 | TASK [Read group_vars] 2025-10-01 10:54:14.397870 | controller | ok 2025-10-01 10:54:14.416749 | 2025-10-01 10:54:14.416817 | TASK [cifmw_helpers : Check directory is available] 2025-10-01 10:54:14.975022 | controller | ok 2025-10-01 10:54:14.981769 | 2025-10-01 10:54:14.981832 | TASK [cifmw_helpers : List dir in ansible user home] 2025-10-01 10:54:15.424969 | controller | var one 2025-10-01 10:54:15.425441 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars'$'\n': No such file or directory 2025-10-01 10:54:15.428553 | controller | all.yml 2025-10-01 10:54:15.430072 | controller | molecule 2025-10-01 10:54:15.430095 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied 2025-10-01 10:54:15.431457 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory 2025-10-01 10:54:15.514422 | controller | ERROR 2025-10-01 10:54:15.514721 | controller | { 2025-10-01 10:54:15.514783 | controller | "delta": "0:00:00.012384", 2025-10-01 10:54:15.514825 | controller | "end": "2025-10-01 10:54:15.431839", 2025-10-01 10:54:15.514867 | controller | "msg": "non-zero return code", 2025-10-01 10:54:15.514905 | controller | "rc": 2, 2025-10-01 10:54:15.514940 | controller | "start": "2025-10-01 10:54:15.419455" 2025-10-01 10:54:15.514975 | controller | } 2025-10-01 10:54:15.515060 | controller | ERROR: Ignoring Errors 2025-10-01 10:54:15.529304 | 2025-10-01 10:54:15.529443 | TASK [cifmw_helpers : List available files] 2025-10-01 10:54:16.082126 | controller | skipping: Conditional result was False 2025-10-01 10:54:16.096631 | 2025-10-01 10:54:16.096783 | LOOP [cifmw_helpers : Read vars] 2025-10-01 10:54:16.138692 | 2025-10-01 10:54:16.138962 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-01 10:54:16.224782 | 2025-10-01 10:54:16.224981 | TASK [Create zuul-output directory] 2025-10-01 10:54:16.716663 | controller | ok 2025-10-01 10:54:16.725445 | 2025-10-01 10:54:16.725576 | TASK [Install required packages] 2025-10-01 10:54:18.930377 | controller | ok: Nothing to do 2025-10-01 10:54:18.945298 | 2025-10-01 10:54:18.945463 | TASK [Output pip related things] 2025-10-01 10:54:19.783214 | controller | pip 21.3.1 from /usr/lib/python3.9/site-packages/pip (python 3.9) 2025-10-01 10:54:19.993482 | controller | changed 2025-10-01 10:54:20.007422 | 2025-10-01 10:54:20.007656 | TASK [Install requirements] 2025-10-01 10:55:55.731954 | controller | changed 2025-10-01 10:55:55.760257 | 2025-10-01 10:55:55.760408 | TASK [Add cronjob to trigger job stats] 2025-10-01 10:55:55.827029 | controller | skipping: Conditional result was False 2025-10-01 10:55:55.836384 | 2025-10-01 10:55:55.836467 | LOOP [Construct project change list] 2025-10-01 10:55:55.897812 | controller | ok: 2025-10-01 10:55:55.898103 | controller | { 2025-10-01 10:55:55.898141 | controller | "branch": "main", 2025-10-01 10:55:55.898167 | controller | "change": "3237", 2025-10-01 10:55:55.898195 | 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-01 10:55:55.898221 | controller | "change_url": "https://github.com/openstack-k8s-operators/ci-framework/pull/3237", 2025-10-01 10:55:55.898248 | controller | "commit_id": "9f82bbc44cf7fa37a2cf6305277fe598af8c6e39", 2025-10-01 10:55:55.898271 | controller | "patchset": "9f82bbc44cf7fa37a2cf6305277fe598af8c6e39", 2025-10-01 10:55:55.898294 | controller | "project": { 2025-10-01 10:55:55.898317 | controller | "canonical_hostname": "github.com", 2025-10-01 10:55:55.898339 | controller | "canonical_name": "github.com/openstack-k8s-operators/ci-framework", 2025-10-01 10:55:55.898361 | controller | "name": "openstack-k8s-operators/ci-framework", 2025-10-01 10:55:55.898384 | controller | "short_name": "ci-framework", 2025-10-01 10:55:55.898407 | controller | "src_dir": "src/github.com/openstack-k8s-operators/ci-framework" 2025-10-01 10:55:55.898430 | controller | }, 2025-10-01 10:55:55.898453 | controller | "topic": null 2025-10-01 10:55:55.898476 | controller | } 2025-10-01 10:55:55.898514 | 2025-10-01 10:55:55.965898 | 2025-10-01 10:55:55.966003 | PLAY [Run ci/playbooks/build_runner_image.yml] 2025-10-01 10:55:56.023288 | 2025-10-01 10:55:56.023400 | TASK [Filter out host if needed] 2025-10-01 10:55:56.034199 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-01 10:55:56.040364 | 2025-10-01 10:55:56.040424 | TASK [Filter out host if needed] 2025-10-01 10:55:56.049632 | crc | skipping: end_host conditional evaluated to False, continuing execution for crc 2025-10-01 10:55:56.054824 | 2025-10-01 10:55:56.054883 | TASK [Get git tag for image tagging] 2025-10-01 10:55:56.639574 | controller | skipping: Conditional result was False 2025-10-01 10:55:56.640517 | crc | skipping: Conditional result was False 2025-10-01 10:55:56.653638 | 2025-10-01 10:55:56.653785 | TASK [Set openstack-runner image] 2025-10-01 10:55:56.688166 | controller | skipping: Conditional result was False 2025-10-01 10:55:56.700086 | crc | skipping: Conditional result was False 2025-10-01 10:55:56.714930 | 2025-10-01 10:55:56.715149 | TASK [Build openstack-runner image] 2025-10-01 10:55:56.743463 | controller | skipping: Conditional result was False 2025-10-01 10:55:56.765050 | crc | skipping: Conditional result was False 2025-10-01 10:55:56.774237 | 2025-10-01 10:55:56.774331 | TASK [Push openstack-runner image] 2025-10-01 10:55:56.798514 | controller | skipping: Conditional result was False 2025-10-01 10:55:56.820479 | crc | skipping: Conditional result was False 2025-10-01 10:55:56.831972 | 2025-10-01 10:55:56.832142 | TASK [Make sure ci-framework directory exists] 2025-10-01 10:55:56.866423 | controller | skipping: Conditional result was False 2025-10-01 10:55:56.877512 | crc | skipping: Conditional result was False 2025-10-01 10:55:56.887509 | 2025-10-01 10:55:56.887620 | TASK [Create EDPM ansible var file] 2025-10-01 10:55:56.919587 | controller | skipping: Conditional result was False 2025-10-01 10:55:56.930587 | crc | skipping: Conditional result was False 2025-10-01 10:55:56.989190 | 2025-10-01 10:55:56.989300 | PLAY RECAP 2025-10-01 10:55:56.989344 | controller | ok: 9 changed: 4 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 1 2025-10-01 10:55:56.989371 | crc | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0 2025-10-01 10:55:56.989388 | 2025-10-01 10:55:57.107811 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-prepare.yml@main] 2025-10-01 10:55:57.111139 | PRE-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-01 10:55:57.729785 | 2025-10-01 10:55:57.729897 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-01 10:55:57.753036 | 2025-10-01 10:55:57.753141 | TASK [Create zuul-output directory] 2025-10-01 10:55:58.312226 | controller | changed 2025-10-01 10:55:58.318909 | 2025-10-01 10:55:58.318985 | TASK [Slurp Zuul inventory test] 2025-10-01 10:55:58.741610 | controller -> localhost | ok 2025-10-01 10:55:58.759742 | 2025-10-01 10:55:58.760007 | TASK [Save zuul inventory] 2025-10-01 10:55:59.878000 | controller | changed 2025-10-01 10:55:59.892355 | 2025-10-01 10:55:59.892510 | TASK [Save zuul vars without the change_message] 2025-10-01 10:56:01.014768 | controller | changed 2025-10-01 10:56:01.059320 | 2025-10-01 10:56:01.059433 | PLAY RECAP 2025-10-01 10:56:01.059493 | controller | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-01 10:56:01.059524 | 2025-10-01 10:56:01.160320 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-01 10:56:01.168179 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-01 10:56:01.777294 | 2025-10-01 10:56:01.777405 | PLAY [Run ci/playbooks/dump_zuul_data.yml] 2025-10-01 10:56:01.800661 | 2025-10-01 10:56:01.800779 | TASK [Create zuul-output directory] 2025-10-01 10:56:02.350784 | controller | ok 2025-10-01 10:56:02.366009 | 2025-10-01 10:56:02.366218 | TASK [Slurp Zuul inventory test] 2025-10-01 10:56:02.802886 | controller -> localhost | ok 2025-10-01 10:56:02.813218 | 2025-10-01 10:56:02.813312 | TASK [Save zuul inventory] 2025-10-01 10:56:03.691101 | controller | ok 2025-10-01 10:56:03.705705 | 2025-10-01 10:56:03.705881 | TASK [Save zuul vars without the change_message] 2025-10-01 10:56:04.520155 | controller | ok 2025-10-01 10:56:04.563646 | 2025-10-01 10:56:04.563775 | PLAY RECAP 2025-10-01 10:56:04.563835 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-01 10:56:04.563865 | 2025-10-01 10:56:04.677765 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/dump_zuul_data.yml@main] 2025-10-01 10:56:04.684526 | RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/kuttl/run.yml@main] 2025-10-01 10:56:05.316978 | 2025-10-01 10:56:05.317123 | PLAY [Run ci/playbooks/kuttl/run.yml] 2025-10-01 10:56:05.338822 | 2025-10-01 10:56:05.338937 | TASK [Read group_vars] 2025-10-01 10:56:05.359292 | controller | ok 2025-10-01 10:56:05.377346 | 2025-10-01 10:56:05.377452 | TASK [cifmw_helpers : Check directory is available] 2025-10-01 10:56:05.943478 | controller | ok 2025-10-01 10:56:05.959005 | 2025-10-01 10:56:05.959239 | TASK [cifmw_helpers : List dir in ansible user home] 2025-10-01 10:56:06.411226 | controller | var one 2025-10-01 10:56:06.412898 | controller | ls: cannot access '/home/zuul/src/github.com/openstack-k8s-operators/ci-framework/group_vars'$'\n': No such file or directory 2025-10-01 10:56:06.414696 | controller | all.yml 2025-10-01 10:56:06.416399 | controller | molecule 2025-10-01 10:56:06.416429 | controller | ls: cannot access '/root/src/github.com/openstack-k8s-operators/ci-framework/group_vars': Permission denied 2025-10-01 10:56:06.418193 | controller | ls: cannot access '/workspace/src/github.com/openstack-k8s-operators/ci-framework/group_vars': No such file or directory 2025-10-01 10:56:06.510357 | controller | ERROR 2025-10-01 10:56:06.510489 | controller | { 2025-10-01 10:56:06.510517 | controller | "delta": "0:00:00.011855", 2025-10-01 10:56:06.510538 | controller | "end": "2025-10-01 10:56:06.418680", 2025-10-01 10:56:06.510557 | controller | "msg": "non-zero return code", 2025-10-01 10:56:06.510574 | controller | "rc": 2, 2025-10-01 10:56:06.510595 | controller | "start": "2025-10-01 10:56:06.406825" 2025-10-01 10:56:06.510613 | controller | } 2025-10-01 10:56:06.510639 | controller | ERROR: Ignoring Errors 2025-10-01 10:56:06.517931 | 2025-10-01 10:56:06.518047 | TASK [cifmw_helpers : List available files] 2025-10-01 10:56:07.049581 | controller | skipping: Conditional result was False 2025-10-01 10:56:07.056354 | 2025-10-01 10:56:07.056448 | LOOP [cifmw_helpers : Read vars] 2025-10-01 10:56:07.088089 | 2025-10-01 10:56:07.088252 | LOOP [cifmw_helpers : Call task to parse all files as fact] 2025-10-01 10:56:07.125633 | 2025-10-01 10:56:07.125809 | TASK [Run kuttl tests playbook] 2025-10-01 10:56:17.695214 | controller | ERROR 2025-10-01 10:56:17.695511 | controller | { 2025-10-01 10:56:17.695555 | 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/eaf3bf33b5094c7293edbd23ebce0adc/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-01 10:56:17.695587 | controller | } failure 2025-10-01 10:56:17.697293 | 2025-10-01 10:56:17.697382 | PLAY RECAP 2025-10-01 10:56:17.697442 | controller | ok: 2 changed: 1 unreachable: 0 failed: 1 skipped: 3 rescued: 0 ignored: 1 2025-10-01 10:56:17.697471 | 2025-10-01 10:56:17.803855 | RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/kuttl/run.yml@main] 2025-10-01 10:56:17.812263 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-collect-logs.yml@main] 2025-10-01 10:56:18.441807 | ANSIBLE PARSE ERROR 2025-10-01 10:56:18.441829 | Using /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/ansible/post_playbook_0/ansible.cfg as config file 2025-10-01 10:56:18.441840 | ERROR! We were unable to read either as JSON nor YAML, these are the errors we got from each: 2025-10-01 10:56:18.441847 | JSON: Expecting value: line 1 column 1 (char 0) 2025-10-01 10:56:18.441855 | 2025-10-01 10:56:18.441861 | Syntax Error while loading YAML. 2025-10-01 10:56:18.441868 | did not find expected '-' indicator 2025-10-01 10:56:18.441875 | 2025-10-01 10:56:18.441881 | The error appears to be in '/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/untrusted/project_0/github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-collect-logs.yml': line 50, column 6, but may 2025-10-01 10:56:18.441889 | be elsewhere in the file depending on the exact syntax problem. 2025-10-01 10:56:18.441895 | 2025-10-01 10:56:18.441902 | The offending line appears to be: 2025-10-01 10:56:18.441909 | 2025-10-01 10:56:18.441915 | - logs 2025-10-01 10:56:18.441921 | environment: 2025-10-01 10:56:18.441928 | ^ here 2025-10-01 10:56:18.442313 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/e2e-collect-logs.yml@main] 2025-10-01 10:56:18.449450 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-01 10:56:19.045290 | 2025-10-01 10:56:19.045408 | PLAY [Run ci/playbooks/collect-logs.yml] 2025-10-01 10:56:19.084730 | 2025-10-01 10:56:19.084904 | TASK [Filter out host if needed] 2025-10-01 10:56:19.096513 | controller | skipping: end_host conditional evaluated to False, continuing execution for controller 2025-10-01 10:56:19.102533 | 2025-10-01 10:56:19.102595 | TASK [Filter out host if needed] 2025-10-01 10:56:19.117062 | 2025-10-01 10:56:19.117140 | TASK [Ensure file is present] 2025-10-01 10:56:19.654683 | controller | ok 2025-10-01 10:56:19.673999 | 2025-10-01 10:56:19.674170 | TASK [Manage molecule report file] 2025-10-01 10:56:20.245650 | controller | skipping: Conditional result was False 2025-10-01 10:56:20.257083 | 2025-10-01 10:56:20.257195 | TASK [Check if we get ci-framework-data basedir] 2025-10-01 10:56:20.573496 | controller | ok 2025-10-01 10:56:20.591239 | 2025-10-01 10:56:20.591450 | TASK [Create ci-framework-data log directory for zuul] 2025-10-01 10:56:20.956332 | controller | changed 2025-10-01 10:56:20.962742 | 2025-10-01 10:56:20.962865 | TASK [Copy ci-framework interesting files] 2025-10-01 10:56:21.364614 | controller | cp: cannot stat '/home/zuul/ci-framework-data/logs': No such file or directory 2025-10-01 10:56:21.368843 | controller | cp: cannot stat '/home/zuul/ci-framework-data/tests': No such file or directory 2025-10-01 10:56:21.562214 | controller | changed 2025-10-01 10:56:21.568526 | 2025-10-01 10:56:21.568599 | TASK [Get SELinux listing] 2025-10-01 10:56:22.160903 | controller | changed 2025-10-01 10:56:22.170813 | 2025-10-01 10:56:22.170907 | TASK [Generate log index] 2025-10-01 10:56:22.954469 | controller | changed 2025-10-01 10:56:22.966630 | 2025-10-01 10:56:22.966766 | TASK [Get some env related data] 2025-10-01 10:56:23.643728 | controller | /home/zuul/.local/bin/ansible 2025-10-01 10:56:24.568471 | controller | changed 2025-10-01 10:56:24.583859 | 2025-10-01 10:56:24.584078 | TASK [Generate list of logs to collect in home directory] 2025-10-01 10:56:25.047482 | controller | ok: All paths examined 2025-10-01 10:56:25.053454 | 2025-10-01 10:56:25.053527 | LOOP [Copy logs from home directory] 2025-10-01 10:56:25.473141 | controller | changed: 2025-10-01 10:56:25.473343 | controller | { 2025-10-01 10:56:25.473380 | controller | "atime": 1759316136.5262558, 2025-10-01 10:56:25.473408 | controller | "ctime": 1759316155.1887434, 2025-10-01 10:56:25.473435 | controller | "dev": 64513, 2025-10-01 10:56:25.473458 | controller | "gid": 1000, 2025-10-01 10:56:25.473481 | controller | "gr_name": "zuul", 2025-10-01 10:56:25.473503 | controller | "inode": 4455244, 2025-10-01 10:56:25.473538 | controller | "isblk": false, 2025-10-01 10:56:25.473573 | controller | "ischr": false, 2025-10-01 10:56:25.473597 | controller | "isdir": false, 2025-10-01 10:56:25.473620 | controller | "isfifo": false, 2025-10-01 10:56:25.473642 | controller | "isgid": false, 2025-10-01 10:56:25.473664 | controller | "islnk": false, 2025-10-01 10:56:25.473686 | controller | "isreg": true, 2025-10-01 10:56:25.473708 | controller | "issock": false, 2025-10-01 10:56:25.473731 | controller | "isuid": false, 2025-10-01 10:56:25.473754 | controller | "mode": "0644", 2025-10-01 10:56:25.473778 | controller | "mtime": 1759316155.1887434, 2025-10-01 10:56:25.473801 | controller | "nlink": 1, 2025-10-01 10:56:25.473823 | controller | "path": "/home/zuul/ansible.log", 2025-10-01 10:56:25.473846 | controller | "pw_name": "zuul", 2025-10-01 10:56:25.473868 | controller | "rgrp": true, 2025-10-01 10:56:25.473890 | controller | "roth": true, 2025-10-01 10:56:25.473912 | controller | "rusr": true, 2025-10-01 10:56:25.473934 | controller | "size": 6749, 2025-10-01 10:56:25.473960 | controller | "uid": 1000, 2025-10-01 10:56:25.473984 | controller | "wgrp": false, 2025-10-01 10:56:25.474006 | controller | "woth": false, 2025-10-01 10:56:25.474072 | controller | "wusr": true, 2025-10-01 10:56:25.474119 | controller | "xgrp": false, 2025-10-01 10:56:25.474143 | controller | "xoth": false, 2025-10-01 10:56:25.474166 | controller | "xusr": false 2025-10-01 10:56:25.474188 | controller | } 2025-10-01 10:56:25.484423 | 2025-10-01 10:56:25.484543 | TASK [Copy crio stats log file] 2025-10-01 10:56:25.518765 | controller | skipping: Conditional result was False 2025-10-01 10:56:25.526814 | 2025-10-01 10:56:25.526913 | TASK [Get SELinux related data] 2025-10-01 10:56:25.852322 | controller | 2025-10-01 10:56:26.127552 | controller | ERROR 2025-10-01 10:56:26.127775 | controller | { 2025-10-01 10:56:26.127837 | controller | "delta": "0:00:00.012218", 2025-10-01 10:56:26.127881 | controller | "end": "2025-10-01 10:56:25.853683", 2025-10-01 10:56:26.127921 | controller | "msg": "non-zero return code", 2025-10-01 10:56:26.127959 | controller | "rc": 1, 2025-10-01 10:56:26.127998 | controller | "start": "2025-10-01 10:56:25.841465" 2025-10-01 10:56:26.128096 | controller | } 2025-10-01 10:56:26.128151 | controller | ERROR: Ignoring Errors 2025-10-01 10:56:26.139333 | 2025-10-01 10:56:26.139454 | TASK [Create system configuration directory] 2025-10-01 10:56:26.382394 | controller | changed 2025-10-01 10:56:26.398497 | 2025-10-01 10:56:26.399168 | TASK [Get some of the system configurations] 2025-10-01 10:56:27.020059 | controller | changed 2025-10-01 10:56:27.035844 | 2025-10-01 10:56:27.036001 | TASK [Copy generated documentation if available] 2025-10-01 10:56:27.064191 | controller | skipping: Conditional result was False 2025-10-01 10:56:27.076540 | 2025-10-01 10:56:27.076664 | TASK [Copy generated AsciiDoc documentation if available] 2025-10-01 10:56:27.108592 | controller | skipping: Conditional result was False 2025-10-01 10:56:27.114961 | 2025-10-01 10:56:27.115071 | TASK [Compress logs bigger than 2MB] 2025-10-01 10:56:27.686079 | controller | changed 2025-10-01 10:56:27.699578 | 2025-10-01 10:56:27.699711 | TASK [Copy files from workspace on node] 2025-10-01 10:56:27.752075 | controller | ok 2025-10-01 10:56:27.798517 | 2025-10-01 10:56:27.798666 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-01 10:56:27.862730 | controller | ok 2025-10-01 10:56:27.871455 | 2025-10-01 10:56:27.871547 | TASK [fetch-output : Set log path for single node] 2025-10-01 10:56:27.907351 | controller | skipping: Conditional result was False 2025-10-01 10:56:27.916503 | 2025-10-01 10:56:27.916599 | LOOP [fetch-output : Ensure local output dirs] 2025-10-01 10:56:28.157658 | controller -> localhost | changed: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/logs/controller" 2025-10-01 10:56:28.157886 | controller -> localhost | changed: All items complete 2025-10-01 10:56:28.157919 | 2025-10-01 10:56:28.357449 | controller -> localhost | changed: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/artifacts" 2025-10-01 10:56:28.570741 | controller -> localhost | changed: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/docs" 2025-10-01 10:56:28.592718 | 2025-10-01 10:56:28.592943 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-01 10:56:29.275814 | controller | changed: 2025-10-01 10:56:29.276423 | controller | .d..t...... ./ 2025-10-01 10:56:29.276581 | controller | >f+++++++++ README.html 2025-10-01 10:56:29.276666 | controller | >f+++++++++ ansible.log 2025-10-01 10:56:29.277134 | controller | >f+++++++++ dmesg.log 2025-10-01 10:56:29.277225 | controller | >f+++++++++ installed-pkgs.log 2025-10-01 10:56:29.277275 | controller | >f+++++++++ python.log 2025-10-01 10:56:29.277325 | controller | >f+++++++++ registries.conf 2025-10-01 10:56:29.277370 | controller | >f+++++++++ selinux-denials.log 2025-10-01 10:56:29.277413 | controller | >f+++++++++ selinux-listing.log 2025-10-01 10:56:29.277458 | controller | cd+++++++++ ci-framework-data/ 2025-10-01 10:56:29.277500 | controller | cd+++++++++ ci-framework-data/artifacts/ 2025-10-01 10:56:29.277543 | controller | >f+++++++++ ci-framework-data/artifacts/zuul_inventory.yml 2025-10-01 10:56:29.277590 | controller | cd+++++++++ ci-framework-data/artifacts/parameters/ 2025-10-01 10:56:29.277654 | controller | >f+++++++++ ci-framework-data/artifacts/parameters/zuul-params.yml 2025-10-01 10:56:29.277710 | controller | cd+++++++++ registries.conf.d/ 2025-10-01 10:56:29.277774 | controller | >f+++++++++ registries.conf.d/000-shortnames.conf 2025-10-01 10:56:29.277837 | controller | cd+++++++++ system-config/ 2025-10-01 10:56:29.277904 | controller | cd+++++++++ system-config/libvirt/ 2025-10-01 10:56:29.277972 | controller | >f+++++++++ system-config/libvirt/libvirt-admin.conf 2025-10-01 10:56:29.278269 | controller | >f+++++++++ system-config/libvirt/libvirt.conf 2025-10-01 10:56:29.739874 | controller | changed: .d..t...... ./ 2025-10-01 10:56:30.190962 | controller | changed: .d..t...... ./ 2025-10-01 10:56:30.219416 | 2025-10-01 10:56:30.219523 | TASK [Return artifact to Zuul] 2025-10-01 10:56:30.234683 | controller | skipping: Conditional result was False 2025-10-01 10:56:30.263050 | 2025-10-01 10:56:30.263142 | PLAY [Run ci/playbooks/collect-logs.yml on CRC host] 2025-10-01 10:56:30.285795 | 2025-10-01 10:56:30.285878 | TASK [Get kubelet journalctl logs] 2025-10-01 10:56:31.363173 | crc | Output suppressed because no_log was given 2025-10-01 10:56:31.398183 | 2025-10-01 10:56:31.398277 | PLAY RECAP 2025-10-01 10:56:31.398321 | controller | ok: 16 changed: 12 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 1 2025-10-01 10:56:31.398348 | crc | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-01 10:56:31.398366 | 2025-10-01 10:56:31.520066 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/collect-logs.yml@main] 2025-10-01 10:56:31.524096 | POST-RUN START: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-autohold.yml@main] 2025-10-01 10:56:32.095171 | 2025-10-01 10:56:32.095301 | PLAY [Run ci/playbooks/multinode-autohold.yml] 2025-10-01 10:56:32.118976 | 2025-10-01 10:56:32.119126 | TASK [Verify if "success" flag exists after successful tests execution] 2025-10-01 10:56:32.670418 | controller | ok 2025-10-01 10:56:32.683788 | 2025-10-01 10:56:32.683941 | TASK [Fetch existing autoholds from zuul] 2025-10-01 10:56:32.751883 | controller | ok 2025-10-01 10:56:32.779491 | 2025-10-01 10:56:32.779643 | TASK [krb_request : Perform the request] 2025-10-01 10:56:33.442279 | controller | ok 2025-10-01 10:56:33.471783 | 2025-10-01 10:56:33.471884 | TASK [Check if any autohold matches] 2025-10-01 10:56:33.559278 | controller | skipping: Conditional result was False 2025-10-01 10:56:33.592234 | 2025-10-01 10:56:33.592343 | PLAY RECAP 2025-10-01 10:56:33.592387 | controller | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2025-10-01 10:56:33.592415 | 2025-10-01 10:56:33.724010 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/openstack-k8s-operators/ci-framework/ci/playbooks/multinode-autohold.yml@main] 2025-10-01 10:56:33.731729 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/print-machineconfigpool.yaml@master] 2025-10-01 10:56:34.397511 | 2025-10-01 10:56:34.397638 | PLAY [crc] 2025-10-01 10:56:34.427250 | 2025-10-01 10:56:34.427383 | TASK [Print machineconfigpool] 2025-10-01 10:56:35.224828 | crc | NAME CONFIG UPDATED UPDATING DEGRADED MACHINECOUNT READYMACHINECOUNT UPDATEDMACHINECOUNT DEGRADEDMACHINECOUNT AGE 2025-10-01 10:56:35.224930 | crc | master rendered-master-f83a149c7490c3b0bf850df839837383 False False True 1 0 0 1 220d 2025-10-01 10:56:35.224942 | crc | worker rendered-worker-594cc07c9feefb5e37f2530ac457d36c True False False 0 0 0 0 220d 2025-10-01 10:56:35.467938 | crc | changed 2025-10-01 10:56:35.526506 | 2025-10-01 10:56:35.526643 | PLAY RECAP 2025-10-01 10:56:35.526709 | crc | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-01 10:56:35.526740 | 2025-10-01 10:56:35.640997 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/print-machineconfigpool.yaml@master] 2025-10-01 10:56:35.644453 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/compress-crc-cloud-logs.yaml@master] 2025-10-01 10:56:36.271920 | 2025-10-01 10:56:36.272051 | PLAY [crc] 2025-10-01 10:56:36.301323 | 2025-10-01 10:56:36.301483 | TASK [Create compressed log tar gz file - crc-cloud logs] 2025-10-01 10:56:37.085219 | crc | tar: Removing leading `/' from member names 2025-10-01 10:56:37.089540 | crc | tar: /var/home/core/workdir/*log: Cannot stat: No such file or directory 2025-10-01 10:56:37.089609 | crc | tar: Exiting with failure status due to previous errors 2025-10-01 10:56:37.347298 | crc | ok 2025-10-01 10:56:37.368208 | 2025-10-01 10:56:37.368357 | TASK [Copy crc-cloud logs] 2025-10-01 10:56:37.704093 | crc | cp: cannot stat '/var/home/core/workdir/*log': No such file or directory 2025-10-01 10:56:37.918895 | crc | ok 2025-10-01 10:56:37.955959 | 2025-10-01 10:56:37.956097 | PLAY RECAP 2025-10-01 10:56:37.956158 | crc | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-01 10:56:37.956191 | 2025-10-01 10:56:38.082371 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/compress-crc-cloud-logs.yaml@master] 2025-10-01 10:56:38.086554 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/compress-logs.yaml@master] 2025-10-01 10:56:38.685560 | 2025-10-01 10:56:38.685695 | PLAY [all] 2025-10-01 10:56:38.723818 | 2025-10-01 10:56:38.723948 | TASK [Create compressed log tar gz file - ci-framework-data] 2025-10-01 10:56:39.358841 | controller | tar: Removing leading `/' from member names 2025-10-01 10:56:39.369283 | 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-01 10:56:39.370854 | 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-01 10:56:39.489114 | crc | tar: Removing leading `/' from member names 2025-10-01 10:56:39.489178 | crc | tar: /var/home/core/ci-framework-data: Cannot stat: No such file or directory 2025-10-01 10:56:39.492494 | crc | tar: Exiting with failure status due to previous errors 2025-10-01 10:56:39.494715 | 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-01 10:56:39.497263 | 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-01 10:56:39.798439 | controller | ERROR 2025-10-01 10:56:39.798681 | controller | { 2025-10-01 10:56:39.798749 | controller | "delta": "0:00:00.023604", 2025-10-01 10:56:39.798799 | controller | "end": "2025-10-01 10:56:39.371235", 2025-10-01 10:56:39.798843 | controller | "msg": "non-zero return code", 2025-10-01 10:56:39.798885 | controller | "rc": 1, 2025-10-01 10:56:39.798926 | controller | "start": "2025-10-01 10:56:39.347631" 2025-10-01 10:56:39.798969 | controller | } 2025-10-01 10:56:39.799066 | controller | ERROR: Ignoring Errors 2025-10-01 10:56:39.816427 | crc | ERROR 2025-10-01 10:56:39.816671 | crc | { 2025-10-01 10:56:39.816743 | crc | "delta": "0:00:00.019449", 2025-10-01 10:56:39.816792 | crc | "end": "2025-10-01 10:56:39.497891", 2025-10-01 10:56:39.816834 | crc | "msg": "non-zero return code", 2025-10-01 10:56:39.816873 | crc | "rc": 1, 2025-10-01 10:56:39.816913 | crc | "start": "2025-10-01 10:56:39.478442" 2025-10-01 10:56:39.816954 | crc | } 2025-10-01 10:56:39.817005 | crc | ERROR: Ignoring Errors 2025-10-01 10:56:39.832579 | 2025-10-01 10:56:39.832788 | TASK [Create compressed log tar gz file - zuul-output] 2025-10-01 10:56:40.174157 | controller | tar: Removing leading `/' from member names 2025-10-01 10:56:40.278696 | crc | tar: Removing leading `/' from member names 2025-10-01 10:56:40.427362 | controller | ok 2025-10-01 10:56:40.435133 | crc | ok 2025-10-01 10:56:40.497868 | 2025-10-01 10:56:40.498065 | PLAY RECAP 2025-10-01 10:56:40.498119 | controller | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2025-10-01 10:56:40.498145 | crc | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2025-10-01 10:56:40.498163 | 2025-10-01 10:56:40.680933 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/compress-logs.yaml@master] 2025-10-01 10:56:40.688587 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup.yml@master] 2025-10-01 10:56:41.284462 | 2025-10-01 10:56:41.284573 | PLAY [Run playbooks/crc/bootstraped-ci-network-cleanup.yml] 2025-10-01 10:56:41.306542 | 2025-10-01 10:56:41.306654 | TASK [Create openstack config dir] 2025-10-01 10:56:41.888321 | controller | ok 2025-10-01 10:56:41.902412 | 2025-10-01 10:56:41.902579 | TASK [Check for cleanup skip flag file presence] 2025-10-01 10:56:42.304788 | controller | ok 2025-10-01 10:56:42.322938 | 2025-10-01 10:56:42.323232 | TASK [Generate clouds config from cloud_secrets secret] 2025-10-01 10:56:43.166144 | controller | changed 2025-10-01 10:56:43.173936 | 2025-10-01 10:56:43.174059 | LOOP [Delete ports from each host] 2025-10-01 10:56:43.257319 | controller | ok: "crc" 2025-10-01 10:56:46.263668 | controller | ok: "controller" 2025-10-01 10:56:46.289324 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup-instance-ports.yml 2025-10-01 10:56:46.293091 | controller | included: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/trusted/project_0/review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup-instance-ports.yml 2025-10-01 10:56:46.300943 | 2025-10-01 10:56:46.301032 | TASK [Fetch port info] 2025-10-01 10:56:48.359363 | controller | admin_state_up: true 2025-10-01 10:56:48.359522 | controller | allowed_address_pairs: [] 2025-10-01 10:56:48.359697 | controller | binding_host_id: null 2025-10-01 10:56:48.359806 | controller | binding_profile: {} 2025-10-01 10:56:48.359932 | controller | binding_vif_details: {} 2025-10-01 10:56:48.360048 | controller | binding_vif_type: null 2025-10-01 10:56:48.360197 | controller | binding_vnic_type: normal 2025-10-01 10:56:48.360333 | controller | created_at: '2025-10-01T10:45:28Z' 2025-10-01 10:56:48.360455 | controller | data_plane_status: null 2025-10-01 10:56:48.360556 | controller | description: '' 2025-10-01 10:56:48.360680 | controller | device_id: 11eb6671-4cb8-4e95-a5bc-2d3f1389495c 2025-10-01 10:56:48.360810 | controller | device_owner: compute:nova 2025-10-01 10:56:48.360944 | controller | device_profile: null 2025-10-01 10:56:48.361269 | controller | dns_assignment: 2025-10-01 10:56:48.361366 | controller | - fqdn: host-192-168-122-10.openstacklocal. 2025-10-01 10:56:48.361374 | controller | hostname: host-192-168-122-10 2025-10-01 10:56:48.361380 | controller | ip_address: 192.168.122.10 2025-10-01 10:56:48.361389 | controller | dns_domain: '' 2025-10-01 10:56:48.361462 | controller | dns_name: '' 2025-10-01 10:56:48.361558 | controller | extra_dhcp_opts: [] 2025-10-01 10:56:48.361789 | controller | fixed_ips: 2025-10-01 10:56:48.361906 | controller | - ip_address: 192.168.122.10 2025-10-01 10:56:48.361918 | controller | subnet_id: 2dadc595-7d2f-4545-88a6-efa798fda4f9 2025-10-01 10:56:48.361926 | controller | hardware_offload_type: null 2025-10-01 10:56:48.361997 | controller | hints: '' 2025-10-01 10:56:48.362106 | controller | id: b9af134e-9558-4588-bde4-a47fa354a644 2025-10-01 10:56:48.362204 | controller | ip_allocation: immediate 2025-10-01 10:56:48.362306 | controller | mac_address: fa:16:3e:bf:73:6c 2025-10-01 10:56:48.362420 | controller | name: crc-11eb6671-4cb8-4e95-a5bc-2d3f1389495c 2025-10-01 10:56:48.362539 | controller | network_id: 61a51c87-5f05-4878-bd5a-345961382f59 2025-10-01 10:56:48.362639 | controller | numa_affinity_policy: null 2025-10-01 10:56:48.362768 | controller | port_security_enabled: false 2025-10-01 10:56:48.362898 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-01 10:56:48.363007 | controller | propagate_uplink_status: null 2025-10-01 10:56:48.363105 | controller | resource_request: null 2025-10-01 10:56:48.363225 | controller | revision_number: 4 2025-10-01 10:56:48.363346 | controller | qos_network_policy_id: null 2025-10-01 10:56:48.363445 | controller | qos_policy_id: null 2025-10-01 10:56:48.363543 | controller | security_group_ids: [] 2025-10-01 10:56:48.363634 | controller | status: ACTIVE 2025-10-01 10:56:48.363734 | controller | tags: [] 2025-10-01 10:56:48.363833 | controller | trunk_details: null 2025-10-01 10:56:48.363951 | controller | trusted: null 2025-10-01 10:56:48.364064 | controller | updated_at: '2025-10-01T10:45:43Z' 2025-10-01 10:56:48.843109 | controller | changed 2025-10-01 10:56:48.858249 | 2025-10-01 10:56:48.858758 | TASK [Set port info yaml for further usage] 2025-10-01 10:56:48.928481 | controller | ok 2025-10-01 10:56:48.942070 | 2025-10-01 10:56:48.942179 | TASK [Detach port] 2025-10-01 10:56:51.507403 | controller | changed 2025-10-01 10:56:51.526904 | 2025-10-01 10:56:51.527174 | LOOP [Delete port association with trunk network] 2025-10-01 10:56:51.589609 | 2025-10-01 10:56:51.589910 | LOOP [Delete trunk sub ports (tagged ones)] 2025-10-01 10:56:51.654483 | 2025-10-01 10:56:51.654770 | TASK [Delete the trunk network itself] 2025-10-01 10:56:52.209498 | controller | skipping: Conditional result was False 2025-10-01 10:56:52.225254 | 2025-10-01 10:56:52.225404 | TASK [Remove the parent/trunk port itself] 2025-10-01 10:57:04.801587 | controller | changed 2025-10-01 10:57:04.817757 | 2025-10-01 10:57:04.817951 | TASK [Fetch port info] 2025-10-01 10:57:16.529644 | controller | admin_state_up: true 2025-10-01 10:57:16.530103 | controller | allowed_address_pairs: [] 2025-10-01 10:57:16.530526 | controller | binding_host_id: null 2025-10-01 10:57:16.530793 | controller | binding_profile: {} 2025-10-01 10:57:16.531166 | controller | binding_vif_details: {} 2025-10-01 10:57:16.531538 | controller | binding_vif_type: null 2025-10-01 10:57:16.532055 | controller | binding_vnic_type: normal 2025-10-01 10:57:16.532498 | controller | created_at: '2025-10-01T10:45:08Z' 2025-10-01 10:57:16.532857 | controller | data_plane_status: null 2025-10-01 10:57:16.533237 | controller | description: '' 2025-10-01 10:57:16.533529 | controller | device_id: 24dc23bb-0233-40ff-9563-1477c30f8289 2025-10-01 10:57:16.533774 | controller | device_owner: compute:nova 2025-10-01 10:57:16.534106 | controller | device_profile: null 2025-10-01 10:57:16.535011 | controller | dns_assignment: 2025-10-01 10:57:16.535340 | controller | - fqdn: host-192-168-122-11.openstacklocal. 2025-10-01 10:57:16.535386 | controller | hostname: host-192-168-122-11 2025-10-01 10:57:16.535409 | controller | ip_address: 192.168.122.11 2025-10-01 10:57:16.535437 | controller | dns_domain: '' 2025-10-01 10:57:16.535712 | controller | dns_name: '' 2025-10-01 10:57:16.535932 | controller | extra_dhcp_opts: [] 2025-10-01 10:57:16.536591 | controller | fixed_ips: 2025-10-01 10:57:16.536813 | controller | - ip_address: 192.168.122.11 2025-10-01 10:57:16.536839 | controller | subnet_id: 2dadc595-7d2f-4545-88a6-efa798fda4f9 2025-10-01 10:57:16.536864 | controller | hardware_offload_type: null 2025-10-01 10:57:16.537058 | controller | hints: '' 2025-10-01 10:57:16.537308 | controller | id: f9909ed2-d900-4b8a-b5a3-7672a64256c9 2025-10-01 10:57:16.537524 | controller | ip_allocation: immediate 2025-10-01 10:57:16.537760 | controller | mac_address: fa:16:3e:da:44:fe 2025-10-01 10:57:16.538066 | controller | name: controller-24dc23bb-0233-40ff-9563-1477c30f8289 2025-10-01 10:57:16.538350 | controller | network_id: 61a51c87-5f05-4878-bd5a-345961382f59 2025-10-01 10:57:16.538583 | controller | numa_affinity_policy: null 2025-10-01 10:57:16.538929 | controller | port_security_enabled: false 2025-10-01 10:57:16.539215 | controller | project_id: 4b633c451ac74233be3721a3635275e5 2025-10-01 10:57:16.539440 | controller | propagate_uplink_status: null 2025-10-01 10:57:16.539664 | controller | resource_request: null 2025-10-01 10:57:16.540026 | controller | revision_number: 4 2025-10-01 10:57:16.540346 | controller | qos_network_policy_id: null 2025-10-01 10:57:16.540606 | controller | qos_policy_id: null 2025-10-01 10:57:16.540838 | controller | security_group_ids: [] 2025-10-01 10:57:16.541118 | controller | status: ACTIVE 2025-10-01 10:57:16.541321 | controller | tags: [] 2025-10-01 10:57:16.541543 | controller | trunk_details: null 2025-10-01 10:57:16.541758 | controller | trusted: null 2025-10-01 10:57:16.542062 | controller | updated_at: '2025-10-01T10:45:27Z' 2025-10-01 10:57:16.911242 | controller | changed 2025-10-01 10:57:16.925926 | 2025-10-01 10:57:16.926125 | TASK [Set port info yaml for further usage] 2025-10-01 10:57:17.021418 | controller | ok 2025-10-01 10:57:17.040201 | 2025-10-01 10:57:17.040451 | TASK [Detach port] 2025-10-01 10:57:34.615793 | controller | changed 2025-10-01 10:57:34.629844 | 2025-10-01 10:57:34.629990 | LOOP [Delete port association with trunk network] 2025-10-01 10:57:34.714670 | 2025-10-01 10:57:34.714970 | LOOP [Delete trunk sub ports (tagged ones)] 2025-10-01 10:57:34.794766 | 2025-10-01 10:57:34.795094 | TASK [Delete the trunk network itself] 2025-10-01 10:57:35.382775 | controller | skipping: Conditional result was False 2025-10-01 10:57:35.398443 | 2025-10-01 10:57:35.398609 | TASK [Remove the parent/trunk port itself] 2025-10-01 10:57:48.473415 | controller | changed 2025-10-01 10:57:48.482095 | 2025-10-01 10:57:48.482189 | TASK [Dettach router from subnet] 2025-10-01 10:57:49.025645 | controller | skipping: Conditional result was False 2025-10-01 10:57:49.040635 | 2025-10-01 10:57:49.040785 | TASK [Delete router] 2025-10-01 10:57:49.592855 | controller | skipping: Conditional result was False 2025-10-01 10:57:49.602912 | 2025-10-01 10:57:49.603080 | TASK [Delete subnet] 2025-10-01 10:58:01.685718 | controller | changed 2025-10-01 10:58:01.699671 | 2025-10-01 10:58:01.699824 | TASK [Delete network] 2025-10-01 10:58:15.273395 | controller | changed 2025-10-01 10:58:15.280221 | 2025-10-01 10:58:15.280333 | TASK [Remove clouds.yml secret] 2025-10-01 10:58:15.605531 | controller | changed 2025-10-01 10:58:15.658051 | 2025-10-01 10:58:15.658267 | PLAY RECAP 2025-10-01 10:58:15.658337 | controller | ok: 16 changed: 10 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-01 10:58:15.658381 | 2025-10-01 10:58:15.778396 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/crc/bootstraped-ci-network-cleanup.yml@master] 2025-10-01 10:58:15.786930 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-01 10:58:16.450614 | 2025-10-01 10:58:16.450735 | PLAY [Report DLRN results after job run] 2025-10-01 10:58:16.475862 | 2025-10-01 10:58:16.476000 | TASK [Report job status to DLRN] 2025-10-01 10:58:16.497204 | controller | ok 2025-10-01 10:58:16.523857 | 2025-10-01 10:58:16.523973 | TASK [dlrn_report : Warning if DLRN is not running] 2025-10-01 10:58:16.601577 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.619398 | 2025-10-01 10:58:16.619538 | TASK [dlrn_report : Install dlrnapi-client shyaml package] 2025-10-01 10:58:16.670171 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.680218 | 2025-10-01 10:58:16.680323 | TASK [dlrn_report : Install kinit related package] 2025-10-01 10:58:16.737502 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.748157 | 2025-10-01 10:58:16.748336 | TASK [dlrn_report : Install dlrn kerberos related packages] 2025-10-01 10:58:16.794842 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.804842 | 2025-10-01 10:58:16.804948 | TASK [Set zuul-log-path fact] 2025-10-01 10:58:16.857816 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.866410 | 2025-10-01 10:58:16.866491 | TASK [dlrn_report : Set the the value of cifmw_repo_setup_promotion when multiple dlrn tags are used] 2025-10-01 10:58:16.920661 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.927698 | 2025-10-01 10:58:16.927790 | TASK [Get hash related data from repo_setup role] 2025-10-01 10:58:16.972040 | controller | skipping: Conditional result was False 2025-10-01 10:58:16.979435 | 2025-10-01 10:58:16.979531 | TASK [dlrn_report : Perform kinit for DLRN kerberos authentication] 2025-10-01 10:58:17.526577 | controller | skipping: Conditional result was False 2025-10-01 10:58:17.543825 | 2025-10-01 10:58:17.543997 | TASK [dlrn_report : Set empty value for dlrnapi password] 2025-10-01 10:58:17.600566 | controller | skipping: Conditional result was False 2025-10-01 10:58:17.608178 | 2025-10-01 10:58:17.608263 | TASK [dlrn_report : Report results to dlrn for the tested hash] 2025-10-01 10:58:18.146853 | controller | skipping: Conditional result was False 2025-10-01 10:58:18.180217 | 2025-10-01 10:58:18.180351 | PLAY RECAP 2025-10-01 10:58:18.180413 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 10 rescued: 0 ignored: 0 2025-10-01 10:58:18.180443 | 2025-10-01 10:58:18.289525 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/ci-framework-rdo-base/dlrn/dlrn-report.yaml@master] 2025-10-01 10:58:18.293416 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-01 10:58:18.853711 | 2025-10-01 10:58:18.853817 | PLAY [all] 2025-10-01 10:58:18.887972 | 2025-10-01 10:58:18.888109 | TASK [include_role : fetch-output] 2025-10-01 10:58:18.941524 | controller | ok 2025-10-01 10:58:18.957949 | crc | ok 2025-10-01 10:58:18.982882 | 2025-10-01 10:58:18.982962 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-01 10:58:19.066032 | crc | ok 2025-10-01 10:58:19.072172 | controller | ok 2025-10-01 10:58:19.078272 | 2025-10-01 10:58:19.078333 | TASK [fetch-output : Set log path for single node] 2025-10-01 10:58:19.115145 | controller | skipping: Conditional result was False 2025-10-01 10:58:19.136148 | crc | skipping: Conditional result was False 2025-10-01 10:58:19.143092 | 2025-10-01 10:58:19.143966 | LOOP [fetch-output : Ensure local output dirs] 2025-10-01 10:58:19.569566 | controller -> localhost | ok: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/logs/controller" 2025-10-01 10:58:19.619830 | crc -> localhost | changed: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/logs/crc" 2025-10-01 10:58:19.806884 | controller -> localhost | ok: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/artifacts" 2025-10-01 10:58:19.837358 | crc -> localhost | ok: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/artifacts" 2025-10-01 10:58:19.995655 | controller -> localhost | ok: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/docs" 2025-10-01 10:58:20.072545 | crc -> localhost | ok: "/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/docs" 2025-10-01 10:58:20.072712 | crc -> localhost | ok: All items complete 2025-10-01 10:58:20.072738 | 2025-10-01 10:58:20.088917 | 2025-10-01 10:58:20.089056 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-01 10:58:20.768390 | controller | changed: 2025-10-01 10:58:20.768789 | controller | .d..t...... ./ 2025-10-01 10:58:20.768851 | controller | >f+++++++++ zuul-output-controller-all-logs.tar.gz 2025-10-01 10:58:20.901191 | crc | changed: 2025-10-01 10:58:20.901303 | crc | .d..t...... ./ 2025-10-01 10:58:20.901334 | crc | >f+++++++++ crc-cloud-workdir-crc-all-logs.tar.gz 2025-10-01 10:58:20.901357 | crc | >f+++++++++ kubelet.log 2025-10-01 10:58:20.901380 | crc | >f+++++++++ zuul-output-crc-all-logs.tar.gz 2025-10-01 10:58:20.901404 | crc | cd+++++++++ crc-cloud/ 2025-10-01 10:58:21.400951 | controller | ok 2025-10-01 10:58:21.514160 | crc | ok 2025-10-01 10:58:21.936089 | controller | ok 2025-10-01 10:58:22.013429 | crc | ok 2025-10-01 10:58:22.013536 | crc | changed: All items complete 2025-10-01 10:58:22.013561 | 2025-10-01 10:58:22.042150 | 2025-10-01 10:58:22.042269 | TASK [include_role : fetch-output-openshift] 2025-10-01 10:58:22.067719 | controller | skipping: Conditional result was False 2025-10-01 10:58:22.078567 | crc | skipping: Conditional result was False 2025-10-01 10:58:22.085719 | 2025-10-01 10:58:22.085818 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-01 10:58:22.562596 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013110 2025-10-01 10:58:22.873992 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.013422 2025-10-01 10:58:22.964944 | 2025-10-01 10:58:22.965109 | PLAY [all] 2025-10-01 10:58:22.993098 | 2025-10-01 10:58:22.993175 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-01 10:58:23.613948 | controller | changed 2025-10-01 10:58:23.767911 | crc | changed 2025-10-01 10:58:23.842926 | 2025-10-01 10:58:23.843055 | PLAY RECAP 2025-10-01 10:58:23.843104 | controller | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-01 10:58:23.843131 | crc | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-10-01 10:58:23.843149 | 2025-10-01 10:58:23.946707 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-10-01 10:58:23.954786 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-10-01 10:58:24.581142 | 2025-10-01 10:58:24.581252 | PLAY [localhost] 2025-10-01 10:58:24.598192 | 2025-10-01 10:58:24.598272 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-01 10:58:24.997974 | localhost | changed 2025-10-01 10:58:25.004813 | 2025-10-01 10:58:25.004957 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-01 10:58:25.040591 | localhost | ok 2025-10-01 10:58:25.059922 | 2025-10-01 10:58:25.060069 | TASK [add-fileserver : Create SSH private key tempfile] 2025-10-01 10:58:25.454499 | localhost | changed 2025-10-01 10:58:25.465317 | 2025-10-01 10:58:25.465466 | TASK [add-fileserver : Create SSH private key from secret] 2025-10-01 10:58:26.261281 | localhost | changed 2025-10-01 10:58:26.267078 | 2025-10-01 10:58:26.267189 | TASK [add-fileserver : Add fileserver ssh key] 2025-10-01 10:58:26.724792 | localhost | Identity added: /var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/tmp/ansible.830fqjje (/var/lib/zuul/builds/eaf3bf33b5094c7293edbd23ebce0adc/work/tmp/ansible.830fqjje) 2025-10-01 10:58:26.724977 | localhost | ok: Runtime: 0:00:00.014668 2025-10-01 10:58:26.729229 | 2025-10-01 10:58:26.729296 | TASK [add-fileserver : Remove SSH private key from disk] 2025-10-01 10:58:27.056203 | localhost | ok: Runtime: 0:00:00.007387 2025-10-01 10:58:27.063453 | 2025-10-01 10:58:27.063583 | TASK [add-fileserver : Add fileserver to inventory] 2025-10-01 10:58:27.129839 | localhost | changed 2025-10-01 10:58:27.139631 | 2025-10-01 10:58:27.139779 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-10-01 10:58:27.634832 | localhost | changed 2025-10-01 10:58:27.690725 | 2025-10-01 10:58:27.690821 | PLAY [localhost] 2025-10-01 10:58:27.702347 | 2025-10-01 10:58:27.702405 | TASK [Generate bulk log download script] 2025-10-01 10:58:27.721899 | localhost | ok 2025-10-01 10:58:27.733946 | 2025-10-01 10:58:27.734011 | TASK [local-log-download : Check API endpoint is defined] 2025-10-01 10:58:27.782100 | localhost | ok: All assertions passed 2025-10-01 10:58:27.787392 | 2025-10-01 10:58:27.787457 | TASK [local-log-download : Create download script] 2025-10-01 10:58:28.260471 | localhost -> localhost | changed 2025-10-01 10:58:28.280669 | 2025-10-01 10:58:28.280807 | TASK [Register quick-download link] 2025-10-01 10:58:28.307650 | localhost | ok 2025-10-01 10:58:28.339668 | 2025-10-01 10:58:28.339742 | PLAY [logserver.rdoproject.org] 2025-10-01 10:58:28.352793 | 2025-10-01 10:58:28.352869 | TASK [Set zuul-log-path fact] 2025-10-01 10:58:28.371616 | logserver.rdoproject.org | ok 2025-10-01 10:58:28.384066 | 2025-10-01 10:58:28.384155 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-01 10:58:28.423294 | logserver.rdoproject.org | ok 2025-10-01 10:58:28.430589 | 2025-10-01 10:58:28.430674 | TASK [upload-logs : Create log directories] 2025-10-01 10:58:29.268145 | logserver.rdoproject.org | changed 2025-10-01 10:58:29.275694 | 2025-10-01 10:58:29.275829 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-01 10:58:29.595910 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.006939 2025-10-01 10:58:29.605957 | 2025-10-01 10:58:29.606169 | TASK [upload-logs : Upload logs to log server] 2025-10-01 10:58:30.443554 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-10-01 10:58:30.450357 | 2025-10-01 10:58:30.450531 | LOOP [upload-logs : Compress console log and json output] 2025-10-01 10:58:30.517959 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-01 10:58:30.530518 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-01 10:58:30.546945 | 2025-10-01 10:58:30.547151 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-01 10:58:30.596862 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-01 10:58:30.597277 | 2025-10-01 10:58:30.600138 | logserver.rdoproject.org | skipping: Conditional result was False 2025-10-01 10:58:30.612782 | 2025-10-01 10:58:30.613007 | LOOP [upload-logs : Upload console log and json output]