2026-03-31 20:13:02.730037 | Job console starting 2026-03-31 20:13:02.753770 | Updating git repos 2026-03-31 20:13:02.815772 | Cloning repos into workspace 2026-03-31 20:13:02.919373 | Restoring repo states 2026-03-31 20:13:02.935175 | Merging changes 2026-03-31 20:13:04.105746 | Checking out repos 2026-03-31 20:13:04.191910 | Preparing playbooks 2026-03-31 20:13:07.717649 | Running Ansible setup 2026-03-31 20:13:11.963309 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 20:13:12.599870 | 2026-03-31 20:13:12.653346 | PLAY [localhost] 2026-03-31 20:13:12.673027 | 2026-03-31 20:13:12.673274 | TASK [Gathering Facts] 2026-03-31 20:13:13.658126 | localhost | ok 2026-03-31 20:13:13.669022 | 2026-03-31 20:13:13.669140 | TASK [Setup log path fact] 2026-03-31 20:13:13.690743 | localhost | ok 2026-03-31 20:13:13.702597 | 2026-03-31 20:13:13.702670 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 20:13:13.732447 | localhost | ok 2026-03-31 20:13:13.743601 | 2026-03-31 20:13:13.743837 | TASK [emit-job-header : Print job information] 2026-03-31 20:13:13.783666 | # Job Information 2026-03-31 20:13:13.783848 | Ansible Version: 2.16.16 2026-03-31 20:13:13.783891 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-03-31 20:13:13.783921 | Pipeline: check 2026-03-31 20:13:13.783948 | Executor: 0a8996d2b663 2026-03-31 20:13:13.783975 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3740 2026-03-31 20:13:13.784005 | Event ID: d7d37310-2d3d-11f1-90e8-0b14fb0d8e13 2026-03-31 20:13:13.788048 | 2026-03-31 20:13:13.788130 | LOOP [emit-job-header : Print node information] 2026-03-31 20:13:13.889805 | localhost | ok: 2026-03-31 20:13:13.897637 | localhost | # Node Information 2026-03-31 20:13:13.897716 | localhost | Inventory Hostname: instance 2026-03-31 20:13:13.897764 | localhost | Hostname: np0000161962 2026-03-31 20:13:13.897805 | localhost | Username: zuul 2026-03-31 20:13:13.897850 | localhost | Distro: Ubuntu 22.04 2026-03-31 20:13:13.897902 | localhost | Provider: yul1 2026-03-31 20:13:13.897955 | localhost | Region: ca-ymq-1 2026-03-31 20:13:13.898013 | localhost | Label: ubuntu-jammy 2026-03-31 20:13:13.898066 | localhost | Product Name: OpenStack Nova 2026-03-31 20:13:13.898136 | localhost | Interface IP: 199.19.213.112 2026-03-31 20:13:13.919300 | 2026-03-31 20:13:13.919580 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-31 20:13:14.320570 | localhost -> localhost | changed 2026-03-31 20:13:14.331549 | 2026-03-31 20:13:14.331661 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-31 20:13:15.140188 | localhost -> localhost | changed 2026-03-31 20:13:15.148977 | 2026-03-31 20:13:15.149046 | PLAY [all] 2026-03-31 20:13:15.157972 | 2026-03-31 20:13:15.158043 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-31 20:13:15.392338 | instance -> localhost | ok 2026-03-31 20:13:15.403398 | 2026-03-31 20:13:15.403503 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-31 20:13:15.437408 | instance | ok 2026-03-31 20:13:15.454214 | instance | included: /var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-31 20:13:15.459672 | 2026-03-31 20:13:15.459733 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-31 20:13:17.103633 | instance -> localhost | Generating public/private rsa key pair. 2026-03-31 20:13:17.103829 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/75c9303557e24925ba32ef1933c30123_id_rsa 2026-03-31 20:13:17.103868 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/75c9303557e24925ba32ef1933c30123_id_rsa.pub 2026-03-31 20:13:17.103892 | instance -> localhost | The key fingerprint is: 2026-03-31 20:13:17.103914 | instance -> localhost | SHA256:YIhx0D1f7dVPiO1rnpgMLW6kT18YE67mFA2wN8xubU4 zuul-build-sshkey 2026-03-31 20:13:17.103961 | instance -> localhost | The key's randomart image is: 2026-03-31 20:13:17.103989 | instance -> localhost | +---[RSA 3072]----+ 2026-03-31 20:13:17.104013 | instance -> localhost | | oo.. . . o o | 2026-03-31 20:13:17.104034 | instance -> localhost | | +..o =. o + o| 2026-03-31 20:13:17.104060 | instance -> localhost | | . . oo..*..o ..| 2026-03-31 20:13:17.104089 | instance -> localhost | | . ..o *... .| 2026-03-31 20:13:17.104111 | instance -> localhost | | S +.E . | 2026-03-31 20:13:17.104140 | instance -> localhost | | .+*.+o | 2026-03-31 20:13:17.104161 | instance -> localhost | | +=+o=.. | 2026-03-31 20:13:17.104362 | instance -> localhost | | .=o.+.o | 2026-03-31 20:13:17.104469 | instance -> localhost | | oo . | 2026-03-31 20:13:17.104510 | instance -> localhost | +----[SHA256]-----+ 2026-03-31 20:13:17.104569 | instance -> localhost | ok: Runtime: 0:00:01.099883 2026-03-31 20:13:17.109701 | 2026-03-31 20:13:17.109779 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-31 20:13:17.145066 | instance | ok 2026-03-31 20:13:17.157403 | instance | included: /var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-31 20:13:17.229444 | 2026-03-31 20:13:17.229578 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-31 20:13:17.254346 | instance | skipping: Conditional result was False 2026-03-31 20:13:17.264246 | 2026-03-31 20:13:17.264425 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-31 20:13:17.723578 | instance | changed 2026-03-31 20:13:17.730211 | 2026-03-31 20:13:17.730305 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-31 20:13:17.926799 | instance | ok 2026-03-31 20:13:17.934956 | 2026-03-31 20:13:17.935111 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-31 20:13:18.382032 | instance | changed 2026-03-31 20:13:18.390252 | 2026-03-31 20:13:18.390346 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-31 20:13:18.863543 | instance | changed 2026-03-31 20:13:18.904872 | 2026-03-31 20:13:18.905003 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-31 20:13:18.930074 | instance | skipping: Conditional result was False 2026-03-31 20:13:18.938529 | 2026-03-31 20:13:18.938623 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-31 20:13:19.297605 | instance -> localhost | changed 2026-03-31 20:13:19.312763 | 2026-03-31 20:13:19.312834 | TASK [add-build-sshkey : Add back temp key] 2026-03-31 20:13:19.631156 | instance -> localhost | Identity added: /var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/75c9303557e24925ba32ef1933c30123_id_rsa (zuul-build-sshkey) 2026-03-31 20:13:19.631435 | instance -> localhost | ok: Runtime: 0:00:00.016457 2026-03-31 20:13:19.638024 | 2026-03-31 20:13:19.638120 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-31 20:13:19.945283 | instance | ok 2026-03-31 20:13:19.951699 | 2026-03-31 20:13:19.951789 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-31 20:13:19.976944 | instance | skipping: Conditional result was False 2026-03-31 20:13:19.992812 | 2026-03-31 20:13:19.992899 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-31 20:13:20.310400 | instance | ok 2026-03-31 20:13:20.317857 | 2026-03-31 20:13:20.317925 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-31 20:13:22.022588 | instance | Output suppressed because no_log was given 2026-03-31 20:13:22.035475 | 2026-03-31 20:13:22.035548 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-31 20:13:22.219535 | instance | ok: "logs" 2026-03-31 20:13:22.219841 | instance | ok: All items complete 2026-03-31 20:13:22.219872 | 2026-03-31 20:13:22.355973 | instance | ok: "artifacts" 2026-03-31 20:13:22.514725 | instance | ok: "docs" 2026-03-31 20:13:22.529224 | 2026-03-31 20:13:22.529408 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-31 20:13:22.733079 | instance | changed: "logs" 2026-03-31 20:13:22.878961 | instance | changed: "artifacts" 2026-03-31 20:13:23.047298 | instance | changed: "docs" 2026-03-31 20:13:23.063251 | 2026-03-31 20:13:23.063414 | PLAY RECAP 2026-03-31 20:13:23.063483 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-31 20:13:23.063525 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:13:23.063557 | 2026-03-31 20:13:23.234884 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 20:13:23.239052 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 20:13:23.815591 | 2026-03-31 20:13:23.815712 | PLAY [all] 2026-03-31 20:13:23.827011 | 2026-03-31 20:13:23.827103 | TASK [setup-uv : Extract archive] 2026-03-31 20:13:26.133553 | instance | changed 2026-03-31 20:13:26.141497 | 2026-03-31 20:13:26.141610 | TASK [setup-uv : Print version] 2026-03-31 20:13:26.854744 | instance | uv 0.8.13 2026-03-31 20:13:26.675916 | instance | ok: Runtime: 0:00:00.011905 2026-03-31 20:13:26.685127 | 2026-03-31 20:13:26.685198 | PLAY RECAP 2026-03-31 20:13:26.685262 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:13:26.685295 | 2026-03-31 20:13:26.820779 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 20:13:26.824896 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/zed] 2026-03-31 20:13:27.405639 | 2026-03-31 20:13:27.405755 | PLAY [all] 2026-03-31 20:13:27.416613 | 2026-03-31 20:13:27.416688 | TASK [Install "jq" for log collection] 2026-03-31 20:42:33.901548 | instance | changed 2026-03-31 20:42:34.260777 | 2026-03-31 20:42:34.261031 | PLAY RECAP 2026-03-31 20:42:34.261433 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 20:42:34.262117 | 2026-03-31 20:42:34.360933 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/zed] 2026-03-31 20:42:34.363420 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 20:42:34.998141 | 2026-03-31 20:42:34.998283 | PLAY [all] 2026-03-31 20:42:35.009048 | 2026-03-31 20:42:35.009139 | TASK [Copy inventory file for Zuul] 2026-03-31 20:42:35.844500 | instance | changed 2026-03-31 20:42:35.850834 | 2026-03-31 20:42:35.850911 | TASK [Switch "ansible_host" to private IP] 2026-03-31 20:42:36.115611 | instance | changed: 1 replacements made 2026-03-31 20:42:36.122305 | 2026-03-31 20:42:36.122375 | TASK [Run Molecule scenario] 2026-03-31 20:42:36.573789 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-03-31 20:42:36.574004 | instance | Creating virtual environment at: .venv 2026-03-31 20:42:36.602124 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-03-31 20:42:36.632961 | instance | Downloading rjsonnet (1.2MiB) 2026-03-31 20:42:36.634070 | instance | Downloading ansible-core (2.1MiB) 2026-03-31 20:42:36.636059 | instance | Downloading cryptography (4.2MiB) 2026-03-31 20:42:36.636458 | instance | Downloading setuptools (1.1MiB) 2026-03-31 20:42:36.637981 | instance | Downloading pygments (1.2MiB) 2026-03-31 20:42:36.638215 | instance | Downloading kubernetes (1.9MiB) 2026-03-31 20:42:36.638523 | instance | Downloading openstacksdk (1.7MiB) 2026-03-31 20:42:36.639464 | instance | Downloading netaddr (2.2MiB) 2026-03-31 20:42:36.932996 | instance | Building pyperclip==1.9.0 2026-03-31 20:42:36.959949 | instance | Downloading rjsonnet 2026-03-31 20:42:37.075114 | instance | Downloading netaddr 2026-03-31 20:42:37.087168 | instance | Downloading pygments 2026-03-31 20:42:37.096767 | instance | Downloading cryptography 2026-03-31 20:42:37.128550 | instance | Downloading setuptools 2026-03-31 20:42:37.175499 | instance | Downloading kubernetes 2026-03-31 20:42:37.202102 | instance | Downloading ansible-core 2026-03-31 20:42:37.226925 | instance | Downloading openstacksdk 2026-03-31 20:42:37.655517 | instance | Built pyperclip==1.9.0 2026-03-31 20:42:37.779251 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-03-31 20:42:37.825296 | instance | Installed 79 packages in 44ms 2026-03-31 20:42:38.426003 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-03-31 20:42:39.032860 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-31 20:42:39.032972 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-03-31 20:43:14.379323 | RUN END RESULT_TIMED_OUT: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 20:43:14.381241 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/zed] 2026-03-31 20:43:17.450208 | 2026-03-31 20:43:17.450330 | PLAY [all] 2026-03-31 20:43:17.464557 | 2026-03-31 20:43:17.464644 | TASK [gather-host-logs : creating directory for system status] 2026-03-31 20:43:17.819537 | instance | changed 2026-03-31 20:43:17.824725 | 2026-03-31 20:43:17.824806 | TASK [gather-host-logs : Get logs for each host] 2026-03-31 20:43:18.234491 | instance | + systemd-cgls --full --all --no-pager 2026-03-31 20:43:18.242051 | instance | + ip addr 2026-03-31 20:43:18.244740 | instance | + ip route 2026-03-31 20:43:18.246379 | instance | + lsblk 2026-03-31 20:43:18.249366 | instance | + mount 2026-03-31 20:43:18.251320 | instance | + docker images 2026-03-31 20:43:18.251649 | instance | /bin/bash: line 7: docker: command not found 2026-03-31 20:43:18.251839 | instance | + brctl show 2026-03-31 20:43:18.252145 | instance | /bin/bash: line 8: brctl: command not found 2026-03-31 20:43:18.252323 | instance | + ps aux --sort=-%mem 2026-03-31 20:43:18.262905 | instance | + dpkg -l 2026-03-31 20:43:18.274325 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-03-31 20:43:18.274751 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-03-31 20:43:18.274832 | instance | /bin/bash: line 11: docker: command not found 2026-03-31 20:43:18.275148 | instance | + '[' '!' -z '' ']' 2026-03-31 20:43:18.361107 | instance | ok: Runtime: 0:00:00.045772 2026-03-31 20:43:18.371893 | 2026-03-31 20:43:18.372029 | TASK [gather-host-logs : Downloads logs to executor] 2026-03-31 20:43:19.531185 | instance | changed: 2026-03-31 20:43:19.531398 | instance | created directory /var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/logs/instance 2026-03-31 20:43:19.531440 | instance | cd+++++++++ system/ 2026-03-31 20:43:19.531499 | instance | >f+++++++++ system/brctl-show.txt 2026-03-31 20:43:19.531552 | instance | >f+++++++++ system/docker-images.txt 2026-03-31 20:43:19.531584 | instance | >f+++++++++ system/ip-addr.txt 2026-03-31 20:43:19.531617 | instance | >f+++++++++ system/ip-route.txt 2026-03-31 20:43:19.531648 | instance | >f+++++++++ system/lsblk.txt 2026-03-31 20:43:19.531706 | instance | >f+++++++++ system/mount.txt 2026-03-31 20:43:19.531739 | instance | >f+++++++++ system/packages.txt 2026-03-31 20:43:19.531767 | instance | >f+++++++++ system/ps.txt 2026-03-31 20:43:19.531793 | instance | >f+++++++++ system/systemd-cgls.txt 2026-03-31 20:43:19.551906 | 2026-03-31 20:43:19.552005 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-31 20:43:19.741213 | instance | changed: "values" 2026-03-31 20:43:19.938407 | instance | changed: "releases" 2026-03-31 20:43:19.952742 | 2026-03-31 20:43:19.952926 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-31 20:43:20.167418 | instance | /bin/bash: line 3: kubectl: command not found 2026-03-31 20:43:20.493714 | instance | ok: Runtime: 0:00:00.006230 2026-03-31 20:43:20.498939 | 2026-03-31 20:43:20.499006 | TASK [helm-release-status : Downloads logs to executor] 2026-03-31 20:43:20.989796 | instance | changed: 2026-03-31 20:43:20.989999 | instance | cd+++++++++ helm/ 2026-03-31 20:43:20.990038 | instance | cd+++++++++ helm/releases/ 2026-03-31 20:43:20.990062 | instance | cd+++++++++ helm/values/ 2026-03-31 20:43:20.999494 | 2026-03-31 20:43:20.999761 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-31 20:43:21.197991 | instance | changed 2026-03-31 20:43:21.204077 | 2026-03-31 20:43:21.204168 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-31 20:43:21.442483 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:21.442792 | instance | 2026-03-31 20:43:21.447021 | instance | environment: line 1: kubectl: command not found 2026-03-31 20:43:21.448473 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:21.449794 | instance | environment: line 1: kubectl: command not found 2026-03-31 20:43:21.450670 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:21.453128 | instance | environment: line 1: kubectl: command not found 2026-03-31 20:43:21.453918 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:21.455661 | instance | environment: line 1: kubectl: command not found 2026-03-31 20:43:21.456429 | instance | environment: line 1: kubectl: command not found 2026-03-31 20:43:21.456775 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:21.457753 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 20:43:21.741901 | instance | ok: Runtime: 0:00:00.025545 2026-03-31 20:43:21.748645 | 2026-03-31 20:43:21.748707 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-31 20:43:21.954876 | instance | changed 2026-03-31 20:43:21.962099 | 2026-03-31 20:43:21.962190 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-31 20:43:22.204342 | instance | environment: line 5: kubectl: command not found 2026-03-31 20:43:22.205153 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:22.205192 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:22.205704 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 20:43:22.531741 | instance | ok: Runtime: 0:00:00.008278 2026-03-31 20:43:22.537727 | 2026-03-31 20:43:22.537795 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-31 20:43:23.016318 | instance | changed: 2026-03-31 20:43:23.016564 | instance | cd+++++++++ objects/ 2026-03-31 20:43:23.016604 | instance | cd+++++++++ objects/cluster/ 2026-03-31 20:43:23.016634 | instance | cd+++++++++ objects/namespaced/ 2026-03-31 20:43:23.027844 | 2026-03-31 20:43:23.027910 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-31 20:43:23.239162 | instance | changed 2026-03-31 20:43:23.245995 | 2026-03-31 20:43:23.246076 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-31 20:43:23.442843 | instance | changed 2026-03-31 20:43:23.448345 | 2026-03-31 20:43:23.448420 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-31 20:43:23.655139 | instance | environment: line 3: kubectl: command not found 2026-03-31 20:43:23.984873 | instance | ok: Runtime: 0:00:00.008370 2026-03-31 20:43:24.001625 | 2026-03-31 20:43:24.001779 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-31 20:43:24.489706 | instance | changed: 2026-03-31 20:43:24.489901 | instance | cd+++++++++ pod-logs/ 2026-03-31 20:43:24.489939 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-03-31 20:43:24.501121 | 2026-03-31 20:43:24.501183 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-03-31 20:43:24.706302 | instance | changed 2026-03-31 20:43:24.711201 | 2026-03-31 20:43:24.711268 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-03-31 20:43:24.916269 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-31 20:43:25.245323 | instance | ok: Runtime: 0:00:00.034081 2026-03-31 20:43:25.252059 | 2026-03-31 20:43:25.252146 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-03-31 20:43:25.460239 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-31 20:43:25.490680 | instance | ceph-mgr endpoints: 2026-03-31 20:43:25.786009 | instance | ok: Runtime: 0:00:00.035862 2026-03-31 20:43:25.795583 | 2026-03-31 20:43:25.795712 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-03-31 20:43:26.024137 | instance | /bin/bash: line 4: kubectl: command not found 2026-03-31 20:43:26.331078 | instance | ok: Runtime: 0:00:00.035565 2026-03-31 20:43:26.337580 | 2026-03-31 20:43:26.337644 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-03-31 20:43:26.824019 | instance | changed: cd+++++++++ prometheus/ 2026-03-31 20:43:26.834232 | 2026-03-31 20:43:26.834297 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-03-31 20:43:27.039642 | instance | changed 2026-03-31 20:43:27.044379 | 2026-03-31 20:43:27.044442 | TASK [gather-selenium-data : Get selenium data] 2026-03-31 20:43:27.254677 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-03-31 20:43:27.256167 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-03-31 20:43:27.578712 | instance | ERROR 2026-03-31 20:43:27.578921 | instance | { 2026-03-31 20:43:27.578962 | instance | "delta": "0:00:00.006566", 2026-03-31 20:43:27.578992 | instance | "end": "2026-03-31 20:43:27.256558", 2026-03-31 20:43:27.579018 | instance | "msg": "non-zero return code", 2026-03-31 20:43:27.579043 | instance | "rc": 1, 2026-03-31 20:43:27.579068 | instance | "start": "2026-03-31 20:43:27.249992" 2026-03-31 20:43:27.579092 | instance | } 2026-03-31 20:43:27.579124 | instance | ERROR: Ignoring Errors 2026-03-31 20:43:27.585966 | 2026-03-31 20:43:27.586031 | TASK [gather-selenium-data : Downloads logs to executor] 2026-03-31 20:43:28.060234 | instance | changed: cd+++++++++ selenium/ 2026-03-31 20:43:28.078568 | 2026-03-31 20:43:28.078669 | PLAY RECAP 2026-03-31 20:43:28.078716 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-03-31 20:43:28.078738 | 2026-03-31 20:43:28.273220 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/zed] 2026-03-31 20:43:28.277638 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 20:43:28.976728 | 2026-03-31 20:43:28.976890 | PLAY [all] 2026-03-31 20:43:28.990064 | 2026-03-31 20:43:28.990154 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-31 20:43:29.035139 | instance | skipping: Conditional result was False 2026-03-31 20:43:29.044980 | 2026-03-31 20:43:29.045120 | TASK [fetch-output : Set log path for single node] 2026-03-31 20:43:29.091226 | instance | ok 2026-03-31 20:43:29.099005 | 2026-03-31 20:43:29.099095 | LOOP [fetch-output : Ensure local output dirs] 2026-03-31 20:43:29.487221 | instance -> localhost | ok: "/var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/logs" 2026-03-31 20:43:29.719613 | instance -> localhost | changed: "/var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/artifacts" 2026-03-31 20:43:29.946765 | instance -> localhost | changed: "/var/lib/zuul/builds/75c9303557e24925ba32ef1933c30123/work/docs" 2026-03-31 20:43:29.962220 | 2026-03-31 20:43:29.962403 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-31 20:43:30.606205 | instance | changed: .d..t...... ./ 2026-03-31 20:43:30.606660 | instance | changed: All items complete 2026-03-31 20:43:30.606691 | 2026-03-31 20:43:31.043216 | instance | changed: .d..t...... ./ 2026-03-31 20:43:31.481468 | instance | changed: .d..t...... ./ 2026-03-31 20:43:31.501072 | 2026-03-31 20:43:31.501286 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-31 20:43:32.044094 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006225 2026-03-31 20:43:32.294633 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009099 2026-03-31 20:43:32.315363 | 2026-03-31 20:43:32.315529 | PLAY [all] 2026-03-31 20:43:32.322025 | 2026-03-31 20:43:32.322094 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-31 20:43:32.742300 | instance | changed 2026-03-31 20:43:32.749513 | 2026-03-31 20:43:32.749580 | PLAY RECAP 2026-03-31 20:43:32.749646 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 20:43:32.749680 | 2026-03-31 20:43:32.911248 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 20:43:32.913580 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-31 20:43:33.612853 | 2026-03-31 20:43:33.613058 | PLAY [localhost] 2026-03-31 20:43:33.623518 | 2026-03-31 20:43:33.623626 | TASK [Generate Zuul manifest] 2026-03-31 20:43:33.647794 | localhost | ok 2026-03-31 20:43:33.689052 | 2026-03-31 20:43:33.689221 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-31 20:43:34.134126 | localhost | changed 2026-03-31 20:43:34.145494 | 2026-03-31 20:43:34.145581 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-31 20:43:34.187680 | localhost | ok 2026-03-31 20:43:34.201231 | 2026-03-31 20:43:34.201416 | TASK [Upload logs] 2026-03-31 20:43:34.239485 | localhost | ok 2026-03-31 20:43:34.421702 | 2026-03-31 20:43:34.425849 | TASK [Set zuul-log-path fact] 2026-03-31 20:43:34.451641 | localhost | ok 2026-03-31 20:43:34.466643 | 2026-03-31 20:43:34.466735 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 20:43:34.497963 | localhost | ok 2026-03-31 20:43:34.506744 | 2026-03-31 20:43:34.506819 | TASK [upload-logs : Create log directories] 2026-03-31 20:43:34.920482 | localhost | changed 2026-03-31 20:43:34.926758 | 2026-03-31 20:43:34.926840 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-31 20:43:35.332507 | localhost -> localhost | ok: Runtime: 0:00:00.005783 2026-03-31 20:43:35.339275 | 2026-03-31 20:43:35.339342 | TASK [upload-logs : Upload logs to log server] 2026-03-31 20:43:35.848307 | localhost | Output suppressed because no_log was given 2026-03-31 20:43:35.853166 | 2026-03-31 20:43:35.853235 | LOOP [upload-logs : Compress console log and json output] 2026-03-31 20:43:35.895168 | localhost | skipping: Conditional result was False 2026-03-31 20:43:35.902961 | localhost | skipping: Conditional result was False 2026-03-31 20:43:35.916862 | 2026-03-31 20:43:35.917021 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-31 20:43:35.960362 | localhost | skipping: Conditional result was False 2026-03-31 20:43:35.960785 | 2026-03-31 20:43:35.964627 | localhost | skipping: Conditional result was False 2026-03-31 20:43:35.979352 | 2026-03-31 20:43:35.979500 | LOOP [upload-logs : Upload console log and json output]