2026-06-08 07:42:17.050053 | Job console starting
2026-06-08 07:42:17.093772 | Updating git repos
2026-06-08 07:42:17.149838 | Cloning repos into workspace
2026-06-08 07:42:17.192079 | Restoring repo states
2026-06-08 07:42:17.204072 | Merging changes
2026-06-08 07:42:18.233770 | Checking out repos
2026-06-08 07:42:18.612016 | Preparing playbooks
2026-06-08 07:42:22.703196 | Running Ansible setup
2026-06-08 07:42:29.609887 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-08 07:42:30.311880 | 
2026-06-08 07:42:30.312415 | PLAY [localhost]
2026-06-08 07:42:30.322373 | 
2026-06-08 07:42:30.322469 | TASK [Gathering Facts]
2026-06-08 07:42:31.313492 | localhost | ok
2026-06-08 07:42:31.323644 | 
2026-06-08 07:42:31.323765 | TASK [Setup log path fact]
2026-06-08 07:42:31.353348 | localhost | ok
2026-06-08 07:42:31.387934 | 
2026-06-08 07:42:31.388163 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-08 07:42:31.420351 | localhost | ok
2026-06-08 07:42:31.428601 | 
2026-06-08 07:42:31.428668 | TASK [emit-job-header : Print job information]
2026-06-08 07:42:31.470338 | # Job Information
2026-06-08 07:42:31.470479 | Ansible Version: 2.16.18
2026-06-08 07:42:31.470525 | Job: ansible-collection-kubernetes-molecule-cluster-upgrade
2026-06-08 07:42:31.470557 | Pipeline: check
2026-06-08 07:42:31.470586 | Executor: 2d72f0692154
2026-06-08 07:42:31.470615 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/279
2026-06-08 07:42:31.470651 | Event ID: 72386820-630d-11f1-8d42-7d1c9c7d40cc
2026-06-08 07:42:31.474361 | 
2026-06-08 07:42:31.474447 | LOOP [emit-job-header : Print node information]
2026-06-08 07:42:31.553161 | localhost | ok:
2026-06-08 07:42:31.553641 | localhost | # Node Information
2026-06-08 07:42:31.553673 | localhost | Inventory Hostname: controller-1
2026-06-08 07:42:31.553696 | localhost | Hostname: np0000178855
2026-06-08 07:42:31.553717 | localhost | Username: zuul
2026-06-08 07:42:31.553744 | localhost | Distro: Debian 13.5
2026-06-08 07:42:31.553765 | localhost | Provider: yul1
2026-06-08 07:42:31.553784 | localhost | Region: ca-ymq-1
2026-06-08 07:42:31.553803 | localhost | Label: debian-trixie
2026-06-08 07:42:31.553822 | localhost | Product Name: OpenStack Nova
2026-06-08 07:42:31.553841 | localhost | Interface IP: 199.204.45.116
2026-06-08 07:42:31.589081 | localhost | ok:
2026-06-08 07:42:31.589318 | localhost | # Node Information
2026-06-08 07:42:31.589383 | localhost | Inventory Hostname: controller-2
2026-06-08 07:42:31.589433 | localhost | Hostname: np0000178856
2026-06-08 07:42:31.589478 | localhost | Username: zuul
2026-06-08 07:42:31.589521 | localhost | Distro: Debian 13.5
2026-06-08 07:42:31.589562 | localhost | Provider: yul1
2026-06-08 07:42:31.589601 | localhost | Region: ca-ymq-1
2026-06-08 07:42:31.589630 | localhost | Label: debian-trixie
2026-06-08 07:42:31.589660 | localhost | Product Name: OpenStack Nova
2026-06-08 07:42:31.589689 | localhost | Interface IP: 199.204.45.132
2026-06-08 07:42:31.626006 | localhost | ok:
2026-06-08 07:42:31.626173 | localhost | # Node Information
2026-06-08 07:42:31.626223 | localhost | Inventory Hostname: controller-3
2026-06-08 07:42:31.626257 | localhost | Hostname: np0000178857
2026-06-08 07:42:31.626287 | localhost | Username: zuul
2026-06-08 07:42:31.626316 | localhost | Distro: Debian 13.5
2026-06-08 07:42:31.626344 | localhost | Provider: yul1
2026-06-08 07:42:31.626379 | localhost | Region: ca-ymq-1
2026-06-08 07:42:31.626444 | localhost | Label: debian-trixie
2026-06-08 07:42:31.626485 | localhost | Product Name: OpenStack Nova
2026-06-08 07:42:31.626516 | localhost | Interface IP: 199.204.45.229
2026-06-08 07:42:31.642432 | 
2026-06-08 07:42:31.642585 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-08 07:42:32.068204 | localhost -> localhost | changed
2026-06-08 07:42:32.079052 | 
2026-06-08 07:42:32.079155 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-08 07:42:33.002233 | localhost -> localhost | changed
2026-06-08 07:42:33.013224 | 
2026-06-08 07:42:33.013384 | PLAY [all]
2026-06-08 07:42:33.023998 | 
2026-06-08 07:42:33.024119 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-08 07:42:33.260077 | controller-1 -> localhost | ok
2026-06-08 07:42:33.272104 | 
2026-06-08 07:42:33.272321 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-08 07:42:33.307546 | controller-1 | ok
2026-06-08 07:42:33.339809 | controller-2 | ok
2026-06-08 07:42:33.356156 | controller-3 | ok
2026-06-08 07:42:33.386172 | controller-1 | included: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-08 07:42:33.386336 | controller-2 | included: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-08 07:42:33.386699 | controller-3 | included: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-08 07:42:33.394175 | 
2026-06-08 07:42:33.394257 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-08 07:42:34.581917 | controller-1 -> localhost | Generating public/private rsa key pair.
2026-06-08 07:42:34.582096 | controller-1 -> localhost | Your identification has been saved in /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/97b3664d636442c1aca4179efa909880_id_rsa
2026-06-08 07:42:34.582131 | controller-1 -> localhost | Your public key has been saved in /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/97b3664d636442c1aca4179efa909880_id_rsa.pub
2026-06-08 07:42:34.582157 | controller-1 -> localhost | The key fingerprint is:
2026-06-08 07:42:34.582181 | controller-1 -> localhost | SHA256:3Rsf3GpujC9TwrhKGy9IN0zJbURbJBw/I9pgQbUb7Qk zuul-build-sshkey
2026-06-08 07:42:34.582205 | controller-1 -> localhost | The key's randomart image is:
2026-06-08 07:42:34.582228 | controller-1 -> localhost | +---[RSA 3072]----+
2026-06-08 07:42:34.582251 | controller-1 -> localhost | |       .o+=oo    |
2026-06-08 07:42:34.582275 | controller-1 -> localhost | |         .oB     |
2026-06-08 07:42:34.582298 | controller-1 -> localhost | |       .o+E =    |
2026-06-08 07:42:34.582320 | controller-1 -> localhost | |       .+=oB = . |
2026-06-08 07:42:34.582343 | controller-1 -> localhost | |       oS.+o= o .|
2026-06-08 07:42:34.582364 | controller-1 -> localhost | |      . + . o+.o |
2026-06-08 07:42:34.582386 | controller-1 -> localhost | |     . oo. ..=+  |
2026-06-08 07:42:34.582409 | controller-1 -> localhost | |      ...+. +oo  |
2026-06-08 07:42:34.582431 | controller-1 -> localhost | |        oo.  =o  |
2026-06-08 07:42:34.582454 | controller-1 -> localhost | +----[SHA256]-----+
2026-06-08 07:42:34.582507 | controller-1 -> localhost | ok: Runtime: 0:00:00.531329
2026-06-08 07:42:34.588604 | 
2026-06-08 07:42:34.588781 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-08 07:42:34.626969 | controller-1 | ok
2026-06-08 07:42:34.632039 | controller-2 | ok
2026-06-08 07:42:34.634962 | controller-3 | ok
2026-06-08 07:42:34.649907 | controller-1 | included: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-08 07:42:34.649971 | controller-2 | included: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-08 07:42:34.649996 | controller-3 | included: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-08 07:42:34.664130 | 
2026-06-08 07:42:34.664283 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-08 07:42:34.693352 | controller-1 | skipping: Conditional result was False
2026-06-08 07:42:34.695752 | controller-2 | skipping: Conditional result was False
2026-06-08 07:42:34.716407 | controller-3 | skipping: Conditional result was False
2026-06-08 07:42:34.727791 | 
2026-06-08 07:42:34.727917 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-08 07:42:35.318582 | controller-3 | changed
2026-06-08 07:42:35.323542 | controller-2 | changed
2026-06-08 07:42:35.326701 | controller-1 | changed
2026-06-08 07:42:35.331026 | 
2026-06-08 07:42:35.331090 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-08 07:42:35.555799 | controller-1 | ok
2026-06-08 07:42:35.562732 | controller-3 | ok
2026-06-08 07:42:35.566981 | controller-2 | ok
2026-06-08 07:42:35.571482 | 
2026-06-08 07:42:35.571550 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-08 07:42:36.140495 | controller-2 | changed
2026-06-08 07:42:36.146252 | controller-1 | changed
2026-06-08 07:42:36.151731 | controller-3 | changed
2026-06-08 07:42:36.156413 | 
2026-06-08 07:42:36.156478 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-08 07:42:36.750900 | controller-2 | changed
2026-06-08 07:42:36.756571 | controller-1 | changed
2026-06-08 07:42:36.814264 | controller-3 | changed
2026-06-08 07:42:36.818722 | 
2026-06-08 07:42:36.818793 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-08 07:42:36.846716 | controller-1 | skipping: Conditional result was False
2026-06-08 07:42:36.849212 | controller-2 | skipping: Conditional result was False
2026-06-08 07:42:36.859725 | controller-3 | skipping: Conditional result was False
2026-06-08 07:42:36.868506 | 
2026-06-08 07:42:36.868655 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-08 07:42:37.237706 | controller-1 -> localhost | changed
2026-06-08 07:42:37.259111 | 
2026-06-08 07:42:37.259200 | TASK [add-build-sshkey : Add back temp key]
2026-06-08 07:42:37.559688 | controller-1 -> localhost | Identity added: /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/97b3664d636442c1aca4179efa909880_id_rsa (zuul-build-sshkey)
2026-06-08 07:42:37.560104 | controller-1 -> localhost | ok: Runtime: 0:00:00.010555
2026-06-08 07:42:37.572382 | 
2026-06-08 07:42:37.572493 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-08 07:42:37.891600 | controller-3 | ok
2026-06-08 07:42:38.001215 | controller-1 | ok
2026-06-08 07:42:38.006028 | controller-2 | ok
2026-06-08 07:42:38.010885 | 
2026-06-08 07:42:38.010983 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-08 07:42:38.048567 | controller-1 | skipping: Conditional result was False
2026-06-08 07:42:38.059877 | controller-2 | skipping: Conditional result was False
2026-06-08 07:42:38.060371 | controller-3 | skipping: Conditional result was False
2026-06-08 07:42:38.080226 | 
2026-06-08 07:42:38.080334 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-08 07:42:38.419921 | controller-3 | ok
2026-06-08 07:42:38.426034 | controller-2 | ok
2026-06-08 07:42:38.431510 | controller-1 | ok
2026-06-08 07:42:38.435813 | 
2026-06-08 07:42:38.435876 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-08 07:42:39.412074 | controller-3 | Output suppressed because no_log was given
2026-06-08 07:42:39.427508 | controller-1 | Output suppressed because no_log was given
2026-06-08 07:42:39.438187 | controller-2 | Output suppressed because no_log was given
2026-06-08 07:42:39.461554 | 
2026-06-08 07:42:39.461776 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-08 07:42:39.691289 | controller-1 | ok: "logs"
2026-06-08 07:42:39.691556 | controller-1 | ok: All items complete
2026-06-08 07:42:39.691597 | 
2026-06-08 07:42:39.696467 | controller-2 | ok: "logs"
2026-06-08 07:42:39.699957 | controller-3 | ok: "logs"
2026-06-08 07:42:39.883859 | controller-3 | ok: "artifacts"
2026-06-08 07:42:39.887438 | controller-1 | ok: "artifacts"
2026-06-08 07:42:39.910437 | controller-2 | ok: "artifacts"
2026-06-08 07:42:40.064337 | controller-3 | ok: "docs"
2026-06-08 07:42:40.080887 | controller-1 | ok: "docs"
2026-06-08 07:42:40.107502 | controller-2 | ok: "docs"
2026-06-08 07:42:40.107598 | controller-2 | ok: All items complete
2026-06-08 07:42:40.107633 | 
2026-06-08 07:42:40.124737 | 
2026-06-08 07:42:40.124892 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-08 07:42:40.350184 | controller-1 | changed: "logs"
2026-06-08 07:42:40.368172 | controller-2 | changed: "logs"
2026-06-08 07:42:40.378961 | controller-3 | changed: "logs"
2026-06-08 07:42:40.554614 | controller-1 | changed: "artifacts"
2026-06-08 07:42:40.559879 | controller-2 | changed: "artifacts"
2026-06-08 07:42:40.565530 | controller-3 | changed: "artifacts"
2026-06-08 07:42:40.746948 | controller-1 | changed: "docs"
2026-06-08 07:42:40.751642 | controller-2 | changed: "docs"
2026-06-08 07:42:40.756995 | controller-3 | changed: "docs"
2026-06-08 07:42:40.782373 | 
2026-06-08 07:42:40.782526 | PLAY RECAP
2026-06-08 07:42:40.782598 | controller-1 | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-06-08 07:42:40.782642 | controller-2 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-06-08 07:42:40.782684 | controller-3 | ok: 11 changed: 5 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-06-08 07:42:40.782725 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:42:40.782758 | 
2026-06-08 07:42:40.961672 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-06-08 07:42:40.968931 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-08 07:42:41.595563 | 
2026-06-08 07:42:41.595743 | PLAY [all]
2026-06-08 07:42:41.608983 | 
2026-06-08 07:42:41.609134 | TASK [setup-uv : Extract archive]
2026-06-08 07:42:45.249630 | controller-2 | changed
2026-06-08 07:42:45.287280 | controller-1 | changed
2026-06-08 07:42:47.983730 | controller-3 | changed
2026-06-08 07:42:48.072727 | 
2026-06-08 07:42:48.072949 | TASK [setup-uv : Print version]
2026-06-08 07:42:48.502685 | controller-2 | uv 0.8.13
2026-06-08 07:42:48.489622 | controller-1 | uv 0.8.13
2026-06-08 07:42:48.531502 | controller-3 | uv 0.8.13
2026-06-08 07:42:48.652101 | controller-1 | ok: Runtime: 0:00:00.016270
2026-06-08 07:42:48.660330 | controller-3 | ok: Runtime: 0:00:00.013807
2026-06-08 07:42:48.666355 | controller-2 | ok: Runtime: 0:00:00.014242
2026-06-08 07:42:48.680412 | 
2026-06-08 07:42:48.680534 | TASK [Install Ansible collection siblings]
2026-06-08 07:42:49.100627 | controller-1 | ok:
2026-06-08 07:42:49.100914 | controller-1 | Skipping ansible.posix: no checked-out sibling
2026-06-08 07:42:49.101024 | controller-1 | Skipping community.crypto: no checked-out sibling
2026-06-08 07:42:49.101079 | controller-1 | Skipping community.general: no checked-out sibling
2026-06-08 07:42:49.101130 | controller-1 | Skipping kubernetes.core: no checked-out sibling
2026-06-08 07:42:49.101182 | controller-1 | Skipping vexxhost.containers: no checked-out sibling
2026-06-08 07:42:49.104910 | 
2026-06-08 07:42:49.105090 | PLAY RECAP
2026-06-08 07:42:49.105257 | controller-1 | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:42:49.105328 | controller-2 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:42:49.105355 | controller-3 | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:42:49.105396 | 
2026-06-08 07:42:49.256435 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-06-08 07:42:49.259705 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-06-08 07:42:49.945553 | 
2026-06-08 07:42:49.968877 | PLAY [all]
2026-06-08 07:42:49.986422 | 
2026-06-08 07:42:49.986541 | TASK [Update apt cache]
2026-06-08 07:42:54.913122 | controller-3 | ok
2026-06-08 07:42:55.195621 | controller-2 | ok
2026-06-08 07:42:55.714854 | controller-1 | ok
2026-06-08 07:42:55.721717 | 
2026-06-08 07:42:55.721903 | TASK [Disable firewalld]
2026-06-08 07:42:55.743141 | controller-1 | skipping: Conditional result was False
2026-06-08 07:42:55.767714 | controller-2 | skipping: Conditional result was False
2026-06-08 07:42:55.779052 | controller-3 | skipping: Conditional result was False
2026-06-08 07:42:55.786021 | 
2026-06-08 07:42:55.786195 | TASK [Install "jq" for log collection]
2026-06-08 07:42:57.961221 | controller-1 | changed
2026-06-08 07:42:58.144224 | controller-2 | changed
2026-06-08 07:42:58.260838 | controller-3 | changed
2026-06-08 07:42:58.262656 | 
2026-06-08 07:42:58.262705 | PLAY RECAP
2026-06-08 07:42:58.262751 | controller-1 | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:42:58.262780 | controller-2 | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:42:58.262806 | controller-3 | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:42:58.262826 | 
2026-06-08 07:42:58.412000 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main]
2026-06-08 07:42:58.416651 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-06-08 07:42:59.037366 | 
2026-06-08 07:42:59.037546 | PLAY [all]
2026-06-08 07:42:59.049512 | 
2026-06-08 07:42:59.049626 | TASK [Copy inventory file for Zuul]
2026-06-08 07:43:00.079090 | controller-1 | changed
2026-06-08 07:43:00.084845 | 
2026-06-08 07:43:00.084993 | TASK [Switch "ansible_host" to private IP]
2026-06-08 07:43:00.474762 | controller-1 | changed: 3 replacements made
2026-06-08 07:43:00.481882 | 
2026-06-08 07:43:00.482038 | TASK [Run Molecule scenario]
2026-06-08 07:43:00.995221 | controller-1 | Using CPython 3.13.5 interpreter at: /usr/bin/python3
2026-06-08 07:43:00.995368 | controller-1 | Creating virtual environment at: .venv
2026-06-08 07:43:01.254095 | controller-1 | Downloading cryptography (4.3MiB)
2026-06-08 07:43:01.254303 | controller-1 | Downloading pygments (1.2MiB)
2026-06-08 07:43:01.255898 | controller-1 | Downloading ansible-core (2.3MiB)
2026-06-08 07:43:01.406768 | controller-1 |  Downloading cryptography
2026-06-08 07:43:01.456086 | controller-1 |  Downloading pygments
2026-06-08 07:43:01.631772 | controller-1 |  Downloading ansible-core
2026-06-08 07:43:01.671025 | controller-1 | Installed 36 packages in 38ms
2026-06-08 07:43:02.372389 | controller-1 | INFO     Collection 'vexxhost.kubernetes' detected.
2026-06-08 07:43:02.372436 | controller-1 | INFO     Scenarios will be used from 'extensions/molecule'
2026-06-08 07:43:03.297126 | controller-1 | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed.  Exiting.
2026-06-08 07:43:03.297185 | controller-1 | INFO     default scenario not found, disabling shared state.
2026-06-08 07:43:03.297195 | controller-1 | INFO     [cluster-upgrade > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-06-08 07:43:03.297201 | controller-1 | INFO     [cluster-upgrade > prerun] Performing prerun with role_name_check=0...
2026-06-08 07:43:19.282754 | controller-1 | INFO     [cluster-upgrade > dependency] Executing
2026-06-08 07:43:19.282893 | controller-1 | WARNING  [cluster-upgrade > dependency] Missing roles requirements file: requirements.yml
2026-06-08 07:43:19.283170 | controller-1 | WARNING  [cluster-upgrade > dependency] Missing collections requirements file: collections.yml
2026-06-08 07:43:19.283328 | controller-1 | WARNING  [cluster-upgrade > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-06-08 07:43:19.290203 | controller-1 | INFO     [cluster-upgrade > cleanup] Executing
2026-06-08 07:43:19.290501 | controller-1 | WARNING  [cluster-upgrade > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-08 07:43:19.295980 | controller-1 | INFO     [cluster-upgrade > destroy] Executing
2026-06-08 07:43:19.296010 | controller-1 | WARNING  [cluster-upgrade > destroy] Skipping, '--destroy=never' requested.
2026-06-08 07:43:19.296083 | controller-1 | INFO     [cluster-upgrade > destroy] Executed: Successful
2026-06-08 07:43:19.301668 | controller-1 | INFO     [cluster-upgrade > syntax] Executing
2026-06-08 07:43:20.708429 | controller-1 |
2026-06-08 07:43:20.708673 | controller-1 | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/cluster-upgrade/converge.yml
2026-06-08 07:43:20.837160 | controller-1 | INFO     [cluster-upgrade > syntax] Executed: Successful
2026-06-08 07:43:20.849815 | controller-1 | INFO     [cluster-upgrade > create] Executing
2026-06-08 07:43:20.855363 | controller-1 | WARNING  [cluster-upgrade > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-06-08 07:43:20.864199 | controller-1 | INFO     [cluster-upgrade > prepare] Executing
2026-06-08 07:43:22.203238 | controller-1 |
2026-06-08 07:43:22.203277 | controller-1 | PLAY [Prepare] *****************************************************************
2026-06-08 07:43:22.203388 | controller-1 |
2026-06-08 07:43:22.203491 | controller-1 | TASK [Gathering Facts] *********************************************************
2026-06-08 07:43:22.203598 | controller-1 | Monday 08 June 2026  07:43:22 +0000 (0:00:00.036)       0:00:00.036 ***********
2026-06-08 07:43:23.456753 | controller-1 | [WARNING]: Host 'controller-2' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-06-08 07:43:24.379452 | controller-1 | [WARNING]: Host 'controller-1' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-06-08 07:43:24.423410 | controller-1 | [WARNING]: Host 'controller-3' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information.
2026-06-08 07:43:24.429719 | controller-1 | ok: [controller-2]
2026-06-08 07:43:24.429925 | controller-1 | ok: [controller-1]
2026-06-08 07:43:24.430124 | controller-1 | ok: [controller-3]
2026-06-08 07:43:24.430365 | controller-1 |
2026-06-08 07:43:24.430576 | controller-1 | TASK [Install Debian packages] *************************************************
2026-06-08 07:43:24.430772 | controller-1 | Monday 08 June 2026  07:43:24 +0000 (0:00:02.226)       0:00:02.263 ***********
2026-06-08 07:43:26.169041 | controller-1 | ok: [controller-3]
2026-06-08 07:43:26.169486 | controller-1 | ok: [controller-1]
2026-06-08 07:43:26.169784 | controller-1 | ok: [controller-2]
2026-06-08 07:43:26.169878 | controller-1 |
2026-06-08 07:43:26.169987 | controller-1 | PLAY [Configure Kubernetes VIP] ************************************************
2026-06-08 07:43:26.170084 | controller-1 |
2026-06-08 07:43:26.170197 | controller-1 | TASK [Gathering Facts] *********************************************************
2026-06-08 07:43:26.170294 | controller-1 | Monday 08 June 2026  07:43:26 +0000 (0:00:01.738)       0:00:04.001 ***********
2026-06-08 07:43:28.032541 | controller-1 | ok: [controller-1]
2026-06-08 07:43:28.032601 | controller-1 | ok: [controller-2]
2026-06-08 07:43:28.032764 | controller-1 | ok: [controller-3]
2026-06-08 07:43:28.032854 | controller-1 |
2026-06-08 07:43:28.033035 | controller-1 | TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] ***
2026-06-08 07:43:28.033228 | controller-1 | Monday 08 June 2026  07:43:28 +0000 (0:00:01.864)       0:00:05.866 ***********
2026-06-08 07:43:28.448550 | controller-1 | changed: [controller-1]
2026-06-08 07:43:28.448639 | controller-1 | changed: [controller-3]
2026-06-08 07:43:28.448692 | controller-1 | changed: [controller-2]
2026-06-08 07:43:28.448778 | controller-1 |
2026-06-08 07:43:28.448869 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] ****************
2026-06-08 07:43:28.452423 | controller-1 | Monday 08 June 2026  07:43:28 +0000 (0:00:00.416)       0:00:06.282 ***********
2026-06-08 07:43:29.977018 | controller-1 | ok: [controller-1] => (item=/etc/keepalived/keepalived.conf)
2026-06-08 07:43:29.977125 | controller-1 | ok: [controller-2] => (item=/etc/keepalived/keepalived.conf)
2026-06-08 07:43:29.977306 | controller-1 | ok: [controller-3] => (item=/etc/keepalived/keepalived.conf)
2026-06-08 07:43:29.977456 | controller-1 | ok: [controller-1] => (item=/etc/keepalived/check_apiserver.sh)
2026-06-08 07:43:29.980600 | controller-1 | ok: [controller-3] => (item=/etc/keepalived/check_apiserver.sh)
2026-06-08 07:43:29.980612 | controller-1 | ok: [controller-2] => (item=/etc/keepalived/check_apiserver.sh)
2026-06-08 07:43:29.980617 | controller-1 | ok: [controller-1] => (item=/etc/kubernetes/manifests/keepalived.yaml)
2026-06-08 07:43:29.980620 | controller-1 | ok: [controller-3] => (item=/etc/kubernetes/manifests/keepalived.yaml)
2026-06-08 07:43:29.980623 | controller-1 | ok: [controller-2] => (item=/etc/kubernetes/manifests/keepalived.yaml)
2026-06-08 07:43:29.980627 | controller-1 | ok: [controller-1] => (item=/etc/haproxy/haproxy.cfg)
2026-06-08 07:43:29.980630 | controller-1 | ok: [controller-3] => (item=/etc/haproxy/haproxy.cfg)
2026-06-08 07:43:29.980633 | controller-1 | ok: [controller-2] => (item=/etc/haproxy/haproxy.cfg)
2026-06-08 07:43:29.980637 | controller-1 | ok: [controller-1] => (item=/etc/kubernetes/manifests/haproxy.yaml)
2026-06-08 07:43:29.980640 | controller-1 | ok: [controller-3] => (item=/etc/kubernetes/manifests/haproxy.yaml)
2026-06-08 07:43:29.980643 | controller-1 | ok: [controller-2] => (item=/etc/kubernetes/manifests/haproxy.yaml)
2026-06-08 07:43:29.980646 | controller-1 |
2026-06-08 07:43:29.980655 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] ****
2026-06-08 07:43:29.980659 | controller-1 | Monday 08 June 2026  07:43:29 +0000 (0:00:01.526)       0:00:07.808 ***********
2026-06-08 07:43:30.377617 | controller-1 | [ERROR]: Task failed: Module failed: Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !
2026-06-08 07:43:30.377867 | controller-1 | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kube_vip/tasks/main.yml:32:3
2026-06-08 07:43:30.378127 | controller-1 |
2026-06-08 07:43:30.378387 | controller-1 | 30     - Restart "kubelet" service
2026-06-08 07:43:30.378581 | controller-1 | 31
2026-06-08 07:43:30.378778 | controller-1 | 32 - name: Switch API server to run on port 6443
2026-06-08 07:43:30.379010 | controller-1 |      ^ column 3
2026-06-08 07:43:30.379203 | controller-1 |
2026-06-08 07:43:30.379540 | controller-1 | failed: [controller-1] (item=/etc/kubernetes/manifests/kube-apiserver.yaml) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/manifests/kube-apiserver.yaml", "msg": "Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !", "rc": 257}
2026-06-08 07:43:30.379811 | controller-1 | failed: [controller-2] (item=/etc/kubernetes/manifests/kube-apiserver.yaml) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/manifests/kube-apiserver.yaml", "msg": "Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !", "rc": 257}
2026-06-08 07:43:30.381481 | controller-1 | failed: [controller-3] (item=/etc/kubernetes/manifests/kube-apiserver.yaml) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/manifests/kube-apiserver.yaml", "msg": "Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !", "rc": 257}
2026-06-08 07:43:30.641240 | controller-1 | [ERROR]: Task failed: Module failed: Path /etc/kubernetes/controller-manager.conf does not exist !
2026-06-08 07:43:30.641431 | controller-1 | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kube_vip/tasks/main.yml:32:3
2026-06-08 07:43:30.641625 | controller-1 |
2026-06-08 07:43:30.641825 | controller-1 | 30     - Restart "kubelet" service
2026-06-08 07:43:30.642009 | controller-1 | 31
2026-06-08 07:43:30.642206 | controller-1 | 32 - name: Switch API server to run on port 6443
2026-06-08 07:43:30.642387 | controller-1 |      ^ column 3
2026-06-08 07:43:30.642570 | controller-1 |
2026-06-08 07:43:30.642968 | controller-1 | failed: [controller-2] (item=/etc/kubernetes/controller-manager.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/controller-manager.conf", "msg": "Path /etc/kubernetes/controller-manager.conf does not exist !", "rc": 257}
2026-06-08 07:43:30.651938 | controller-1 | failed: [controller-1] (item=/etc/kubernetes/controller-manager.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/controller-manager.conf", "msg": "Path /etc/kubernetes/controller-manager.conf does not exist !", "rc": 257}
2026-06-08 07:43:30.661757 | controller-1 | failed: [controller-3] (item=/etc/kubernetes/controller-manager.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/controller-manager.conf", "msg": "Path /etc/kubernetes/controller-manager.conf does not exist !", "rc": 257}
2026-06-08 07:43:30.927526 | controller-1 | [ERROR]: Task failed: Module failed: Path /etc/kubernetes/scheduler.conf does not exist !
2026-06-08 07:43:30.927748 | controller-1 | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kube_vip/tasks/main.yml:32:3
2026-06-08 07:43:30.928010 | controller-1 |
2026-06-08 07:43:30.928221 | controller-1 | 30     - Restart "kubelet" service
2026-06-08 07:43:30.928417 | controller-1 | 31
2026-06-08 07:43:30.928715 | controller-1 | 32 - name: Switch API server to run on port 6443
2026-06-08 07:43:30.928914 | controller-1 |      ^ column 3
2026-06-08 07:43:30.929087 | controller-1 |
2026-06-08 07:43:30.929420 | controller-1 | failed: [controller-2] (item=/etc/kubernetes/scheduler.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/scheduler.conf", "msg": "Path /etc/kubernetes/scheduler.conf does not exist !", "rc": 257}
2026-06-08 07:43:30.940480 | controller-1 | failed: [controller-3] (item=/etc/kubernetes/scheduler.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/scheduler.conf", "msg": "Path /etc/kubernetes/scheduler.conf does not exist !", "rc": 257}
2026-06-08 07:43:30.956738 | controller-1 | failed: [controller-1] (item=/etc/kubernetes/scheduler.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/scheduler.conf", "msg": "Path /etc/kubernetes/scheduler.conf does not exist !", "rc": 257}
2026-06-08 07:43:30.961727 | controller-1 | ...ignoring
2026-06-08 07:43:30.961880 | controller-1 | ...ignoring
2026-06-08 07:43:30.962176 | controller-1 | ...ignoring
2026-06-08 07:43:30.962388 | controller-1 |
2026-06-08 07:43:30.962636 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] *********
2026-06-08 07:43:30.962851 | controller-1 | Monday 08 June 2026  07:43:30 +0000 (0:00:00.985)       0:00:08.794 ***********
2026-06-08 07:43:31.401138 | controller-1 | ok: [controller-1]
2026-06-08 07:43:31.401186 | controller-1 | ok: [controller-3]
2026-06-08 07:43:31.401277 | controller-1 | ok: [controller-2]
2026-06-08 07:43:31.401393 | controller-1 |
2026-06-08 07:43:31.404643 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] *********
2026-06-08 07:43:31.404668 | controller-1 | Monday 08 June 2026  07:43:31 +0000 (0:00:00.437)       0:00:09.232 ***********
2026-06-08 07:43:31.738021 | controller-1 | ok: [controller-1]
2026-06-08 07:43:31.738053 | controller-1 | ok: [controller-3]
2026-06-08 07:43:31.738062 | controller-1 | ok: [controller-2]
2026-06-08 07:43:31.738071 | controller-1 |
2026-06-08 07:43:31.738080 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************
2026-06-08 07:43:31.738089 | controller-1 | Monday 08 June 2026  07:43:31 +0000 (0:00:00.337)       0:00:09.569 ***********
2026-06-08 07:43:31.794843 | controller-1 | ok: [controller-1]
2026-06-08 07:43:31.795140 | controller-1 | ok: [controller-2]
2026-06-08 07:43:31.795409 | controller-1 | ok: [controller-3]
2026-06-08 07:43:31.795658 | controller-1 |
2026-06-08 07:43:31.795947 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] ***
2026-06-08 07:43:31.796254 | controller-1 | Monday 08 June 2026  07:43:31 +0000 (0:00:00.058)       0:00:09.628 ***********
2026-06-08 07:43:31.852808 | controller-1 | skipping: [controller-2]
2026-06-08 07:43:31.852988 | controller-1 | ok: [controller-1]
2026-06-08 07:43:31.853144 | controller-1 | skipping: [controller-3]
2026-06-08 07:43:31.853291 | controller-1 |
2026-06-08 07:43:31.853454 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] ***************
2026-06-08 07:43:31.853613 | controller-1 | Monday 08 June 2026  07:43:31 +0000 (0:00:00.058)       0:00:09.686 ***********
2026-06-08 07:43:32.818559 | controller-1 | ok: [controller-1]
2026-06-08 07:43:32.818767 | controller-1 | ok: [controller-3]
2026-06-08 07:43:32.818930 | controller-1 | ok: [controller-2]
2026-06-08 07:43:32.819084 | controller-1 |
2026-06-08 07:43:32.819252 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Ensure kube-vip configuration file] *******
2026-06-08 07:43:32.819414 | controller-1 | Monday 08 June 2026  07:43:32 +0000 (0:00:00.965)       0:00:10.651 ***********
2026-06-08 07:43:33.208795 | controller-1 | ok: [controller-1]
2026-06-08 07:43:33.208842 | controller-1 | ok: [controller-2]
2026-06-08 07:43:33.208853 | controller-1 | ok: [controller-3]
2026-06-08 07:43:33.208865 | controller-1 |
2026-06-08 07:43:33.208876 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Flush handlers] ***************************
2026-06-08 07:43:33.208887 | controller-1 | Monday 08 June 2026  07:43:33 +0000 (0:00:00.321)       0:00:10.973 ***********
2026-06-08 07:43:33.208897 | controller-1 |
2026-06-08 07:43:33.208907 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Flush handlers] ***************************
2026-06-08 07:43:33.208916 | controller-1 | Monday 08 June 2026  07:43:33 +0000 (0:00:00.006)       0:00:10.979 ***********
2026-06-08 07:43:33.208926 | controller-1 |
2026-06-08 07:43:33.208935 | controller-1 | TASK [vexxhost.kubernetes.kube_vip : Flush handlers] ***************************
2026-06-08 07:43:33.208945 | controller-1 | Monday 08 June 2026  07:43:33 +0000 (0:00:00.003)       0:00:10.983 ***********
2026-06-08 07:43:33.208954 | controller-1 |
2026-06-08 07:43:33.208964 | controller-1 | PLAY [Install Kubernetes] ******************************************************
2026-06-08 07:43:33.208974 | controller-1 |
2026-06-08 07:43:33.208983 | controller-1 | TASK [Gathering Facts] *********************************************************
2026-06-08 07:43:33.209002 | controller-1 | Monday 08 June 2026  07:43:33 +0000 (0:00:00.056)       0:00:11.039 ***********
2026-06-08 07:43:34.079121 | controller-1 | ok: [controller-1]
2026-06-08 07:43:34.079197 | controller-1 | ok: [controller-2]
2026-06-08 07:43:34.079219 | controller-1 | ok: [controller-3]
2026-06-08 07:43:34.079285 | controller-1 |
2026-06-08 07:43:34.079407 | controller-1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-08 07:43:34.079519 | controller-1 | Monday 08 June 2026  07:43:34 +0000 (0:00:00.872)       0:00:11.911 ***********
2026-06-08 07:43:34.514158 | controller-1 | ok: [controller-2]
2026-06-08 07:43:34.514312 | controller-1 | ok: [controller-3]
2026-06-08 07:43:34.514525 | controller-1 | ok: [controller-1]
2026-06-08 07:43:34.514719 | controller-1 |
2026-06-08 07:43:34.514935 | controller-1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-06-08 07:43:34.515143 | controller-1 | Monday 08 June 2026  07:43:34 +0000 (0:00:00.434)       0:00:12.346 ***********
2026-06-08 07:43:34.597433 | controller-1 | skipping: [controller-1]
2026-06-08 07:43:34.597635 | controller-1 | skipping: [controller-2]
2026-06-08 07:43:34.597844 | controller-1 | skipping: [controller-3]
2026-06-08 07:43:34.598028 | controller-1 |
2026-06-08 07:43:34.598228 | controller-1 | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-06-08 07:43:34.598517 | controller-1 | Monday 08 June 2026  07:43:34 +0000 (0:00:00.083)       0:00:12.430 ***********
2026-06-08 07:43:34.962931 | controller-1 | changed: [controller-1]
2026-06-08 07:43:34.963105 | controller-1 | changed: [controller-2]
2026-06-08 07:43:34.963308 | controller-1 | changed: [controller-3]
2026-06-08 07:43:34.963489 | controller-1 |
2026-06-08 07:43:34.963696 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:43:34.963893 | controller-1 | Monday 08 June 2026  07:43:34 +0000 (0:00:00.365)       0:00:12.795 ***********
2026-06-08 07:43:35.136074 | controller-1 | ok: [controller-3] => {
2026-06-08 07:43:35.136273 | controller-1 |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-06-08 07:43:35.136473 | controller-1 | }
2026-06-08 07:43:35.136759 | controller-1 | ok: [controller-1] => {
2026-06-08 07:43:35.136970 | controller-1 |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-06-08 07:43:35.137148 | controller-1 | }
2026-06-08 07:43:35.137347 | controller-1 | ok: [controller-2] => {
2026-06-08 07:43:35.137544 | controller-1 |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-06-08 07:43:35.137726 | controller-1 | }
2026-06-08 07:43:35.137930 | controller-1 |
2026-06-08 07:43:35.138130 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:43:35.138320 | controller-1 | Monday 08 June 2026  07:43:35 +0000 (0:00:00.173)       0:00:12.969 ***********
2026-06-08 07:43:43.637658 | controller-1 | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually
2026-06-08 07:43:43.673104 | controller-1 | changed: [controller-3]
2026-06-08 07:43:43.673196 | controller-1 | changed: [controller-2]
2026-06-08 07:43:43.673205 | controller-1 | changed: [controller-1]
2026-06-08 07:43:43.673219 | controller-1 |
2026-06-08 07:43:43.673439 | controller-1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-08 07:43:43.673463 | controller-1 | Monday 08 June 2026  07:43:43 +0000 (0:00:08.535)       0:00:21.504 ***********
2026-06-08 07:43:43.721199 | controller-1 | skipping: [controller-1]
2026-06-08 07:43:43.778088 | controller-1 | skipping: [controller-2]
2026-06-08 07:43:43.778167 | controller-1 | skipping: [controller-3]
2026-06-08 07:43:43.778250 | controller-1 |
2026-06-08 07:43:43.778342 | controller-1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-08 07:43:43.778430 | controller-1 | Monday 08 June 2026  07:43:43 +0000 (0:00:00.107)       0:00:21.611 ***********
2026-06-08 07:43:44.144557 | controller-1 | ok: [controller-1]
2026-06-08 07:43:44.144624 | controller-1 | ok: [controller-2]
2026-06-08 07:43:44.144640 | controller-1 | ok: [controller-3]
2026-06-08 07:43:44.144998 | controller-1 |
2026-06-08 07:43:44.145033 | controller-1 | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-06-08 07:43:44.145038 | controller-1 | Monday 08 June 2026  07:43:44 +0000 (0:00:00.365)       0:00:21.977 ***********
2026-06-08 07:43:45.206012 | controller-1 | ok: [controller-1]
2026-06-08 07:43:45.206097 | controller-1 | ok: [controller-2]
2026-06-08 07:43:45.206107 | controller-1 | ok: [controller-3]
2026-06-08 07:43:45.206115 | controller-1 |
2026-06-08 07:43:45.206124 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:43:45.206131 | controller-1 | Monday 08 June 2026  07:43:45 +0000 (0:00:01.057)       0:00:23.034 ***********
2026-06-08 07:43:45.325138 | controller-1 | ok: [controller-1] => {
2026-06-08 07:43:45.325214 | controller-1 |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.1/containerd-2.3.1-linux-amd64.tar.gz"
2026-06-08 07:43:45.325223 | controller-1 | }
2026-06-08 07:43:45.328485 | controller-1 | ok: [controller-2] => {
2026-06-08 07:43:45.328528 | controller-1 |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.1/containerd-2.3.1-linux-amd64.tar.gz"
2026-06-08 07:43:45.328534 | controller-1 | }
2026-06-08 07:43:45.328540 | controller-1 | ok: [controller-3] => {
2026-06-08 07:43:45.328545 | controller-1 |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.1/containerd-2.3.1-linux-amd64.tar.gz"
2026-06-08 07:43:45.328549 | controller-1 | }
2026-06-08 07:43:45.328555 | controller-1 |
2026-06-08 07:43:45.328560 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:43:45.328574 | controller-1 | Monday 08 June 2026  07:43:45 +0000 (0:00:00.121)       0:00:23.156 ***********
2026-06-08 07:44:17.503102 | controller-1 | [ERROR]: Task failed: Module failed: Request failed
2026-06-08 07:44:17.503139 | controller-1 | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:19:3
2026-06-08 07:44:17.503150 | controller-1 |
2026-06-08 07:44:17.503548 | controller-1 | 17     msg: "{{ download_artifact_url }}"
2026-06-08 07:44:17.503817 | controller-1 | 18
2026-06-08 07:44:17.504113 | controller-1 | 19 - name: Download item
2026-06-08 07:44:17.504422 | controller-1 |      ^ column 3
2026-06-08 07:44:17.504711 | controller-1 |
2026-06-08 07:44:17.505006 | controller-1 | fatal: [controller-1]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false}
2026-06-08 07:44:17.665375 | controller-1 | fatal: [controller-2]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false}
2026-06-08 07:44:17.676140 | controller-1 | changed: [controller-3]
2026-06-08 07:44:17.676160 | controller-1 | FAILED - RETRYING: [controller-1]: Download item (4 retries left).
2026-06-08 07:44:17.676165 | controller-1 | FAILED - RETRYING: [controller-2]: Download item (4 retries left).
2026-06-08 07:44:17.676170 | controller-1 | FAILED - RETRYING: [controller-1]: Download item (3 retries left).
2026-06-08 07:44:17.676174 | controller-1 | FAILED - RETRYING: [controller-2]: Download item (3 retries left).
2026-06-08 07:44:17.676178 | controller-1 | FAILED - RETRYING: [controller-1]: Download item (2 retries left).
2026-06-08 07:44:17.676182 | controller-1 | FAILED - RETRYING: [controller-2]: Download item (2 retries left).
2026-06-08 07:44:17.676187 | controller-1 | FAILED - RETRYING: [controller-1]: Download item (1 retries left).
2026-06-08 07:44:17.676191 | controller-1 | FAILED - RETRYING: [controller-2]: Download item (1 retries left).
2026-06-08 07:44:17.676195 | controller-1 |
2026-06-08 07:44:17.676200 | controller-1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-08 07:44:17.676205 | controller-1 | Monday 08 June 2026  07:44:17 +0000 (0:00:32.351)       0:00:55.508 ***********
2026-06-08 07:44:20.772707 | controller-1 | changed: [controller-3]
2026-06-08 07:44:20.772750 | controller-1 |
2026-06-08 07:44:20.772963 | controller-1 | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-06-08 07:44:20.772989 | controller-1 | Monday 08 June 2026  07:44:20 +0000 (0:00:03.094)       0:00:58.602 ***********
2026-06-08 07:44:20.808791 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:20.808859 | controller-1 |
2026-06-08 07:44:20.808946 | controller-1 | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-06-08 07:44:20.809031 | controller-1 | Monday 08 June 2026  07:44:20 +0000 (0:00:00.039)       0:00:58.641 ***********
2026-06-08 07:44:20.845107 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:20.845171 | controller-1 |
2026-06-08 07:44:20.845334 | controller-1 | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-06-08 07:44:20.845472 | controller-1 | Monday 08 June 2026  07:44:20 +0000 (0:00:00.033)       0:00:58.675 ***********
2026-06-08 07:44:20.886098 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:20.886152 | controller-1 |
2026-06-08 07:44:20.886403 | controller-1 | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-06-08 07:44:20.886426 | controller-1 | Monday 08 June 2026  07:44:20 +0000 (0:00:00.043)       0:00:58.719 ***********
2026-06-08 07:44:26.609061 | controller-1 | changed: [controller-3]
2026-06-08 07:44:26.609115 | controller-1 |
2026-06-08 07:44:26.609133 | controller-1 | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-06-08 07:44:26.609258 | controller-1 | Monday 08 June 2026  07:44:26 +0000 (0:00:05.721)       0:01:04.440 ***********
2026-06-08 07:44:27.302223 | controller-1 | changed: [controller-3]
2026-06-08 07:44:27.302296 | controller-1 |
2026-06-08 07:44:27.302492 | controller-1 | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-06-08 07:44:27.302638 | controller-1 | Monday 08 June 2026  07:44:27 +0000 (0:00:00.693)       0:01:05.134 ***********
2026-06-08 07:44:28.781239 | controller-1 | changed: [controller-3] => (item={'path': '/etc/containerd'})
2026-06-08 07:44:28.781285 | controller-1 | changed: [controller-3] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-06-08 07:44:28.783472 | controller-1 | changed: [controller-3] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-06-08 07:44:28.783482 | controller-1 | changed: [controller-3] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-06-08 07:44:28.783486 | controller-1 | changed: [controller-3] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-06-08 07:44:28.783490 | controller-1 |
2026-06-08 07:44:28.783494 | controller-1 | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-06-08 07:44:28.783497 | controller-1 | Monday 08 June 2026  07:44:28 +0000 (0:00:01.476)       0:01:06.610 ***********
2026-06-08 07:44:29.649490 | controller-1 | changed: [controller-3]
2026-06-08 07:44:29.649511 | controller-1 |
2026-06-08 07:44:29.649515 | controller-1 | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-06-08 07:44:29.649519 | controller-1 | Monday 08 June 2026  07:44:29 +0000 (0:00:00.860)       0:01:07.471 ***********
2026-06-08 07:44:29.649522 | controller-1 |
2026-06-08 07:44:29.649525 | controller-1 | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-06-08 07:44:29.649529 | controller-1 | Monday 08 June 2026  07:44:29 +0000 (0:00:00.008)       0:01:07.479 ***********
2026-06-08 07:44:30.548357 | controller-1 | changed: [controller-3]
2026-06-08 07:44:30.551869 | controller-1 |
2026-06-08 07:44:30.551880 | controller-1 | RUNNING HANDLER [vexxhost.kubernetes.kubelet : Reload systemd] *****************
2026-06-08 07:44:30.551884 | controller-1 | Monday 08 June 2026  07:44:30 +0000 (0:00:00.901)       0:01:08.381 ***********
2026-06-08 07:44:32.473548 | controller-1 | ok: [controller-3]
2026-06-08 07:44:32.473732 | controller-1 |
2026-06-08 07:44:32.473905 | controller-1 | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-06-08 07:44:32.474083 | controller-1 | Monday 08 June 2026  07:44:32 +0000 (0:00:01.925)       0:01:10.306 ***********
2026-06-08 07:44:33.267315 | controller-1 | changed: [controller-3]
2026-06-08 07:44:33.267364 | controller-1 |
2026-06-08 07:44:33.267446 | controller-1 | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the "kubeadm-config" ConfigMap] ***
2026-06-08 07:44:33.267541 | controller-1 | Monday 08 June 2026  07:44:33 +0000 (0:00:00.794)       0:01:11.100 ***********
2026-06-08 07:44:33.938895 | controller-1 | [ERROR]: Task failed: Module failed: Failed to import the required Python library (kubernetes) on np0000178857's Python /usr/bin/python3.13. Please read the module documentation and install it in the appropriate location. If the required library is installed, but Ansible is using the wrong Python interpreter, please consult the documentation on ansible_python_interpreter
2026-06-08 07:44:33.938933 | controller-1 | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kubernetes_upgrade_check/tasks/main.yml:16:3
2026-06-08 07:44:33.938943 | controller-1 |
2026-06-08 07:44:33.938952 | controller-1 | 14
2026-06-08 07:44:33.938960 | controller-1 | 15 ---
2026-06-08 07:44:33.938968 | controller-1 | 16 - name: Retrieve the "kubeadm-config" ConfigMap
2026-06-08 07:44:33.938975 | controller-1 |      ^ column 3
2026-06-08 07:44:33.938983 | controller-1 |
2026-06-08 07:44:33.938991 | controller-1 | fatal: [controller-3]: FAILED! => {"changed": false, "msg": "Failed to import the required Python library (kubernetes) on np0000178857's Python /usr/bin/python3.13. Please read the module documentation and install it in the appropriate location. If the required library is installed, but Ansible is using the wrong Python interpreter, please consult the documentation on ansible_python_interpreter"}
2026-06-08 07:44:33.948731 | controller-1 | ...ignoring
2026-06-08 07:44:33.948874 | controller-1 |
2026-06-08 07:44:33.949002 | controller-1 | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Parse the ClusterConfiguration] ***
2026-06-08 07:44:33.949119 | controller-1 | Monday 08 June 2026  07:44:33 +0000 (0:00:00.678)       0:01:11.779 ***********
2026-06-08 07:44:33.983832 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:33.983934 | controller-1 |
2026-06-08 07:44:33.984074 | controller-1 | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the current Kubernetes version] ***
2026-06-08 07:44:33.984197 | controller-1 | Monday 08 June 2026  07:44:33 +0000 (0:00:00.037)       0:01:11.816 ***********
2026-06-08 07:44:34.025670 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:34.025711 | controller-1 |
2026-06-08 07:44:34.025721 | controller-1 | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Extract major, minor, and patch versions] ***
2026-06-08 07:44:34.025730 | controller-1 | Monday 08 June 2026  07:44:34 +0000 (0:00:00.039)       0:01:11.856 ***********
2026-06-08 07:44:34.060040 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:34.060134 | controller-1 |
2026-06-08 07:44:34.060312 | controller-1 | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Fail if we're jumping more than one minor version] ***
2026-06-08 07:44:34.060450 | controller-1 | Monday 08 June 2026  07:44:34 +0000 (0:00:00.036)       0:01:11.893 ***********
2026-06-08 07:44:34.100994 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:34.101087 | controller-1 |
2026-06-08 07:44:34.101382 | controller-1 | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Set fact if we need to upgrade] ***
2026-06-08 07:44:34.101404 | controller-1 | Monday 08 June 2026  07:44:34 +0000 (0:00:00.039)       0:01:11.932 ***********
2026-06-08 07:44:34.148134 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:34.148217 | controller-1 |
2026-06-08 07:44:34.148302 | controller-1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-08 07:44:34.148414 | controller-1 | Monday 08 June 2026  07:44:34 +0000 (0:00:00.047)       0:01:11.979 ***********
2026-06-08 07:44:34.460847 | controller-1 | ok: [controller-3]
2026-06-08 07:44:34.460936 | controller-1 |
2026-06-08 07:44:34.460947 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:44:34.461069 | controller-1 | Monday 08 June 2026  07:44:34 +0000 (0:00:00.312)       0:01:12.291 ***********
2026-06-08 07:44:34.507001 | controller-1 | ok: [controller-3] => {
2026-06-08 07:44:34.507093 | controller-1 |     "msg": "https://dl.k8s.io/release/v1.33.4/bin/linux/amd64/kubeadm"
2026-06-08 07:44:34.507106 | controller-1 | }
2026-06-08 07:44:34.507541 | controller-1 |
2026-06-08 07:44:34.507571 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:44:34.507578 | controller-1 | Monday 08 June 2026  07:44:34 +0000 (0:00:00.048)       0:01:12.340 ***********
2026-06-08 07:44:35.580475 | controller-1 | changed: [controller-3]
2026-06-08 07:44:35.580535 | controller-1 |
2026-06-08 07:44:35.580638 | controller-1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-08 07:44:35.580835 | controller-1 | Monday 08 June 2026  07:44:35 +0000 (0:00:01.073)       0:01:13.413 ***********
2026-06-08 07:44:35.621341 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:35.621366 | controller-1 |
2026-06-08 07:44:35.621371 | controller-1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-08 07:44:35.621375 | controller-1 | Monday 08 June 2026  07:44:35 +0000 (0:00:00.040)       0:01:13.454 ***********
2026-06-08 07:44:35.933045 | controller-1 | ok: [controller-3]
2026-06-08 07:44:35.933107 | controller-1 |
2026-06-08 07:44:35.933121 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:44:35.933254 | controller-1 | Monday 08 June 2026  07:44:35 +0000 (0:00:00.310)       0:01:13.764 ***********
2026-06-08 07:44:35.985215 | controller-1 | ok: [controller-3] => {
2026-06-08 07:44:35.985265 | controller-1 |     "msg": "https://dl.k8s.io/release/v1.33.4/bin/linux/amd64/kubectl"
2026-06-08 07:44:35.985345 | controller-1 | }
2026-06-08 07:44:35.985442 | controller-1 |
2026-06-08 07:44:35.985565 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:44:35.985662 | controller-1 | Monday 08 June 2026  07:44:35 +0000 (0:00:00.053)       0:01:13.818 ***********
2026-06-08 07:44:36.820064 | controller-1 | changed: [controller-3]
2026-06-08 07:44:36.820103 | controller-1 |
2026-06-08 07:44:36.820799 | controller-1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-08 07:44:36.820871 | controller-1 | Monday 08 June 2026  07:44:36 +0000 (0:00:00.834)       0:01:14.653 ***********
2026-06-08 07:44:36.873114 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:36.873188 | controller-1 |
2026-06-08 07:44:36.873210 | controller-1 | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-06-08 07:44:36.873276 | controller-1 | Monday 08 June 2026  07:44:36 +0000 (0:00:00.051)       0:01:14.704 ***********
2026-06-08 07:44:36.907178 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:36.907306 | controller-1 |
2026-06-08 07:44:36.907488 | controller-1 | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-06-08 07:44:36.907608 | controller-1 | Monday 08 June 2026  07:44:36 +0000 (0:00:00.035)       0:01:14.739 ***********
2026-06-08 07:44:36.945649 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:36.945734 | controller-1 |
2026-06-08 07:44:36.946048 | controller-1 | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-06-08 07:44:36.946084 | controller-1 | Monday 08 June 2026  07:44:36 +0000 (0:00:00.038)       0:01:14.778 ***********
2026-06-08 07:44:36.980680 | controller-1 | skipping: [controller-3]
2026-06-08 07:44:36.984648 | controller-1 |
2026-06-08 07:44:36.984675 | controller-1 | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-06-08 07:44:36.984681 | controller-1 | Monday 08 June 2026  07:44:36 +0000 (0:00:00.035)       0:01:14.813 ***********
2026-06-08 07:44:38.021044 | controller-1 | ok: [controller-3]
2026-06-08 07:44:38.021096 | controller-1 |
2026-06-08 07:44:38.021191 | controller-1 | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-06-08 07:44:38.021285 | controller-1 | Monday 08 June 2026  07:44:38 +0000 (0:00:01.038)       0:01:15.852 ***********
2026-06-08 07:44:38.702501 | controller-1 | ok: [controller-3]
2026-06-08 07:44:38.702559 | controller-1 |
2026-06-08 07:44:38.702766 | controller-1 | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-06-08 07:44:38.702797 | controller-1 | Monday 08 June 2026  07:44:38 +0000 (0:00:00.682)       0:01:16.535 ***********
2026-06-08 07:44:40.137531 | controller-1 | ok: [controller-3] => (item={'path': '/etc/containerd'})
2026-06-08 07:44:40.137600 | controller-1 | ok: [controller-3] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-06-08 07:44:40.137613 | controller-1 | ok: [controller-3] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-06-08 07:44:40.137720 | controller-1 | ok: [controller-3] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-06-08 07:44:40.137817 | controller-1 | ok: [controller-3] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-06-08 07:44:40.137894 | controller-1 |
2026-06-08 07:44:40.138000 | controller-1 | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-06-08 07:44:40.138087 | controller-1 | Monday 08 June 2026  07:44:40 +0000 (0:00:01.432)       0:01:17.968 ***********
2026-06-08 07:44:40.924846 | controller-1 | ok: [controller-3]
2026-06-08 07:44:40.924902 | controller-1 |
2026-06-08 07:44:40.924995 | controller-1 | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-06-08 07:44:40.928642 | controller-1 | Monday 08 June 2026  07:44:40 +0000 (0:00:00.783)       0:01:18.751 ***********
2026-06-08 07:44:40.928668 | controller-1 |
2026-06-08 07:44:40.928673 | controller-1 | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-06-08 07:44:40.928677 | controller-1 | Monday 08 June 2026  07:44:40 +0000 (0:00:00.006)       0:01:18.758 ***********
2026-06-08 07:44:41.423577 | controller-1 | ok: [controller-3]
2026-06-08 07:44:41.423639 | controller-1 |
2026-06-08 07:44:41.423649 | controller-1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-08 07:44:41.423657 | controller-1 | Monday 08 June 2026  07:44:41 +0000 (0:00:00.494)       0:01:19.252 ***********
2026-06-08 07:44:41.744479 | controller-1 | ok: [controller-3]
2026-06-08 07:44:41.744535 | controller-1 |
2026-06-08 07:44:41.744555 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:44:41.744712 | controller-1 | Monday 08 June 2026  07:44:41 +0000 (0:00:00.324)       0:01:19.577 ***********
2026-06-08 07:44:41.829393 | controller-1 | ok: [controller-3] => {
2026-06-08 07:44:41.829414 | controller-1 |     "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/crictl-v1.35.0-linux-amd64.tar.gz"
2026-06-08 07:44:41.829418 | controller-1 | }
2026-06-08 07:44:41.829422 | controller-1 |
2026-06-08 07:44:41.829426 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:44:41.829429 | controller-1 | Monday 08 June 2026  07:44:41 +0000 (0:00:00.082)       0:01:19.660 ***********
2026-06-08 07:44:42.511684 | controller-1 | changed: [controller-3]
2026-06-08 07:44:42.511703 | controller-1 |
2026-06-08 07:44:42.511708 | controller-1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-08 07:44:42.511712 | controller-1 | Monday 08 June 2026  07:44:42 +0000 (0:00:00.684)       0:01:20.344 ***********
2026-06-08 07:44:44.181457 | controller-1 | changed: [controller-3]
2026-06-08 07:44:44.184558 | controller-1 |
2026-06-08 07:44:44.184568 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:44:44.184572 | controller-1 | Monday 08 June 2026  07:44:44 +0000 (0:00:01.670)       0:01:22.014 ***********
2026-06-08 07:44:44.252808 | controller-1 | ok: [controller-3] => {
2026-06-08 07:44:44.252966 | controller-1 |     "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/critest-v1.35.0-linux-amd64.tar.gz"
2026-06-08 07:44:44.253118 | controller-1 | }
2026-06-08 07:44:44.253235 | controller-1 |
2026-06-08 07:44:44.253375 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:44:44.253502 | controller-1 | Monday 08 June 2026  07:44:44 +0000 (0:00:00.071)       0:01:22.086 ***********
2026-06-08 07:44:44.892721 | controller-1 | changed: [controller-3]
2026-06-08 07:44:44.892778 | controller-1 |
2026-06-08 07:44:44.892938 | controller-1 | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-06-08 07:44:44.892959 | controller-1 | Monday 08 June 2026  07:44:44 +0000 (0:00:00.640)       0:01:22.726 ***********
2026-06-08 07:44:46.595413 | controller-1 | changed: [controller-3]
2026-06-08 07:44:46.595470 | controller-1 |
2026-06-08 07:44:46.595513 | controller-1 | TASK [vexxhost.containers.cri_tools : Create crictl config] ********************
2026-06-08 07:44:46.595631 | controller-1 | Monday 08 June 2026  07:44:46 +0000 (0:00:01.700)       0:01:24.427 ***********
2026-06-08 07:44:47.270404 | controller-1 | changed: [controller-3]
2026-06-08 07:44:47.270499 | controller-1 |
2026-06-08 07:44:47.270510 | controller-1 | TASK [vexxhost.containers.directory : Create directory (/opt/cni/bin)] *********
2026-06-08 07:44:47.270523 | controller-1 | Monday 08 June 2026  07:44:47 +0000 (0:00:00.676)       0:01:25.103 ***********
2026-06-08 07:44:47.582641 | controller-1 | changed: [controller-3]
2026-06-08 07:44:47.582705 | controller-1 |
2026-06-08 07:44:47.582719 | controller-1 | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-06-08 07:44:47.582819 | controller-1 | Monday 08 June 2026  07:44:47 +0000 (0:00:00.311)       0:01:25.415 ***********
2026-06-08 07:44:47.885004 | controller-1 | ok: [controller-3]
2026-06-08 07:44:47.885023 | controller-1 |
2026-06-08 07:44:47.885028 | controller-1 | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-06-08 07:44:47.885032 | controller-1 | Monday 08 June 2026  07:44:47 +0000 (0:00:00.302)       0:01:25.718 ***********
2026-06-08 07:44:47.965085 | controller-1 | ok: [controller-3] => {
2026-06-08 07:44:47.965143 | controller-1 |     "msg": "https://github.com/containernetworking/plugins/releases/download/v1.9.1/cni-plugins-linux-amd64-v1.9.1.tgz"
2026-06-08 07:44:47.965239 | controller-1 | }
2026-06-08 07:44:47.965318 | controller-1 |
2026-06-08 07:44:47.965413 | controller-1 | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-06-08 07:44:47.965541 | controller-1 | Monday 08 June 2026  07:44:47 +0000 (0:00:00.076)       0:01:25.794 ***********
2026-06-08 07:45:15.361368 | controller-1 | fatal: [controller-3]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false}
2026-06-08 07:45:15.364994 | controller-1 | FAILED - RETRYING: [controller-3]: Download item (4 retries left).
2026-06-08 07:45:15.365114 | controller-1 | FAILED - RETRYING: [controller-3]: Download item (3 retries left).
2026-06-08 07:45:15.365244 | controller-1 | FAILED - RETRYING: [controller-3]: Download item (2 retries left).
2026-06-08 07:45:15.365368 | controller-1 | FAILED - RETRYING: [controller-3]: Download item (1 retries left).
2026-06-08 07:45:15.365488 | controller-1 |
2026-06-08 07:45:15.365622 | controller-1 | PLAY RECAP *********************************************************************
2026-06-08 07:45:15.365734 | controller-1 | controller-1               : ok=20   changed=3    unreachable=0    failed=1    skipped=2    rescued=0    ignored=1
2026-06-08 07:45:15.365860 | controller-1 | controller-2               : ok=19   changed=3    unreachable=0    failed=1    skipped=3    rescued=0    ignored=1
2026-06-08 07:45:15.365978 | controller-1 | controller-3               : ok=51   changed=19   unreachable=0    failed=1    skipped=16   rescued=0    ignored=2
2026-06-08 07:45:15.366061 | controller-1 |
2026-06-08 07:45:15.368302 | controller-1 |
2026-06-08 07:45:15.368326 | controller-1 | TASKS RECAP ********************************************************************
2026-06-08 07:45:15.368330 | controller-1 | Monday 08 June 2026  07:45:15 +0000 (0:00:27.402)       0:01:53.197 ***********
2026-06-08 07:45:15.368342 | controller-1 | ===============================================================================
2026-06-08 07:45:15.368345 | controller-1 | vexxhost.containers.download_artifact : Download item ------------------ 32.35s
2026-06-08 07:45:15.368348 | controller-1 | vexxhost.containers.download_artifact : Download item ------------------ 27.40s
2026-06-08 07:45:15.368351 | controller-1 | vexxhost.containers.download_artifact : Download item ------------------- 8.54s
2026-06-08 07:45:15.368355 | controller-1 | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.72s
2026-06-08 07:45:15.368358 | controller-1 | vexxhost.containers.download_artifact : Extract archive ----------------- 3.09s
2026-06-08 07:45:15.368361 | controller-1 | Gathering Facts --------------------------------------------------------- 2.23s
2026-06-08 07:45:15.368364 | controller-1 | vexxhost.kubernetes.kubelet : Reload systemd ---------------------------- 1.93s
2026-06-08 07:45:15.368367 | controller-1 | Gathering Facts --------------------------------------------------------- 1.86s
2026-06-08 07:45:15.368370 | controller-1 | Install Debian packages ------------------------------------------------- 1.74s
2026-06-08 07:45:15.368374 | controller-1 | vexxhost.containers.download_artifact : Extract archive ----------------- 1.70s
2026-06-08 07:45:15.368377 | controller-1 | vexxhost.containers.download_artifact : Extract archive ----------------- 1.67s
2026-06-08 07:45:15.368380 | controller-1 | vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack ---------------- 1.53s
2026-06-08 07:45:15.368383 | controller-1 | vexxhost.containers.containerd : Create folders for configuration ------- 1.48s
2026-06-08 07:45:15.368386 | controller-1 | vexxhost.containers.containerd : Create folders for configuration ------- 1.43s
2026-06-08 07:45:15.368396 | controller-1 | vexxhost.containers.download_artifact : Download item ------------------- 1.07s
2026-06-08 07:45:15.368400 | controller-1 | vexxhost.containers.package : Update state for tar ---------------------- 1.06s
2026-06-08 07:45:15.368403 | controller-1 | vexxhost.containers.containerd : Install AppArmor packages -------------- 1.04s
2026-06-08 07:45:15.368406 | controller-1 | vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443 ---- 0.99s
2026-06-08 07:45:15.368409 | controller-1 | vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest --------------- 0.97s
2026-06-08 07:45:15.368412 | controller-1 | vexxhost.containers.containerd : Restart containerd --------------------- 0.90s
2026-06-08 07:45:15.515154 | controller-1 | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.Bs5j.cluster-upgrade/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/cluster-upgrade/prepare.yml
2026-06-08 07:45:15.515346 | controller-1 | ERROR    [cluster-upgrade > prepare] Executed: Failed
2026-06-08 07:45:15.515461 | controller-1 | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.Bs5j.cluster-upgrade/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/cluster-upgrade/prepare.yml
2026-06-08 07:45:26.035426 | controller-1 | ERROR
2026-06-08 07:45:26.035664 | controller-1 | {
2026-06-08 07:45:26.035708 | controller-1 |   "delta": "0:02:14.700782",
2026-06-08 07:45:26.035740 | controller-1 |   "end": "2026-06-08 07:45:15.602079",
2026-06-08 07:45:26.035768 | controller-1 |   "msg": "non-zero return code",
2026-06-08 07:45:26.035796 | controller-1 |   "rc": 2,
2026-06-08 07:45:26.035828 | controller-1 |   "start": "2026-06-08 07:43:00.901297"
2026-06-08 07:45:26.035856 | controller-1 | }
failure
2026-06-08 07:45:26.044150 | 
2026-06-08 07:45:26.044204 | PLAY RECAP
2026-06-08 07:45:26.044252 | controller-1 | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:45:26.044273 | 
2026-06-08 07:45:26.169092 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-06-08 07:45:26.172624 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-06-08 07:45:26.795569 | 
2026-06-08 07:45:26.795702 | PLAY [all]
2026-06-08 07:45:26.806824 | 
2026-06-08 07:45:26.806902 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-06-08 07:45:27.202064 | controller-1 | changed
2026-06-08 07:45:27.373626 | controller-3 | changed
2026-06-08 07:45:27.377168 | controller-2 | changed
2026-06-08 07:45:27.382509 | 
2026-06-08 07:45:27.382621 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-06-08 07:45:27.821834 | controller-1 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:27.821987 | controller-1 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:27.828364 | controller-1 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.830669 | controller-1 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.833326 | controller-1 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.833605 | controller-1 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.834359 | controller-1 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.835602 | controller-1 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.838782 | controller-1 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.838797 | controller-1 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.839872 | controller-1 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.840677 | controller-1 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.812743 | controller-3 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:27.812845 | controller-3 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:27.821769 | controller-3 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.824407 | controller-3 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.874827 | controller-3 | E0608 07:45:27.874645    2714 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.876369 | controller-3 | E0608 07:45:27.876295    2714 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.876946 | controller-3 | E0608 07:45:27.876834    2716 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.878436 | controller-3 | E0608 07:45:27.878273    2714 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.878549 | controller-3 | E0608 07:45:27.878503    2716 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.880118 | controller-3 | E0608 07:45:27.880073    2714 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.880814 | controller-3 | E0608 07:45:27.880771    2716 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.881884 | controller-3 | E0608 07:45:27.881844    2714 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.882401 | controller-3 | E0608 07:45:27.882368    2716 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.883029 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:27.884086 | controller-3 | E0608 07:45:27.884044    2716 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.885222 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:27.897716 | controller-3 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.897741 | controller-3 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.833848 | controller-2 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:27.833990 | controller-2 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:27.840522 | controller-2 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.842022 | controller-2 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.843108 | controller-2 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.844129 | controller-2 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.847597 | controller-2 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.848418 | controller-2 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.849306 | controller-2 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.851456 | controller-2 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.853258 | controller-2 | environment: line 1: kubectl: command not found
2026-06-08 07:45:27.855599 | controller-2 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:27.951945 | controller-1 | ok: Runtime: 0:00:00.032467
2026-06-08 07:45:27.959532 | controller-2 | ok: Runtime: 0:00:00.037530
2026-06-08 07:45:28.083740 | controller-3 | ok: Runtime: 0:00:00.231855
2026-06-08 07:45:28.088304 | 
2026-06-08 07:45:28.088370 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-06-08 07:45:28.326730 | controller-1 | changed
2026-06-08 07:45:28.331733 | controller-2 | changed
2026-06-08 07:45:28.336149 | controller-3 | changed
2026-06-08 07:45:28.339838 | 
2026-06-08 07:45:28.339931 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-06-08 07:45:27.942211 | controller-3 | E0608 07:45:27.942135    2743 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.943383 | controller-3 | E0608 07:45:27.943309    2741 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.944194 | controller-3 | E0608 07:45:27.944133    2743 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.945318 | controller-3 | E0608 07:45:27.945271    2741 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.945889 | controller-3 | E0608 07:45:27.945855    2743 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.946870 | controller-3 | E0608 07:45:27.946840    2741 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.947488 | controller-3 | E0608 07:45:27.947460    2743 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.948508 | controller-3 | E0608 07:45:27.948478    2741 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.948956 | controller-3 | E0608 07:45:27.948917    2743 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.950071 | controller-3 | E0608 07:45:27.950041    2741 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:27.950168 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:27.951231 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:27.962352 | controller-3 | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-06-08 07:45:28.013702 | controller-3 | E0608 07:45:28.013469    2762 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.015489 | controller-3 | E0608 07:45:28.015427    2762 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.017028 | controller-3 | E0608 07:45:28.016982    2762 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.018775 | controller-3 | E0608 07:45:28.018720    2762 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.021022 | controller-3 | E0608 07:45:28.020940    2762 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.022183 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:28.613264 | controller-1 | environment: line 5: kubectl: command not found
2026-06-08 07:45:28.614033 | controller-1 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.614728 | controller-1 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.615182 | controller-1 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.666976 | controller-3 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.667406 | controller-3 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.667633 | controller-3 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.717807 | controller-3 | E0608 07:45:28.717672    2794 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.719789 | controller-3 | E0608 07:45:28.719743    2794 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.722159 | controller-3 | E0608 07:45:28.722094    2794 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.724165 | controller-3 | E0608 07:45:28.724084    2794 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.726061 | controller-3 | E0608 07:45:28.725997    2794 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:28.727255 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:28.684032 | controller-2 | environment: line 5: kubectl: command not found
2026-06-08 07:45:28.685320 | controller-2 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.685464 | controller-2 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.685826 | controller-2 | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-06-08 07:45:28.965733 | controller-1 | ok: Runtime: 0:00:00.011221
2026-06-08 07:45:28.972206 | controller-2 | ok: Runtime: 0:00:00.013192
2026-06-08 07:45:28.979512 | controller-3 | ok: Runtime: 0:00:00.079331
2026-06-08 07:45:28.986423 | 
2026-06-08 07:45:28.986515 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-06-08 07:45:29.585905 | controller-1 | changed:
2026-06-08 07:45:29.586284 | controller-1 | created directory /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/logs/controller-1
2026-06-08 07:45:29.586338 | controller-1 | cd+++++++++ objects/
2026-06-08 07:45:29.586372 | controller-1 | cd+++++++++ objects/cluster/
2026-06-08 07:45:29.586403 | controller-1 | cd+++++++++ objects/namespaced/
2026-06-08 07:45:29.632667 | controller-3 | changed:
2026-06-08 07:45:29.632788 | controller-3 | created directory /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/logs/controller-3
2026-06-08 07:45:29.632824 | controller-3 | cd+++++++++ objects/
2026-06-08 07:45:29.632853 | controller-3 | cd+++++++++ objects/cluster/
2026-06-08 07:45:29.632881 | controller-3 | cd+++++++++ objects/namespaced/
2026-06-08 07:45:29.691765 | controller-2 | changed:
2026-06-08 07:45:29.691837 | controller-2 | created directory /var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/logs/controller-2
2026-06-08 07:45:29.691872 | controller-2 | cd+++++++++ objects/
2026-06-08 07:45:29.691913 | controller-2 | cd+++++++++ objects/cluster/
2026-06-08 07:45:29.691953 | controller-2 | cd+++++++++ objects/namespaced/
2026-06-08 07:45:29.706297 | 
2026-06-08 07:45:29.706369 | TASK [gather-pod-logs : creating directory for pod logs]
2026-06-08 07:45:29.940391 | controller-1 | changed
2026-06-08 07:45:29.957375 | controller-3 | changed
2026-06-08 07:45:29.973633 | controller-2 | changed
2026-06-08 07:45:29.982703 | 
2026-06-08 07:45:29.982779 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-06-08 07:45:30.236106 | controller-2 | changed
2026-06-08 07:45:30.239730 | controller-1 | changed
2026-06-08 07:45:30.242866 | controller-3 | changed
2026-06-08 07:45:30.246631 | 
2026-06-08 07:45:30.246707 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-06-08 07:45:30.518763 | controller-1 | environment: line 3: kubectl: command not found
2026-06-08 07:45:30.580320 | controller-3 | E0608 07:45:30.580160    2847 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:30.582375 | controller-3 | E0608 07:45:30.582299    2847 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:30.584260 | controller-3 | E0608 07:45:30.584206    2847 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:30.588101 | controller-3 | E0608 07:45:30.588040    2847 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:30.589784 | controller-3 | E0608 07:45:30.589736    2847 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:30.591031 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:30.538285 | controller-2 | environment: line 3: kubectl: command not found
2026-06-08 07:45:30.804451 | controller-1 | ok: Runtime: 0:00:00.010596
2026-06-08 07:45:30.812378 | controller-2 | ok: Runtime: 0:00:00.013668
2026-06-08 07:45:30.818087 | controller-3 | ok: Runtime: 0:00:00.079560
2026-06-08 07:45:30.823014 | 
2026-06-08 07:45:30.823080 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-06-08 07:45:31.326430 | controller-1 | changed:
2026-06-08 07:45:31.326777 | controller-1 | cd+++++++++ pod-logs/
2026-06-08 07:45:31.326825 | controller-1 | cd+++++++++ pod-logs/failed-pods/
2026-06-08 07:45:31.357441 | controller-2 | changed:
2026-06-08 07:45:31.357566 | controller-2 | cd+++++++++ pod-logs/
2026-06-08 07:45:31.357608 | controller-2 | cd+++++++++ pod-logs/failed-pods/
2026-06-08 07:45:31.362893 | controller-3 | changed:
2026-06-08 07:45:31.362945 | controller-3 | cd+++++++++ pod-logs/
2026-06-08 07:45:31.362971 | controller-3 | cd+++++++++ pod-logs/failed-pods/
2026-06-08 07:45:31.378712 | 
2026-06-08 07:45:31.378872 | LOOP [helm-release-status : creating directory for helm release status]
2026-06-08 07:45:31.616277 | controller-1 | changed: "values"
2026-06-08 07:45:31.634318 | controller-2 | changed: "values"
2026-06-08 07:45:31.638921 | controller-3 | changed: "values"
2026-06-08 07:45:31.833603 | controller-1 | changed: "releases"
2026-06-08 07:45:31.838503 | controller-2 | changed: "releases"
2026-06-08 07:45:31.841918 | controller-3 | changed: "releases"
2026-06-08 07:45:31.853596 | 
2026-06-08 07:45:31.853714 | TASK [helm-release-status : Gather get release status for helm charts]
2026-06-08 07:45:32.123712 | controller-1 | /bin/bash: line 3: kubectl: command not found
2026-06-08 07:45:32.179163 | controller-3 | E0608 07:45:32.178631    2896 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:32.181190 | controller-3 | E0608 07:45:32.181105    2896 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:32.182791 | controller-3 | E0608 07:45:32.182700    2896 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:32.184795 | controller-3 | E0608 07:45:32.184748    2896 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:32.186530 | controller-3 | E0608 07:45:32.186467    2896 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused"
2026-06-08 07:45:32.187828 | controller-3 | The connection to the server localhost:8080 was refused - did you specify the right host or port?
2026-06-08 07:45:32.151536 | controller-2 | /bin/bash: line 3: kubectl: command not found
2026-06-08 07:45:32.412384 | controller-1 | ok: Runtime: 0:00:00.008010
2026-06-08 07:45:32.420815 | controller-2 | ok: Runtime: 0:00:00.009795
2026-06-08 07:45:32.426750 | controller-3 | ok: Runtime: 0:00:00.074633
2026-06-08 07:45:32.430700 | 
2026-06-08 07:45:32.430765 | TASK [helm-release-status : Downloads logs to executor]
2026-06-08 07:45:32.934655 | controller-3 | changed:
2026-06-08 07:45:32.934982 | controller-3 | cd+++++++++ helm/
2026-06-08 07:45:32.935024 | controller-3 | cd+++++++++ helm/releases/
2026-06-08 07:45:32.935056 | controller-3 | cd+++++++++ helm/values/
2026-06-08 07:45:32.940177 | controller-2 | changed:
2026-06-08 07:45:32.940251 | controller-2 | cd+++++++++ helm/
2026-06-08 07:45:32.940286 | controller-2 | cd+++++++++ helm/releases/
2026-06-08 07:45:32.940317 | controller-2 | cd+++++++++ helm/values/
2026-06-08 07:45:32.957460 | controller-1 | changed:
2026-06-08 07:45:32.957617 | controller-1 | cd+++++++++ helm/
2026-06-08 07:45:32.957676 | controller-1 | cd+++++++++ helm/releases/
2026-06-08 07:45:32.957724 | controller-1 | cd+++++++++ helm/values/
2026-06-08 07:45:32.971869 | 
2026-06-08 07:45:32.972000 | PLAY RECAP
2026-06-08 07:45:32.972052 | controller-1 | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:45:32.972080 | controller-2 | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:45:32.972106 | controller-3 | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-08 07:45:32.972125 | 
2026-06-08 07:45:33.149870 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main]
2026-06-08 07:45:33.156562 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-08 07:45:33.818515 | 
2026-06-08 07:45:33.819250 | PLAY [all]
2026-06-08 07:45:33.829874 | 
2026-06-08 07:45:33.829947 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-08 07:45:33.886237 | controller-1 | ok
2026-06-08 07:45:33.890519 | controller-2 | ok
2026-06-08 07:45:33.894439 | controller-3 | ok
2026-06-08 07:45:33.897791 | 
2026-06-08 07:45:33.897883 | TASK [fetch-output : Set log path for single node]
2026-06-08 07:45:33.929096 | controller-2 | skipping: Conditional result was False
2026-06-08 07:45:33.940478 | controller-1 | skipping: Conditional result was False
2026-06-08 07:45:33.940884 | controller-3 | skipping: Conditional result was False
2026-06-08 07:45:33.947433 | 
2026-06-08 07:45:33.947526 | LOOP [fetch-output : Ensure local output dirs]
2026-06-08 07:45:34.339299 | controller-3 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/logs/controller-3"
2026-06-08 07:45:34.341499 | controller-2 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/logs/controller-2"
2026-06-08 07:45:34.345248 | controller-1 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/logs/controller-1"
2026-06-08 07:45:34.552258 | controller-3 -> localhost | changed: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/artifacts"
2026-06-08 07:45:34.556522 | controller-2 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/artifacts"
2026-06-08 07:45:34.577710 | controller-1 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/artifacts"
2026-06-08 07:45:34.754360 | controller-3 -> localhost | changed: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/docs"
2026-06-08 07:45:34.790957 | controller-1 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/docs"
2026-06-08 07:45:34.791175 | controller-1 -> localhost | changed: All items complete
2026-06-08 07:45:34.791236 | 
2026-06-08 07:45:34.796103 | controller-2 -> localhost | ok: "/var/lib/zuul/builds/97b3664d636442c1aca4179efa909880/work/docs"
2026-06-08 07:45:34.820774 | 
2026-06-08 07:45:34.821021 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-08 07:45:35.452363 | controller-3 | changed: .d..t...... ./
2026-06-08 07:45:35.453152 | controller-3 | ok: All items complete
2026-06-08 07:45:35.453204 | 
2026-06-08 07:45:35.460707 | controller-1 | changed: .d..t...... ./
2026-06-08 07:45:35.467520 | controller-2 | changed: .d..t...... ./
2026-06-08 07:45:35.888316 | controller-3 | changed: .d..t...... ./
2026-06-08 07:45:35.907976 | controller-1 | ok
2026-06-08 07:45:35.913137 | controller-2 | ok
2026-06-08 07:45:36.336846 | controller-3 | changed: .d..t...... ./
2026-06-08 07:45:36.370559 | controller-1 | ok
2026-06-08 07:45:36.402406 | controller-2 | ok
2026-06-08 07:45:36.402590 | controller-2 | changed: All items complete
2026-06-08 07:45:36.402627 | 
2026-06-08 07:45:36.430405 | 
2026-06-08 07:45:36.430573 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-08 07:45:36.850441 | controller-1 -> localhost | ok: Item: artifacts Runtime: 0:00:00.008426
2026-06-08 07:45:37.105153 | controller-1 -> localhost | ok: Item: docs Runtime: 0:00:00.006579
2026-06-08 07:45:37.133532 | 
2026-06-08 07:45:37.133680 | PLAY [all]
2026-06-08 07:45:37.139130 | 
2026-06-08 07:45:37.139210 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-06-08 07:45:37.630065 | controller-1 | changed
2026-06-08 07:45:37.779753 | controller-3 | changed
2026-06-08 07:45:37.807221 | controller-2 | changed
2026-06-08 07:45:37.820937 | 
2026-06-08 07:45:37.821054 | PLAY RECAP
2026-06-08 07:45:37.821102 | controller-1 | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:45:37.821131 | controller-2 | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:45:37.821156 | controller-3 | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-06-08 07:45:37.821175 | 
2026-06-08 07:45:37.954240 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-06-08 07:45:37.957555 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-06-08 07:45:38.596755 | 
2026-06-08 07:45:38.596904 | PLAY [localhost]
2026-06-08 07:45:38.608569 | 
2026-06-08 07:45:38.608674 | TASK [Generate Zuul manifest]
2026-06-08 07:45:38.630303 | localhost | ok
2026-06-08 07:45:38.647244 | 
2026-06-08 07:45:38.647372 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-08 07:45:39.043731 | localhost | changed
2026-06-08 07:45:39.055172 | 
2026-06-08 07:45:39.055334 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-08 07:45:39.084697 | localhost | ok
2026-06-08 07:45:39.091908 | 
2026-06-08 07:45:39.091993 | TASK [Upload logs]
2026-06-08 07:45:39.111527 | localhost | ok
2026-06-08 07:45:39.176265 | 
2026-06-08 07:45:39.176426 | TASK [Set zuul-log-path fact]
2026-06-08 07:45:39.196002 | localhost | ok
2026-06-08 07:45:39.207340 | 
2026-06-08 07:45:39.207412 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-08 07:45:39.236380 | localhost | ok
2026-06-08 07:45:39.243177 | 
2026-06-08 07:45:39.243251 | TASK [upload-logs : Create log directories]
2026-06-08 07:45:39.690807 | localhost | changed
2026-06-08 07:45:39.751978 | 
2026-06-08 07:45:39.752165 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-08 07:45:40.179201 | localhost -> localhost | ok: Runtime: 0:00:00.006017
2026-06-08 07:45:40.184387 | 
2026-06-08 07:45:40.184480 | TASK [upload-logs : Upload logs to log server]
2026-06-08 07:45:40.647663 | localhost | Output suppressed because no_log was given
2026-06-08 07:45:40.651698 | 
2026-06-08 07:45:40.651769 | LOOP [upload-logs : Compress console log and json output]
2026-06-08 07:45:40.696835 | localhost | skipping: Conditional result was False
2026-06-08 07:45:40.704631 | localhost | skipping: Conditional result was False
2026-06-08 07:45:40.717941 | 
2026-06-08 07:45:40.718191 | LOOP [upload-logs : Upload compressed console log and json output]
2026-06-08 07:45:40.770712 | localhost | skipping: Conditional result was False
2026-06-08 07:45:40.771153 | 
2026-06-08 07:45:40.775316 | localhost | skipping: Conditional result was False
2026-06-08 07:45:40.791904 | 
2026-06-08 07:45:40.792176 | LOOP [upload-logs : Upload console log and json output]