2026-04-13 20:43:13.085167 | Job console starting 2026-04-13 20:43:13.105514 | Updating git repos 2026-04-13 20:43:13.226817 | Cloning repos into workspace 2026-04-13 20:43:14.288794 | Restoring repo states 2026-04-13 20:43:14.315411 | Merging changes 2026-04-13 20:43:17.278584 | Checking out repos 2026-04-13 20:43:17.575669 | Preparing playbooks 2026-04-13 20:43:28.903771 | Running Ansible setup 2026-04-13 20:43:33.570948 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 20:43:34.225837 | 2026-04-13 20:43:34.358999 | PLAY [localhost] 2026-04-13 20:43:34.371854 | 2026-04-13 20:43:34.372028 | TASK [Gathering Facts] 2026-04-13 20:43:35.476127 | localhost | ok 2026-04-13 20:43:35.486014 | 2026-04-13 20:43:35.486211 | TASK [Setup log path fact] 2026-04-13 20:43:35.504617 | localhost | ok 2026-04-13 20:43:35.520431 | 2026-04-13 20:43:35.520591 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 20:43:35.549048 | localhost | ok 2026-04-13 20:43:35.557249 | 2026-04-13 20:43:35.557410 | TASK [emit-job-header : Print job information] 2026-04-13 20:43:35.607942 | # Job Information 2026-04-13 20:43:35.608147 | Ansible Version: 2.16.16 2026-04-13 20:43:35.608194 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-04-13 20:43:35.608224 | Pipeline: check 2026-04-13 20:43:35.608270 | Executor: 0a8996d2b663 2026-04-13 20:43:35.608303 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818 2026-04-13 20:43:35.608334 | Event ID: 47cd3f80-3779-11f1-9d54-63e76b9c6aba 2026-04-13 20:43:35.612341 | 2026-04-13 20:43:35.612520 | LOOP [emit-job-header : Print node information] 2026-04-13 20:43:35.711093 | localhost | ok: 2026-04-13 20:43:35.711338 | localhost | # Node Information 2026-04-13 20:43:35.711404 | localhost | Inventory Hostname: instance 2026-04-13 20:43:35.711454 | localhost | Hostname: np0000165722 2026-04-13 20:43:35.711497 | localhost | Username: zuul 2026-04-13 20:43:35.711551 | localhost | Distro: Ubuntu 22.04 2026-04-13 20:43:35.711613 | localhost | Provider: yul1 2026-04-13 20:43:35.711668 | localhost | Region: ca-ymq-1 2026-04-13 20:43:35.711712 | localhost | Label: ubuntu-jammy 2026-04-13 20:43:35.711753 | localhost | Product Name: OpenStack Nova 2026-04-13 20:43:35.711794 | localhost | Interface IP: 199.19.213.168 2026-04-13 20:43:35.727727 | 2026-04-13 20:43:35.727917 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-13 20:43:36.220854 | localhost -> localhost | changed 2026-04-13 20:43:36.225504 | 2026-04-13 20:43:36.225590 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-13 20:43:37.238383 | localhost -> localhost | changed 2026-04-13 20:43:37.245000 | 2026-04-13 20:43:37.245057 | PLAY [all] 2026-04-13 20:43:37.270069 | 2026-04-13 20:43:37.270250 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-13 20:43:37.612719 | instance -> localhost | ok 2026-04-13 20:43:37.620099 | 2026-04-13 20:43:37.620310 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-13 20:43:37.662200 | instance | ok 2026-04-13 20:43:37.686832 | instance | included: /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-13 20:43:37.696185 | 2026-04-13 20:43:37.696293 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-13 20:43:39.143923 | instance -> localhost | Generating public/private rsa key pair. 2026-04-13 20:43:39.144077 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/2df696be10b74f7f95962bacc8788232_id_rsa 2026-04-13 20:43:39.144108 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/2df696be10b74f7f95962bacc8788232_id_rsa.pub 2026-04-13 20:43:39.144131 | instance -> localhost | The key fingerprint is: 2026-04-13 20:43:39.144153 | instance -> localhost | SHA256:+SkkCsmRfJ01TvtN5naezShn847/LTTBhqS6RSBeHtE zuul-build-sshkey 2026-04-13 20:43:39.144189 | instance -> localhost | The key's randomart image is: 2026-04-13 20:43:39.144212 | instance -> localhost | +---[RSA 3072]----+ 2026-04-13 20:43:39.144239 | instance -> localhost | | =o | 2026-04-13 20:43:39.144261 | instance -> localhost | | . . ..=+oE . | 2026-04-13 20:43:39.144281 | instance -> localhost | | + ..o+oo ooo | 2026-04-13 20:43:39.144302 | instance -> localhost | | . + . .oo=. + | 2026-04-13 20:43:39.144322 | instance -> localhost | | + . So. +... | 2026-04-13 20:43:39.144342 | instance -> localhost | | . . o...o oo= | 2026-04-13 20:43:39.144362 | instance -> localhost | | . .oo ..B.o| 2026-04-13 20:43:39.144382 | instance -> localhost | | .. +.+.| 2026-04-13 20:43:39.144405 | instance -> localhost | | .+B| 2026-04-13 20:43:39.144426 | instance -> localhost | +----[SHA256]-----+ 2026-04-13 20:43:39.144491 | instance -> localhost | ok: Runtime: 0:00:01.008823 2026-04-13 20:43:39.149895 | 2026-04-13 20:43:39.149982 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-13 20:43:39.180979 | instance | ok 2026-04-13 20:43:39.193382 | instance | included: /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-13 20:43:39.205708 | 2026-04-13 20:43:39.205873 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-13 20:43:39.220433 | instance | skipping: Conditional result was False 2026-04-13 20:43:39.227919 | 2026-04-13 20:43:39.228068 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-13 20:43:39.674349 | instance | changed 2026-04-13 20:43:39.778431 | 2026-04-13 20:43:39.778531 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-13 20:43:39.996047 | instance | ok 2026-04-13 20:43:40.017699 | 2026-04-13 20:43:40.017845 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-13 20:43:40.523285 | instance | changed 2026-04-13 20:43:40.683822 | 2026-04-13 20:43:40.683945 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-13 20:43:41.151728 | instance | changed 2026-04-13 20:43:41.157922 | 2026-04-13 20:43:41.157990 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-13 20:43:41.181029 | instance | skipping: Conditional result was False 2026-04-13 20:43:41.191753 | 2026-04-13 20:43:41.191855 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-13 20:43:41.739327 | instance -> localhost | changed 2026-04-13 20:43:41.753325 | 2026-04-13 20:43:41.753495 | TASK [add-build-sshkey : Add back temp key] 2026-04-13 20:43:42.243630 | instance -> localhost | Identity added: /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/2df696be10b74f7f95962bacc8788232_id_rsa (zuul-build-sshkey) 2026-04-13 20:43:42.243865 | instance -> localhost | ok: Runtime: 0:00:00.013841 2026-04-13 20:43:42.259403 | 2026-04-13 20:43:42.259543 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-13 20:43:42.646784 | instance | ok 2026-04-13 20:43:42.655425 | 2026-04-13 20:43:42.655574 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-13 20:43:42.679967 | instance | skipping: Conditional result was False 2026-04-13 20:43:42.700950 | 2026-04-13 20:43:42.701107 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-13 20:43:43.106986 | instance | ok 2026-04-13 20:43:43.113863 | 2026-04-13 20:43:43.113955 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-13 20:43:45.525144 | instance | Output suppressed because no_log was given 2026-04-13 20:43:45.535211 | 2026-04-13 20:43:45.535338 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-13 20:43:45.711420 | instance | ok: "logs" 2026-04-13 20:43:45.711708 | instance | ok: All items complete 2026-04-13 20:43:45.711748 | 2026-04-13 20:43:45.860055 | instance | ok: "artifacts" 2026-04-13 20:43:46.266471 | instance | ok: "docs" 2026-04-13 20:43:46.289575 | 2026-04-13 20:43:46.289771 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-13 20:43:46.465560 | instance | changed: "logs" 2026-04-13 20:43:46.622445 | instance | changed: "artifacts" 2026-04-13 20:43:47.181867 | instance | changed: "docs" 2026-04-13 20:43:47.197936 | 2026-04-13 20:43:47.198044 | PLAY RECAP 2026-04-13 20:43:47.198110 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-13 20:43:47.198157 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:43:47.198189 | 2026-04-13 20:43:47.495055 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 20:43:47.882472 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 20:43:48.615387 | 2026-04-13 20:43:49.618766 | PLAY [all] 2026-04-13 20:43:49.642303 | 2026-04-13 20:43:49.642461 | TASK [setup-uv : Extract archive] 2026-04-13 20:43:51.877873 | instance | changed 2026-04-13 20:43:51.888340 | 2026-04-13 20:43:51.888506 | TASK [setup-uv : Print version] 2026-04-13 20:43:52.293016 | instance | uv 0.8.13 2026-04-13 20:43:52.434261 | instance | ok: Runtime: 0:00:00.013005 2026-04-13 20:43:52.440605 | 2026-04-13 20:43:52.440670 | PLAY RECAP 2026-04-13 20:43:52.440724 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:43:52.440797 | 2026-04-13 20:43:52.566941 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 20:43:52.573930 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 20:43:53.227860 | 2026-04-13 20:43:53.278996 | PLAY [all] 2026-04-13 20:43:53.299403 | 2026-04-13 20:43:53.299586 | TASK [Install "jq" for log collection] 2026-04-13 20:44:03.690624 | instance | changed 2026-04-13 20:44:03.701336 | 2026-04-13 20:44:03.701510 | TASK [Install pip3 for Python package management] 2026-04-13 20:44:08.365671 | instance | changed 2026-04-13 20:44:08.373427 | 2026-04-13 20:44:08.373504 | TASK [Install Python "kubernetes" library for kubernetes.core modules] 2026-04-13 20:44:11.510888 | instance | changed 2026-04-13 20:44:11.514459 | 2026-04-13 20:44:11.514569 | PLAY [all] 2026-04-13 20:44:11.524561 | 2026-04-13 20:44:11.524664 | TASK [ensure-go : Check installed go version] 2026-04-13 20:44:12.065338 | instance | ok: ERROR (ignored) 2026-04-13 20:44:12.065561 | instance | { 2026-04-13 20:44:12.065596 | instance | "failed_when_result": false, 2026-04-13 20:44:12.065618 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-04-13 20:44:12.065640 | instance | "rc": 2 2026-04-13 20:44:12.065844 | instance | } 2026-04-13 20:44:12.074411 | 2026-04-13 20:44:12.074560 | TASK [ensure-go : Skip if correct version of go is installed] 2026-04-13 20:44:12.127303 | instance | ok 2026-04-13 20:44:12.140464 | instance | included: /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-04-13 20:44:12.147151 | 2026-04-13 20:44:12.147337 | TASK [ensure-go : Create temp directory] 2026-04-13 20:44:12.474544 | instance | changed 2026-04-13 20:44:12.483178 | 2026-04-13 20:44:12.483272 | TASK [ensure-go : Get archive checksum] 2026-04-13 20:44:13.171199 | instance | ok: OK (64 bytes) 2026-04-13 20:44:13.181811 | 2026-04-13 20:44:13.181945 | TASK [ensure-go : Download go archive] 2026-04-13 20:44:14.994523 | instance | changed: OK (78559214 bytes) 2026-04-13 20:44:15.004294 | 2026-04-13 20:44:15.004553 | TASK [ensure-go : Install go] 2026-04-13 20:44:20.873634 | instance | changed 2026-04-13 20:44:20.883447 | 2026-04-13 20:44:20.883551 | PLAY [all] 2026-04-13 20:44:20.891397 | 2026-04-13 20:44:20.891506 | TASK [Build atmosphere binary] 2026-04-13 20:44:21.159528 | instance -> localhost | ERROR 2026-04-13 20:44:21.159870 | instance -> localhost | { 2026-04-13 20:44:21.159938 | instance -> localhost | "delta": null, 2026-04-13 20:44:21.160194 | instance -> localhost | "end": null, 2026-04-13 20:44:21.160239 | 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:21.160269 | instance -> localhost | "rc": null, 2026-04-13 20:44:21.160304 | instance -> localhost | "start": null 2026-04-13 20:44:21.160344 | instance -> localhost | } failure 2026-04-13 20:44:21.162708 | 2026-04-13 20:44:21.162804 | PLAY RECAP 2026-04-13 20:44:21.162897 | instance | ok: 9 changed: 6 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:44:21.162947 | 2026-04-13 20:44:21.370712 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 20:44:21.374788 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 20:44:22.253872 | 2026-04-13 20:44:22.254141 | PLAY [all] 2026-04-13 20:44:22.273756 | 2026-04-13 20:44:22.273997 | TASK [gather-host-logs : creating directory for system status] 2026-04-13 20:44:22.635638 | instance | changed 2026-04-13 20:44:22.644676 | 2026-04-13 20:44:22.644889 | TASK [gather-host-logs : Get logs for each host] 2026-04-13 20:44:23.003211 | instance | + systemd-cgls --full --all --no-pager 2026-04-13 20:44:23.010826 | instance | + ip addr 2026-04-13 20:44:23.013395 | instance | + ip route 2026-04-13 20:44:23.016623 | instance | + lsblk 2026-04-13 20:44:23.020263 | instance | + mount 2026-04-13 20:44:23.023279 | instance | + docker images 2026-04-13 20:44:23.023874 | instance | /bin/bash: line 7: docker: command not found 2026-04-13 20:44:23.024207 | instance | + brctl show 2026-04-13 20:44:23.024678 | instance | /bin/bash: line 8: brctl: command not found 2026-04-13 20:44:23.025022 | instance | + ps aux --sort=-%mem 2026-04-13 20:44:23.038221 | instance | + dpkg -l 2026-04-13 20:44:23.045888 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-13 20:44:23.046254 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-13 20:44:23.046303 | instance | /bin/bash: line 11: docker: command not found 2026-04-13 20:44:23.046548 | instance | + '[' '!' -z '' ']' 2026-04-13 20:44:23.196159 | instance | ok: Runtime: 0:00:00.048950 2026-04-13 20:44:23.203386 | 2026-04-13 20:44:23.203541 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-13 20:44:23.923681 | instance | changed: 2026-04-13 20:44:23.924436 | instance | created directory /var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/logs/instance 2026-04-13 20:44:23.924482 | instance | cd+++++++++ system/ 2026-04-13 20:44:23.924507 | instance | >f+++++++++ system/brctl-show.txt 2026-04-13 20:44:23.924533 | instance | >f+++++++++ system/docker-images.txt 2026-04-13 20:44:23.924563 | instance | >f+++++++++ system/ip-addr.txt 2026-04-13 20:44:23.924597 | instance | >f+++++++++ system/ip-route.txt 2026-04-13 20:44:23.924621 | instance | >f+++++++++ system/lsblk.txt 2026-04-13 20:44:23.924641 | instance | >f+++++++++ system/mount.txt 2026-04-13 20:44:23.924662 | instance | >f+++++++++ system/packages.txt 2026-04-13 20:44:23.924681 | instance | >f+++++++++ system/ps.txt 2026-04-13 20:44:23.924700 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-13 20:44:23.935664 | 2026-04-13 20:44:23.935801 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-13 20:44:24.195536 | instance | changed: "values" 2026-04-13 20:44:24.377934 | instance | changed: "releases" 2026-04-13 20:44:24.388146 | 2026-04-13 20:44:24.388313 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-13 20:44:24.592608 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-13 20:44:25.099577 | instance | ok: Runtime: 0:00:00.007520 2026-04-13 20:44:25.107061 | 2026-04-13 20:44:25.107268 | TASK [helm-release-status : Downloads logs to executor] 2026-04-13 20:44:25.643071 | instance | changed: 2026-04-13 20:44:25.643262 | instance | cd+++++++++ helm/ 2026-04-13 20:44:25.643311 | instance | cd+++++++++ helm/releases/ 2026-04-13 20:44:25.643353 | instance | cd+++++++++ helm/values/ 2026-04-13 20:44:25.658158 | 2026-04-13 20:44:25.658330 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-13 20:44:25.886725 | instance | changed 2026-04-13 20:44:25.895718 | 2026-04-13 20:44:25.896001 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-13 20:44:26.131408 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:26.131823 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:26.136151 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:26.137519 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:26.138637 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:26.139727 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:26.141115 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:26.142304 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:26.142486 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:26.143653 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:26.144782 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:44:26.145979 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:44:26.442469 | instance | ok: Runtime: 0:00:00.026966 2026-04-13 20:44:26.448004 | 2026-04-13 20:44:26.448094 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-13 20:44:26.656005 | instance | changed 2026-04-13 20:44:26.665043 | 2026-04-13 20:44:26.665213 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-13 20:44:26.962222 | instance | environment: line 5: kubectl: command not found 2026-04-13 20:44:26.963468 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:26.963696 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:26.964566 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:44:27.356683 | instance | ok: Runtime: 0:00:00.010407 2026-04-13 20:44:27.363992 | 2026-04-13 20:44:27.364105 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-13 20:44:28.419081 | instance | changed: 2026-04-13 20:44:28.419348 | instance | cd+++++++++ objects/ 2026-04-13 20:44:28.419393 | instance | cd+++++++++ objects/cluster/ 2026-04-13 20:44:28.419427 | instance | cd+++++++++ objects/namespaced/ 2026-04-13 20:44:28.431866 | 2026-04-13 20:44:28.431958 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-13 20:44:28.628291 | instance | changed 2026-04-13 20:44:28.635527 | 2026-04-13 20:44:28.635630 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-13 20:44:28.847170 | instance | changed 2026-04-13 20:44:28.852755 | 2026-04-13 20:44:28.852848 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-13 20:44:29.069718 | instance | environment: line 3: kubectl: command not found 2026-04-13 20:44:29.394676 | instance | ok: Runtime: 0:00:00.007923 2026-04-13 20:44:29.400135 | 2026-04-13 20:44:29.400210 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-13 20:44:29.980285 | instance | changed: 2026-04-13 20:44:29.980502 | instance | cd+++++++++ pod-logs/ 2026-04-13 20:44:29.980544 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-13 20:44:29.993260 | 2026-04-13 20:44:29.993367 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-13 20:44:30.197102 | instance | changed 2026-04-13 20:44:30.204496 | 2026-04-13 20:44:30.204657 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-13 20:44:30.452852 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 20:44:30.743452 | instance | ok: Runtime: 0:00:00.037691 2026-04-13 20:44:30.749094 | 2026-04-13 20:44:30.749180 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-13 20:44:30.960243 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 20:44:30.988556 | instance | ceph-mgr endpoints: 2026-04-13 20:44:31.285975 | instance | ok: Runtime: 0:00:00.033276 2026-04-13 20:44:31.295930 | 2026-04-13 20:44:31.296124 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-13 20:44:31.519376 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-13 20:44:31.854943 | instance | ok: Runtime: 0:00:00.041345 2026-04-13 20:44:31.862480 | 2026-04-13 20:44:31.862635 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-13 20:44:32.442042 | instance | changed: cd+++++++++ prometheus/ 2026-04-13 20:44:32.469121 | 2026-04-13 20:44:32.469333 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-13 20:44:32.673564 | instance | changed 2026-04-13 20:44:32.681863 | 2026-04-13 20:44:32.682038 | TASK [gather-selenium-data : Get selenium data] 2026-04-13 20:44:32.920591 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-13 20:44:32.922154 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-13 20:44:33.228535 | instance | ERROR 2026-04-13 20:44:33.228722 | instance | { 2026-04-13 20:44:33.229029 | instance | "delta": "0:00:00.005898", 2026-04-13 20:44:33.229146 | instance | "end": "2026-04-13 20:44:32.922529", 2026-04-13 20:44:33.229168 | instance | "msg": "non-zero return code", 2026-04-13 20:44:33.229189 | instance | "rc": 1, 2026-04-13 20:44:33.229217 | instance | "start": "2026-04-13 20:44:32.916631" 2026-04-13 20:44:33.229245 | instance | } 2026-04-13 20:44:33.229299 | instance | ERROR: Ignoring Errors 2026-04-13 20:44:33.236824 | 2026-04-13 20:44:33.236939 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-13 20:44:33.781675 | instance | changed: cd+++++++++ selenium/ 2026-04-13 20:44:33.790230 | 2026-04-13 20:44:33.790295 | PLAY RECAP 2026-04-13 20:44:33.790341 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-13 20:44:33.790363 | 2026-04-13 20:44:33.919632 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 20:44:33.921995 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 20:44:34.539960 | 2026-04-13 20:44:34.540126 | PLAY [all] 2026-04-13 20:44:34.553459 | 2026-04-13 20:44:34.553587 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-13 20:44:34.598119 | instance | skipping: Conditional result was False 2026-04-13 20:44:34.608742 | 2026-04-13 20:44:34.608889 | TASK [fetch-output : Set log path for single node] 2026-04-13 20:44:34.652751 | instance | ok 2026-04-13 20:44:34.657626 | 2026-04-13 20:44:34.657717 | LOOP [fetch-output : Ensure local output dirs] 2026-04-13 20:44:35.091717 | instance -> localhost | ok: "/var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/logs" 2026-04-13 20:44:35.356621 | instance -> localhost | changed: "/var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/artifacts" 2026-04-13 20:44:35.794913 | instance -> localhost | changed: "/var/lib/zuul/builds/2df696be10b74f7f95962bacc8788232/work/docs" 2026-04-13 20:44:35.818289 | 2026-04-13 20:44:35.818458 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-13 20:44:36.475083 | instance | changed: .d..t...... ./ 2026-04-13 20:44:36.475276 | instance | changed: All items complete 2026-04-13 20:44:36.475376 | 2026-04-13 20:44:36.918773 | instance | changed: .d..t...... ./ 2026-04-13 20:44:37.450107 | instance | changed: .d..t...... ./ 2026-04-13 20:44:37.472537 | 2026-04-13 20:44:37.472677 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-13 20:44:37.926202 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007332 2026-04-13 20:44:38.219856 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008837 2026-04-13 20:44:38.238184 | 2026-04-13 20:44:38.238329 | PLAY [all] 2026-04-13 20:44:38.246995 | 2026-04-13 20:44:38.247147 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-13 20:44:38.753677 | instance | changed 2026-04-13 20:44:38.760970 | 2026-04-13 20:44:38.761052 | PLAY RECAP 2026-04-13 20:44:38.761111 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 20:44:38.761135 | 2026-04-13 20:44:38.877514 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 20:44:38.880242 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-13 20:44:39.479533 | 2026-04-13 20:44:39.479692 | PLAY [localhost] 2026-04-13 20:44:39.490797 | 2026-04-13 20:44:39.490957 | TASK [Generate Zuul manifest] 2026-04-13 20:44:39.513931 | localhost | ok 2026-04-13 20:44:39.531987 | 2026-04-13 20:44:39.532148 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-13 20:44:39.930388 | localhost | changed 2026-04-13 20:44:39.945105 | 2026-04-13 20:44:39.945209 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-13 20:44:39.977007 | localhost | ok 2026-04-13 20:44:39.986303 | 2026-04-13 20:44:39.986392 | TASK [Upload logs] 2026-04-13 20:44:40.008078 | localhost | ok 2026-04-13 20:44:40.074976 | 2026-04-13 20:44:40.075096 | TASK [Set zuul-log-path fact] 2026-04-13 20:44:40.094058 | localhost | ok 2026-04-13 20:44:40.108391 | 2026-04-13 20:44:40.108501 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 20:44:40.140399 | localhost | ok 2026-04-13 20:44:40.152116 | 2026-04-13 20:44:40.152246 | TASK [upload-logs : Create log directories] 2026-04-13 20:44:40.611188 | localhost | changed 2026-04-13 20:44:40.619278 | 2026-04-13 20:44:40.619470 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-13 20:44:41.067949 | localhost -> localhost | ok: Runtime: 0:00:00.006574 2026-04-13 20:44:41.075121 | 2026-04-13 20:44:41.075242 | TASK [upload-logs : Upload logs to log server] 2026-04-13 20:44:41.715899 | localhost | Output suppressed because no_log was given 2026-04-13 20:44:41.722544 | 2026-04-13 20:44:41.722717 | LOOP [upload-logs : Compress console log and json output] 2026-04-13 20:44:41.777527 | localhost | skipping: Conditional result was False 2026-04-13 20:44:41.787298 | localhost | skipping: Conditional result was False 2026-04-13 20:44:41.800413 | 2026-04-13 20:44:41.800551 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-13 20:44:41.857517 | localhost | skipping: Conditional result was False 2026-04-13 20:44:41.857817 | 2026-04-13 20:44:41.866581 | localhost | skipping: Conditional result was False 2026-04-13 20:44:41.873700 | 2026-04-13 20:44:41.874134 | LOOP [upload-logs : Upload console log and json output]