2026-04-13 20:43:14.185390 | Job console starting 2026-04-13 20:43:14.235510 | Updating git repos 2026-04-13 20:43:14.374224 | Cloning repos into workspace 2026-04-13 20:43:15.282550 | Restoring repo states 2026-04-13 20:43:15.301259 | Merging changes 2026-04-13 20:43:19.262330 | Checking out repos 2026-04-13 20:43:19.953143 | Preparing playbooks 2026-04-13 20:43:30.703246 | Running Ansible setup 2026-04-13 20:43:35.853973 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 20:43:36.696159 | 2026-04-13 20:43:36.696311 | PLAY [localhost] 2026-04-13 20:43:36.706902 | 2026-04-13 20:43:36.707023 | TASK [Gathering Facts] 2026-04-13 20:43:37.640064 | localhost | ok 2026-04-13 20:43:37.653170 | 2026-04-13 20:43:37.653379 | TASK [Setup log path fact] 2026-04-13 20:43:37.676927 | localhost | ok 2026-04-13 20:43:37.699100 | 2026-04-13 20:43:37.699245 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 20:43:37.732597 | localhost | ok 2026-04-13 20:43:37.740363 | 2026-04-13 20:43:37.740453 | TASK [emit-job-header : Print job information] 2026-04-13 20:43:37.781301 | # Job Information 2026-04-13 20:43:37.781520 | Ansible Version: 2.16.16 2026-04-13 20:43:37.781582 | Job: atmosphere-molecule-csi-rbd 2026-04-13 20:43:37.781626 | Pipeline: check 2026-04-13 20:43:37.781665 | Executor: 0a8996d2b663 2026-04-13 20:43:37.781704 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818 2026-04-13 20:43:37.781748 | Event ID: 47cd3f80-3779-11f1-9d54-63e76b9c6aba 2026-04-13 20:43:37.786982 | 2026-04-13 20:43:37.787137 | LOOP [emit-job-header : Print node information] 2026-04-13 20:43:37.911636 | localhost | ok: 2026-04-13 20:43:37.911856 | localhost | # Node Information 2026-04-13 20:43:37.911905 | localhost | Inventory Hostname: instance 2026-04-13 20:43:37.911941 | localhost | Hostname: np0000165723 2026-04-13 20:43:37.911979 | localhost | Username: zuul 2026-04-13 20:43:37.912023 | localhost | Distro: Ubuntu 22.04 2026-04-13 20:43:37.912061 | localhost | Provider: yul1 2026-04-13 20:43:37.912098 | localhost | Region: ca-ymq-1 2026-04-13 20:43:37.912133 | localhost | Label: ubuntu-jammy 2026-04-13 20:43:37.912170 | localhost | Product Name: OpenStack Nova 2026-04-13 20:43:37.912207 | localhost | Interface IP: 199.19.213.15 2026-04-13 20:43:37.925321 | 2026-04-13 20:43:37.925455 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-13 20:43:38.398629 | localhost -> localhost | changed 2026-04-13 20:43:38.409260 | 2026-04-13 20:43:38.409364 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-13 20:43:39.841276 | localhost -> localhost | changed 2026-04-13 20:43:39.850844 | 2026-04-13 20:43:39.850981 | PLAY [all] 2026-04-13 20:43:39.862132 | 2026-04-13 20:43:39.862296 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-13 20:43:40.197410 | instance -> localhost | ok 2026-04-13 20:43:40.207859 | 2026-04-13 20:43:40.208026 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-13 20:43:40.257901 | instance | ok 2026-04-13 20:43:40.298244 | instance | included: /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-13 20:43:40.308719 | 2026-04-13 20:43:40.308872 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-13 20:43:41.219008 | instance -> localhost | Generating public/private rsa key pair. 2026-04-13 20:43:41.221248 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/ebe4042281ba4de09d82c8f0fb3e8b6e_id_rsa 2026-04-13 20:43:41.221296 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/ebe4042281ba4de09d82c8f0fb3e8b6e_id_rsa.pub 2026-04-13 20:43:41.221329 | instance -> localhost | The key fingerprint is: 2026-04-13 20:43:41.221362 | instance -> localhost | SHA256:4rpGW3CufuiES48cZEYJfEpEifqSiC8vFI8YEK3L+iw zuul-build-sshkey 2026-04-13 20:43:41.221414 | instance -> localhost | The key's randomart image is: 2026-04-13 20:43:41.221450 | instance -> localhost | +---[RSA 3072]----+ 2026-04-13 20:43:41.221486 | instance -> localhost | |B=. | 2026-04-13 20:43:41.221520 | instance -> localhost | |o=.o | 2026-04-13 20:43:41.221551 | instance -> localhost | |+.= | 2026-04-13 20:43:41.221582 | instance -> localhost | |++ . . | 2026-04-13 20:43:41.221614 | instance -> localhost | |==B +. S | 2026-04-13 20:43:41.221645 | instance -> localhost | |BB.o..o. | 2026-04-13 20:43:41.221676 | instance -> localhost | |oo+..=. | 2026-04-13 20:43:41.221710 | instance -> localhost | |E+.*=.. | 2026-04-13 20:43:41.221747 | instance -> localhost | | *B+*o | 2026-04-13 20:43:41.221780 | instance -> localhost | +----[SHA256]-----+ 2026-04-13 20:43:41.221865 | instance -> localhost | ok: Runtime: 0:00:00.294604 2026-04-13 20:43:41.233626 | 2026-04-13 20:43:41.233745 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-13 20:43:41.253305 | instance | ok 2026-04-13 20:43:41.265836 | instance | included: /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-13 20:43:41.281343 | 2026-04-13 20:43:41.281474 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-13 20:43:41.315392 | instance | skipping: Conditional result was False 2026-04-13 20:43:41.530596 | 2026-04-13 20:43:41.530741 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-13 20:43:42.029132 | instance | changed 2026-04-13 20:43:42.040922 | 2026-04-13 20:43:42.041363 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-13 20:43:42.255729 | instance | ok 2026-04-13 20:43:42.272047 | 2026-04-13 20:43:42.272194 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-13 20:43:42.760497 | instance | changed 2026-04-13 20:43:42.767784 | 2026-04-13 20:43:42.768011 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-13 20:43:43.218991 | instance | changed 2026-04-13 20:43:43.228476 | 2026-04-13 20:43:43.228617 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-13 20:43:43.243743 | instance | skipping: Conditional result was False 2026-04-13 20:43:43.252036 | 2026-04-13 20:43:43.252161 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-13 20:43:43.748626 | instance -> localhost | changed 2026-04-13 20:43:43.765400 | 2026-04-13 20:43:43.765526 | TASK [add-build-sshkey : Add back temp key] 2026-04-13 20:43:44.570114 | instance -> localhost | Identity added: /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/ebe4042281ba4de09d82c8f0fb3e8b6e_id_rsa (zuul-build-sshkey) 2026-04-13 20:43:44.570528 | instance -> localhost | ok: Runtime: 0:00:00.015608 2026-04-13 20:43:44.582158 | 2026-04-13 20:43:44.582308 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-13 20:43:44.952726 | instance | ok 2026-04-13 20:43:45.390433 | 2026-04-13 20:43:45.390565 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-13 20:43:45.415502 | instance | skipping: Conditional result was False 2026-04-13 20:43:45.435729 | 2026-04-13 20:43:45.435866 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-13 20:43:45.793683 | instance | ok 2026-04-13 20:43:45.802088 | 2026-04-13 20:43:45.802186 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-13 20:43:50.193742 | instance | Output suppressed because no_log was given 2026-04-13 20:43:50.208024 | 2026-04-13 20:43:50.392867 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-13 20:43:50.592918 | instance | ok: "logs" 2026-04-13 20:43:50.593257 | instance | ok: All items complete 2026-04-13 20:43:50.593292 | 2026-04-13 20:43:50.768046 | instance | ok: "artifacts" 2026-04-13 20:43:50.933290 | instance | ok: "docs" 2026-04-13 20:43:50.972431 | 2026-04-13 20:43:50.972580 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-13 20:43:51.182643 | instance | changed: "logs" 2026-04-13 20:43:51.349832 | instance | changed: "artifacts" 2026-04-13 20:43:51.539076 | instance | changed: "docs" 2026-04-13 20:43:51.556612 | 2026-04-13 20:43:51.556748 | PLAY RECAP 2026-04-13 20:43:51.556814 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-13 20:43:51.556861 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:43:51.556895 | 2026-04-13 20:43:51.696205 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 20:43:51.700545 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 20:43:52.478309 | 2026-04-13 20:43:52.479102 | PLAY [all] 2026-04-13 20:43:52.497145 | 2026-04-13 20:43:52.497340 | TASK [setup-uv : Extract archive] 2026-04-13 20:43:54.733189 | instance | changed 2026-04-13 20:43:54.739575 | 2026-04-13 20:43:54.739739 | TASK [setup-uv : Print version] 2026-04-13 20:43:55.171155 | instance | uv 0.8.13 2026-04-13 20:43:55.284087 | instance | ok: Runtime: 0:00:00.009694 2026-04-13 20:43:55.293365 | 2026-04-13 20:43:55.293432 | PLAY RECAP 2026-04-13 20:43:55.293479 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:43:55.293505 | 2026-04-13 20:43:55.454969 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 20:43:55.591659 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 20:43:56.348275 | 2026-04-13 20:43:56.348492 | PLAY [all] 2026-04-13 20:43:56.363535 | 2026-04-13 20:43:56.363733 | TASK [Install "jq" for log collection] 2026-04-13 20:44:06.755928 | instance | changed 2026-04-13 20:44:06.766495 | 2026-04-13 20:44:06.766578 | TASK [Install pip3 for Python package management] 2026-04-13 20:44:13.237059 | instance | changed 2026-04-13 20:44:13.243514 | 2026-04-13 20:44:13.243695 | TASK [Install Python "kubernetes" library for kubernetes.core modules] 2026-04-13 20:44:16.576386 | instance | changed 2026-04-13 20:44:16.580854 | 2026-04-13 20:44:16.581003 | PLAY [all] 2026-04-13 20:44:16.592938 | 2026-04-13 20:44:16.593147 | TASK [ensure-go : Check installed go version] 2026-04-13 20:44:17.131131 | instance | ok: ERROR (ignored) 2026-04-13 20:44:17.131326 | instance | { 2026-04-13 20:44:17.131360 | instance | "failed_when_result": false, 2026-04-13 20:44:17.131382 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-04-13 20:44:17.131404 | instance | "rc": 2 2026-04-13 20:44:17.131427 | instance | } 2026-04-13 20:44:17.137847 | 2026-04-13 20:44:17.137939 | TASK [ensure-go : Skip if correct version of go is installed] 2026-04-13 20:44:17.190348 | instance | ok 2026-04-13 20:44:17.200911 | instance | included: /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-04-13 20:44:17.205981 | 2026-04-13 20:44:17.206063 | TASK [ensure-go : Create temp directory] 2026-04-13 20:44:17.572598 | instance | changed 2026-04-13 20:44:17.581228 | 2026-04-13 20:44:17.581371 | TASK [ensure-go : Get archive checksum] 2026-04-13 20:44:18.207115 | instance | ok: OK (64 bytes) 2026-04-13 20:44:18.216208 | 2026-04-13 20:44:18.216319 | TASK [ensure-go : Download go archive] 2026-04-13 20:44:19.652337 | instance | changed: OK (78559214 bytes) 2026-04-13 20:44:19.659398 | 2026-04-13 20:44:19.659491 | TASK [ensure-go : Install go] 2026-04-13 20:44:25.755426 | instance | changed 2026-04-13 20:44:25.771459 | 2026-04-13 20:44:25.771639 | PLAY [all] 2026-04-13 20:44:25.780573 | 2026-04-13 20:44:25.780644 | TASK [Build atmosphere binary] 2026-04-13 20:44:26.159855 | instance -> localhost | ERROR 2026-04-13 20:44:26.160213 | instance -> localhost | { 2026-04-13 20:44:26.160300 | instance -> localhost | "delta": null, 2026-04-13 20:44:26.160341 | instance -> localhost | "end": null, 2026-04-13 20:44:26.160370 | instance -> localhost | "msg": "Unable to change directory before execution: [Errno 2] No such file or directory: b'src/github.com/vexxhost/atmosphere'", 2026-04-13 20:44:26.160396 | instance -> localhost | "rc": null, 2026-04-13 20:44:26.160422 | instance -> localhost | "start": null 2026-04-13 20:44:26.160447 | instance -> localhost | } failure 2026-04-13 20:44:26.162369 | 2026-04-13 20:44:26.162434 | PLAY RECAP 2026-04-13 20:44:26.162498 | instance | ok: 9 changed: 6 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:44:26.162529 | 2026-04-13 20:44:26.411573 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 20:44:26.414675 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 20:44:27.031612 | 2026-04-13 20:44:27.347870 | PLAY [all] 2026-04-13 20:44:27.372509 | 2026-04-13 20:44:27.372895 | TASK [gather-host-logs : creating directory for system status] 2026-04-13 20:44:27.776814 | instance | changed 2026-04-13 20:44:27.790577 | 2026-04-13 20:44:28.345059 | TASK [gather-host-logs : Get logs for each host] 2026-04-13 20:44:28.732311 | instance | + systemd-cgls --full --all --no-pager 2026-04-13 20:44:28.744538 | instance | + ip addr 2026-04-13 20:44:28.747450 | instance | + ip route 2026-04-13 20:44:28.748738 | instance | + lsblk 2026-04-13 20:44:28.750667 | instance | + mount 2026-04-13 20:44:28.751906 | instance | + docker images 2026-04-13 20:44:28.752246 | instance | /bin/bash: line 7: docker: command not found 2026-04-13 20:44:28.752410 | instance | + brctl show 2026-04-13 20:44:28.752709 | instance | /bin/bash: line 8: brctl: command not found 2026-04-13 20:44:28.752856 | instance | + ps aux --sort=-%mem 2026-04-13 20:44:28.763247 | instance | + dpkg -l 2026-04-13 20:44:28.771083 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-13 20:44:28.771405 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-13 20:44:28.771476 | instance | /bin/bash: line 11: docker: command not found 2026-04-13 20:44:28.771797 | instance | + '[' '!' -z '' ']' 2026-04-13 20:44:28.891796 | instance | ok: Runtime: 0:00:00.046108 2026-04-13 20:44:28.902074 | 2026-04-13 20:44:28.902245 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-13 20:44:29.557892 | instance | changed: 2026-04-13 20:44:29.558081 | instance | created directory /var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/logs/instance 2026-04-13 20:44:29.558121 | instance | cd+++++++++ system/ 2026-04-13 20:44:29.558151 | instance | >f+++++++++ system/brctl-show.txt 2026-04-13 20:44:29.558202 | instance | >f+++++++++ system/docker-images.txt 2026-04-13 20:44:29.558253 | instance | >f+++++++++ system/ip-addr.txt 2026-04-13 20:44:29.558291 | instance | >f+++++++++ system/ip-route.txt 2026-04-13 20:44:29.558322 | instance | >f+++++++++ system/lsblk.txt 2026-04-13 20:44:29.558350 | instance | >f+++++++++ system/mount.txt 2026-04-13 20:44:29.558382 | instance | >f+++++++++ system/packages.txt 2026-04-13 20:44:29.558409 | instance | >f+++++++++ system/ps.txt 2026-04-13 20:44:29.558438 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-13 20:44:29.570417 | 2026-04-13 20:44:29.570480 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-13 20:44:29.797757 | instance | changed: "values" 2026-04-13 20:44:29.973418 | instance | changed: "releases" 2026-04-13 20:44:29.992101 | 2026-04-13 20:44:29.992326 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-13 20:44:30.225324 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-13 20:44:30.530430 | instance | ok: Runtime: 0:00:00.004517 2026-04-13 20:44:30.535772 | 2026-04-13 20:44:30.535863 | TASK [helm-release-status : Downloads logs to executor] 2026-04-13 20:44:31.071338 | instance | changed: 2026-04-13 20:44:31.071520 | instance | cd+++++++++ helm/ 2026-04-13 20:44:31.071572 | instance | cd+++++++++ helm/releases/ 2026-04-13 20:44:31.071639 | instance | cd+++++++++ helm/values/ 2026-04-13 20:44:31.089985 | 2026-04-13 20:44:31.090184 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-13 20:44:31.297943 | instance | changed 2026-04-13 20:44:31.305316 | 2026-04-13 20:44:31.305454 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-13 20:44:31.524742 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:31.524862 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:31.529708 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:31.531175 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:31.532945 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:31.534229 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:31.534875 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:31.536263 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:31.537797 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:31.538696 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:31.539212 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:31.539921 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:31.843539 | instance | ok: Runtime: 0:00:00.024329 2026-04-13 20:44:31.849329 | 2026-04-13 20:44:31.849411 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-13 20:44:32.095311 | instance | changed 2026-04-13 20:44:32.100430 | 2026-04-13 20:44:32.100511 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-13 20:44:32.350538 | instance | environment: line 5: kubectl: command not found 2026-04-13 20:44:32.351165 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:32.351204 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:32.351427 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:32.677954 | instance | ok: Runtime: 0:00:00.010262 2026-04-13 20:44:32.686515 | 2026-04-13 20:44:32.686684 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-13 20:44:33.208007 | instance | changed: 2026-04-13 20:44:33.208270 | instance | cd+++++++++ objects/ 2026-04-13 20:44:33.208326 | instance | cd+++++++++ objects/cluster/ 2026-04-13 20:44:33.208372 | instance | cd+++++++++ objects/namespaced/ 2026-04-13 20:44:33.217955 | 2026-04-13 20:44:33.218048 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-13 20:44:33.416087 | instance | changed 2026-04-13 20:44:33.422042 | 2026-04-13 20:44:33.422113 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-13 20:44:33.642605 | instance | changed 2026-04-13 20:44:33.649551 | 2026-04-13 20:44:33.649622 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-13 20:44:33.864521 | instance | environment: line 3: kubectl: command not found 2026-04-13 20:44:34.183495 | instance | ok: Runtime: 0:00:00.009514 2026-04-13 20:44:34.189300 | 2026-04-13 20:44:34.189387 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-13 20:44:34.699017 | instance | changed: 2026-04-13 20:44:34.699205 | instance | cd+++++++++ pod-logs/ 2026-04-13 20:44:34.699239 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-13 20:44:34.712034 | 2026-04-13 20:44:34.712212 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-13 20:44:34.918669 | instance | changed 2026-04-13 20:44:34.925655 | 2026-04-13 20:44:34.925749 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-13 20:44:35.164979 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 20:44:35.589587 | instance | ok: Runtime: 0:00:00.037775 2026-04-13 20:44:35.601348 | 2026-04-13 20:44:35.601458 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-13 20:44:35.844759 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 20:44:35.877841 | instance | ceph-mgr endpoints: 2026-04-13 20:44:36.148535 | instance | ok: Runtime: 0:00:00.038265 2026-04-13 20:44:36.157330 | 2026-04-13 20:44:36.157457 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-13 20:44:36.391981 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-13 20:44:36.695399 | instance | ok: Runtime: 0:00:00.037898 2026-04-13 20:44:36.700924 | 2026-04-13 20:44:36.701075 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-13 20:44:37.255068 | instance | changed: cd+++++++++ prometheus/ 2026-04-13 20:44:37.274068 | 2026-04-13 20:44:37.274422 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-13 20:44:37.502731 | instance | changed 2026-04-13 20:44:37.509074 | 2026-04-13 20:44:37.509199 | TASK [gather-selenium-data : Get selenium data] 2026-04-13 20:44:37.741965 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-13 20:44:37.743444 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-13 20:44:38.054032 | instance | ERROR 2026-04-13 20:44:38.054272 | instance | { 2026-04-13 20:44:38.054317 | instance | "delta": "0:00:00.006334", 2026-04-13 20:44:38.054390 | instance | "end": "2026-04-13 20:44:37.743857", 2026-04-13 20:44:38.054419 | instance | "msg": "non-zero return code", 2026-04-13 20:44:38.054456 | instance | "rc": 1, 2026-04-13 20:44:38.054483 | instance | "start": "2026-04-13 20:44:37.737523" 2026-04-13 20:44:38.054509 | instance | } 2026-04-13 20:44:38.054617 | instance | ERROR: Ignoring Errors 2026-04-13 20:44:38.062860 | 2026-04-13 20:44:38.063043 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-13 20:44:38.609784 | instance | changed: cd+++++++++ selenium/ 2026-04-13 20:44:38.622482 | 2026-04-13 20:44:38.622600 | PLAY RECAP 2026-04-13 20:44:38.622650 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-13 20:44:38.622673 | 2026-04-13 20:44:38.765007 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 20:44:38.767675 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 20:44:39.511994 | 2026-04-13 20:44:39.512194 | PLAY [all] 2026-04-13 20:44:39.526316 | 2026-04-13 20:44:39.526476 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-13 20:44:39.583576 | instance | skipping: Conditional result was False 2026-04-13 20:44:39.591815 | 2026-04-13 20:44:39.592049 | TASK [fetch-output : Set log path for single node] 2026-04-13 20:44:39.636817 | instance | ok 2026-04-13 20:44:39.644386 | 2026-04-13 20:44:39.644560 | LOOP [fetch-output : Ensure local output dirs] 2026-04-13 20:44:40.136108 | instance -> localhost | ok: "/var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/logs" 2026-04-13 20:44:40.385581 | instance -> localhost | changed: "/var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/artifacts" 2026-04-13 20:44:40.633049 | instance -> localhost | changed: "/var/lib/zuul/builds/ebe4042281ba4de09d82c8f0fb3e8b6e/work/docs" 2026-04-13 20:44:40.647349 | 2026-04-13 20:44:40.647459 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-13 20:44:41.354580 | instance | changed: .d..t...... ./ 2026-04-13 20:44:41.355276 | instance | changed: All items complete 2026-04-13 20:44:41.355346 | 2026-04-13 20:44:41.818965 | instance | changed: .d..t...... ./ 2026-04-13 20:44:42.367095 | instance | changed: .d..t...... ./ 2026-04-13 20:44:42.392363 | 2026-04-13 20:44:42.392509 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-13 20:44:42.910399 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009019 2026-04-13 20:44:43.244135 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009774 2026-04-13 20:44:43.272257 | 2026-04-13 20:44:43.272881 | PLAY [all] 2026-04-13 20:44:43.287997 | 2026-04-13 20:44:43.288150 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-13 20:44:43.800627 | instance | changed 2026-04-13 20:44:43.811500 | 2026-04-13 20:44:43.811628 | PLAY RECAP 2026-04-13 20:44:43.811703 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 20:44:43.811736 | 2026-04-13 20:44:44.109464 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 20:44:44.112457 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-13 20:44:44.737240 | 2026-04-13 20:44:44.737437 | PLAY [localhost] 2026-04-13 20:44:44.747552 | 2026-04-13 20:44:44.747643 | TASK [Generate Zuul manifest] 2026-04-13 20:44:44.770980 | localhost | ok 2026-04-13 20:44:44.785798 | 2026-04-13 20:44:44.785909 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-13 20:44:45.254366 | localhost | changed 2026-04-13 20:44:45.269298 | 2026-04-13 20:44:45.269456 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-13 20:44:45.300659 | localhost | ok 2026-04-13 20:44:45.309777 | 2026-04-13 20:44:45.309876 | TASK [Upload logs] 2026-04-13 20:44:45.331452 | localhost | ok 2026-04-13 20:44:45.402359 | 2026-04-13 20:44:45.402473 | TASK [Set zuul-log-path fact] 2026-04-13 20:44:45.421617 | localhost | ok 2026-04-13 20:44:45.435659 | 2026-04-13 20:44:45.435807 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 20:44:45.467470 | localhost | ok 2026-04-13 20:44:45.477757 | 2026-04-13 20:44:45.477844 | TASK [upload-logs : Create log directories] 2026-04-13 20:44:45.960466 | localhost | changed 2026-04-13 20:44:45.968228 | 2026-04-13 20:44:45.968391 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-13 20:44:46.408681 | localhost -> localhost | ok: Runtime: 0:00:00.006086 2026-04-13 20:44:46.413886 | 2026-04-13 20:44:46.413958 | TASK [upload-logs : Upload logs to log server] 2026-04-13 20:44:46.986203 | localhost | Output suppressed because no_log was given 2026-04-13 20:44:46.991379 | 2026-04-13 20:44:46.991667 | LOOP [upload-logs : Compress console log and json output] 2026-04-13 20:44:47.045188 | localhost | skipping: Conditional result was False 2026-04-13 20:44:48.055767 | localhost | skipping: Conditional result was False 2026-04-13 20:44:48.065580 | 2026-04-13 20:44:48.065744 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-13 20:44:48.113639 | localhost | skipping: Conditional result was False 2026-04-13 20:44:48.114138 | 2026-04-13 20:44:48.118999 | localhost | skipping: Conditional result was False 2026-04-13 20:44:48.125887 | 2026-04-13 20:44:48.126025 | LOOP [upload-logs : Upload console log and json output]