2026-04-16 00:16:20.334040 | Job console starting 2026-04-16 00:16:20.344915 | Updating git repos 2026-04-16 00:16:20.447646 | Cloning repos into workspace 2026-04-16 00:16:20.524654 | Restoring repo states 2026-04-16 00:16:20.550299 | Merging changes 2026-04-16 00:16:21.532645 | Checking out repos 2026-04-16 00:16:21.634856 | Preparing playbooks 2026-04-16 00:16:24.105270 | Running Ansible setup 2026-04-16 00:16:27.275482 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-16 00:16:27.829218 | 2026-04-16 00:16:27.829341 | PLAY [localhost] 2026-04-16 00:16:27.836940 | 2026-04-16 00:16:27.837029 | TASK [Gathering Facts] 2026-04-16 00:16:29.341897 | localhost | ok 2026-04-16 00:16:29.352318 | 2026-04-16 00:16:29.352415 | TASK [Setup log path fact] 2026-04-16 00:16:29.371847 | localhost | ok 2026-04-16 00:16:29.382545 | 2026-04-16 00:16:29.382605 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-16 00:16:29.411104 | localhost | ok 2026-04-16 00:16:29.418792 | 2026-04-16 00:16:29.418881 | TASK [emit-job-header : Print job information] 2026-04-16 00:16:29.459074 | # Job Information 2026-04-16 00:16:29.459259 | Ansible Version: 2.16.16 2026-04-16 00:16:29.459306 | Job: atmosphere-molecule-csi-rbd 2026-04-16 00:16:29.459338 | Pipeline: check 2026-04-16 00:16:29.459367 | Executor: 0a8996d2b663 2026-04-16 00:16:29.459396 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3835 2026-04-16 00:16:29.459429 | Event ID: 69329484-3929-11f1-806c-0c126485a0af 2026-04-16 00:16:29.463330 | 2026-04-16 00:16:29.463419 | LOOP [emit-job-header : Print node information] 2026-04-16 00:16:29.573554 | localhost | ok: 2026-04-16 00:16:29.574181 | localhost | # Node Information 2026-04-16 00:16:29.574212 | localhost | Inventory Hostname: instance 2026-04-16 00:16:29.574234 | localhost | Hostname: np0000166502 2026-04-16 00:16:29.574253 | localhost | Username: zuul 2026-04-16 00:16:29.574275 | localhost | Distro: Ubuntu 22.04 2026-04-16 00:16:29.574294 | localhost | Provider: yul1 2026-04-16 00:16:29.574313 | localhost | Region: ca-ymq-1 2026-04-16 00:16:29.574330 | localhost | Label: ubuntu-jammy 2026-04-16 00:16:29.574348 | localhost | Product Name: OpenStack Nova 2026-04-16 00:16:29.574365 | localhost | Interface IP: 199.204.45.169 2026-04-16 00:16:29.586391 | 2026-04-16 00:16:29.586500 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-16 00:16:29.954779 | localhost -> localhost | changed 2026-04-16 00:16:29.961990 | 2026-04-16 00:16:29.962079 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-16 00:16:30.756884 | localhost -> localhost | changed 2026-04-16 00:16:30.767379 | 2026-04-16 00:16:30.767433 | PLAY [all] 2026-04-16 00:16:30.775797 | 2026-04-16 00:16:30.775861 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-16 00:16:30.991638 | instance -> localhost | ok 2026-04-16 00:16:31.001304 | 2026-04-16 00:16:31.001390 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-16 00:16:31.042986 | instance | ok 2026-04-16 00:16:31.056039 | instance | included: /var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-16 00:16:31.061601 | 2026-04-16 00:16:31.061683 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-16 00:16:31.913473 | instance -> localhost | Generating public/private rsa key pair. 2026-04-16 00:16:31.913736 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/c8bfed6369664973a1ed5167fca749c4_id_rsa 2026-04-16 00:16:31.913801 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/c8bfed6369664973a1ed5167fca749c4_id_rsa.pub 2026-04-16 00:16:31.913853 | instance -> localhost | The key fingerprint is: 2026-04-16 00:16:31.913953 | instance -> localhost | SHA256:A7k2iVllU/eopU2m2DD7EtFF/FnOuFORJ/tC/jbI4Sc zuul-build-sshkey 2026-04-16 00:16:31.914028 | instance -> localhost | The key's randomart image is: 2026-04-16 00:16:31.914078 | instance -> localhost | +---[RSA 3072]----+ 2026-04-16 00:16:31.914136 | instance -> localhost | | +..o+ .| 2026-04-16 00:16:31.914184 | instance -> localhost | | + o o.o.oo| 2026-04-16 00:16:31.914229 | instance -> localhost | | + + . =..Oo| 2026-04-16 00:16:31.914274 | instance -> localhost | | + + B O * +| 2026-04-16 00:16:31.914308 | instance -> localhost | | o = S = .o + | 2026-04-16 00:16:31.914329 | instance -> localhost | | . . + .= .| 2026-04-16 00:16:31.914363 | instance -> localhost | | . . o o+ | 2026-04-16 00:16:31.914385 | instance -> localhost | | . E oo| 2026-04-16 00:16:31.914407 | instance -> localhost | | o..| 2026-04-16 00:16:31.914428 | instance -> localhost | +----[SHA256]-----+ 2026-04-16 00:16:31.914477 | instance -> localhost | ok: Runtime: 0:00:00.447687 2026-04-16 00:16:31.931416 | 2026-04-16 00:16:31.931478 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-16 00:16:31.964691 | instance | ok 2026-04-16 00:16:31.974246 | instance | included: /var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-16 00:16:31.981683 | 2026-04-16 00:16:31.981743 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-16 00:16:32.006423 | instance | skipping: Conditional result was False 2026-04-16 00:16:32.015861 | 2026-04-16 00:16:32.015925 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-16 00:16:32.455855 | instance | changed 2026-04-16 00:16:32.460740 | 2026-04-16 00:16:32.460813 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-16 00:16:32.635521 | instance | ok 2026-04-16 00:16:32.640449 | 2026-04-16 00:16:32.640512 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-16 00:16:33.090515 | instance | changed 2026-04-16 00:16:33.097626 | 2026-04-16 00:16:33.097735 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-16 00:16:33.566731 | instance | changed 2026-04-16 00:16:33.574413 | 2026-04-16 00:16:33.574515 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-16 00:16:33.599885 | instance | skipping: Conditional result was False 2026-04-16 00:16:33.608470 | 2026-04-16 00:16:33.608618 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-16 00:16:33.998187 | instance -> localhost | changed 2026-04-16 00:16:34.013541 | 2026-04-16 00:16:34.013649 | TASK [add-build-sshkey : Add back temp key] 2026-04-16 00:16:34.310817 | instance -> localhost | Identity added: /var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/c8bfed6369664973a1ed5167fca749c4_id_rsa (zuul-build-sshkey) 2026-04-16 00:16:34.311128 | instance -> localhost | ok: Runtime: 0:00:00.013888 2026-04-16 00:16:34.319951 | 2026-04-16 00:16:34.320039 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-16 00:16:34.655755 | instance | ok 2026-04-16 00:16:34.788236 | 2026-04-16 00:16:34.788368 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-16 00:16:34.813407 | instance | skipping: Conditional result was False 2026-04-16 00:16:34.828497 | 2026-04-16 00:16:34.828562 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-16 00:16:35.140312 | instance | ok 2026-04-16 00:16:35.147863 | 2026-04-16 00:16:35.147929 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-16 00:16:36.773512 | instance | Output suppressed because no_log was given 2026-04-16 00:16:36.784831 | 2026-04-16 00:16:36.784897 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-16 00:16:36.964925 | instance | ok: "logs" 2026-04-16 00:16:36.965175 | instance | ok: All items complete 2026-04-16 00:16:36.965203 | 2026-04-16 00:16:37.109890 | instance | ok: "artifacts" 2026-04-16 00:16:37.262901 | instance | ok: "docs" 2026-04-16 00:16:37.285258 | 2026-04-16 00:16:37.285394 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-16 00:16:37.476205 | instance | changed: "logs" 2026-04-16 00:16:37.625376 | instance | changed: "artifacts" 2026-04-16 00:16:37.766462 | instance | changed: "docs" 2026-04-16 00:16:37.907536 | 2026-04-16 00:16:37.907646 | PLAY RECAP 2026-04-16 00:16:37.907695 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-16 00:16:37.907725 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:16:37.907744 | 2026-04-16 00:16:38.020240 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-16 00:16:38.023009 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-16 00:16:38.621292 | 2026-04-16 00:16:38.621412 | PLAY [all] 2026-04-16 00:16:38.632630 | 2026-04-16 00:16:38.632702 | TASK [setup-uv : Extract archive] 2026-04-16 00:16:41.802822 | instance | changed 2026-04-16 00:16:41.810348 | 2026-04-16 00:16:41.810451 | TASK [setup-uv : Print version] 2026-04-16 00:16:41.291073 | instance | uv 0.8.13 2026-04-16 00:16:42.348184 | instance | ok: Runtime: 0:00:00.012906 2026-04-16 00:16:42.354894 | 2026-04-16 00:16:42.354943 | PLAY RECAP 2026-04-16 00:16:42.354987 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:16:42.355013 | 2026-04-16 00:16:42.455218 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-16 00:16:42.459120 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre-install-deps.yml@main] 2026-04-16 00:16:42.998660 | 2026-04-16 00:16:42.998815 | PLAY [all] 2026-04-16 00:16:43.011461 | 2026-04-16 00:16:43.011574 | TASK [Install system packages] 2026-04-16 00:17:08.919860 | instance | changed 2026-04-16 00:17:08.939584 | 2026-04-16 00:17:08.939924 | TASK [Enable iscsid service] 2026-04-16 00:17:10.041428 | instance | changed 2026-04-16 00:17:10.048747 | 2026-04-16 00:17:10.048824 | TASK [Enable multipathd service] 2026-04-16 00:17:10.378072 | instance | ok 2026-04-16 00:17:10.385882 | 2026-04-16 00:17:10.385959 | TASK [Install Helm 3.14.4] 2026-04-16 00:17:11.925641 | instance | ok: Runtime: 0:00:00.777568 2026-04-16 00:17:11.930922 | 2026-04-16 00:17:11.930989 | TASK [Install Go 1.24.2] 2026-04-16 00:17:14.972497 | instance | ok: Runtime: 0:00:02.378507 2026-04-16 00:17:14.978030 | 2026-04-16 00:17:14.978093 | TASK [Create Python venv and install openstacksdk] 2026-04-16 00:17:31.257113 | instance | changed 2026-04-16 00:17:31.260982 | 2026-04-16 00:17:31.261049 | PLAY RECAP 2026-04-16 00:17:31.261113 | instance | ok: 6 changed: 5 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:17:31.261142 | 2026-04-16 00:17:31.398267 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre-install-deps.yml@main] 2026-04-16 00:17:31.403178 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-16 00:17:32.204738 | 2026-04-16 00:17:32.204871 | PLAY [all] 2026-04-16 00:17:32.211175 | 2026-04-16 00:17:32.211240 | PLAY RECAP 2026-04-16 00:17:32.211273 | 2026-04-16 00:17:32.316379 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-16 00:17:32.371355 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/csi/converge.yml@main] 2026-04-16 00:17:32.958950 | 2026-04-16 00:17:32.959074 | PLAY [all] 2026-04-16 00:17:32.970304 | 2026-04-16 00:17:32.970381 | TASK [Build atmosphere binary] 2026-04-16 00:17:33.317917 | instance | go: downloading go1.24.4 (linux/amd64) 2026-04-16 00:17:38.880617 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-04-16 00:17:38.886242 | instance | go: downloading golang.org/x/sync v0.18.0 2026-04-16 00:17:39.042804 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-04-16 00:17:46.026011 | instance | ok: Runtime: 0:00:12.201607 2026-04-16 00:17:46.032419 | 2026-04-16 00:17:46.032495 | TASK [Deploy with parallel orchestrator] 2026-04-16 00:17:46.242986 | instance | /bin/bash: line 1: .venv/bin/activate: No such file or directory 2026-04-16 00:17:46.573884 | instance | ERROR 2026-04-16 00:17:46.574176 | instance | { 2026-04-16 00:17:46.574207 | instance | "delta": "0:00:00.008542", 2026-04-16 00:17:46.574230 | instance | "end": "2026-04-16 00:17:46.243407", 2026-04-16 00:17:46.574249 | instance | "msg": "non-zero return code", 2026-04-16 00:17:46.574268 | instance | "rc": 1, 2026-04-16 00:17:46.574286 | instance | "start": "2026-04-16 00:17:46.234865" 2026-04-16 00:17:46.574311 | instance | } failure 2026-04-16 00:17:46.576206 | 2026-04-16 00:17:46.576255 | PLAY RECAP 2026-04-16 00:17:46.576305 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:17:46.576327 | 2026-04-16 00:17:46.718396 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/csi/converge.yml@main] 2026-04-16 00:17:46.722674 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-16 00:17:47.308706 | 2026-04-16 00:17:47.308837 | PLAY [all] 2026-04-16 00:17:47.324830 | 2026-04-16 00:17:47.324913 | TASK [gather-host-logs : creating directory for system status] 2026-04-16 00:17:47.712799 | instance | changed 2026-04-16 00:17:47.719212 | 2026-04-16 00:17:47.719291 | TASK [gather-host-logs : Get logs for each host] 2026-04-16 00:17:48.087670 | instance | + systemd-cgls --full --all --no-pager 2026-04-16 00:17:48.099440 | instance | + ip addr 2026-04-16 00:17:48.100742 | instance | + ip route 2026-04-16 00:17:48.101867 | instance | + lsblk 2026-04-16 00:17:48.103809 | instance | + mount 2026-04-16 00:17:48.105104 | instance | + docker images 2026-04-16 00:17:48.105444 | instance | /bin/bash: line 7: docker: command not found 2026-04-16 00:17:48.105570 | instance | + brctl show 2026-04-16 00:17:48.105887 | instance | /bin/bash: line 8: brctl: command not found 2026-04-16 00:17:48.106054 | instance | + ps aux --sort=-%mem 2026-04-16 00:17:48.116990 | instance | + dpkg -l 2026-04-16 00:17:48.124525 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-16 00:17:48.124899 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-16 00:17:48.124949 | instance | /bin/bash: line 11: docker: command not found 2026-04-16 00:17:48.125226 | instance | + '[' '!' -z '' ']' 2026-04-16 00:17:48.255050 | instance | ok: Runtime: 0:00:00.042637 2026-04-16 00:17:48.263539 | 2026-04-16 00:17:48.263634 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-16 00:17:48.895838 | instance | changed: 2026-04-16 00:17:48.896051 | instance | created directory /var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/logs/instance 2026-04-16 00:17:48.896093 | instance | cd+++++++++ system/ 2026-04-16 00:17:48.896125 | instance | >f+++++++++ system/brctl-show.txt 2026-04-16 00:17:48.896154 | instance | >f+++++++++ system/docker-images.txt 2026-04-16 00:17:48.896183 | instance | >f+++++++++ system/ip-addr.txt 2026-04-16 00:17:48.896215 | instance | >f+++++++++ system/ip-route.txt 2026-04-16 00:17:48.896245 | instance | >f+++++++++ system/lsblk.txt 2026-04-16 00:17:48.896273 | instance | >f+++++++++ system/mount.txt 2026-04-16 00:17:48.896305 | instance | >f+++++++++ system/packages.txt 2026-04-16 00:17:48.896333 | instance | >f+++++++++ system/ps.txt 2026-04-16 00:17:48.896361 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-16 00:17:48.907804 | 2026-04-16 00:17:48.907944 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-16 00:17:49.118480 | instance | changed: "values" 2026-04-16 00:17:49.287072 | instance | changed: "releases" 2026-04-16 00:17:49.308058 | 2026-04-16 00:17:49.308153 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-16 00:17:49.513648 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-16 00:17:49.846538 | instance | ok: Runtime: 0:00:00.005965 2026-04-16 00:17:49.853865 | 2026-04-16 00:17:49.853935 | TASK [helm-release-status : Downloads logs to executor] 2026-04-16 00:17:50.327238 | instance | changed: 2026-04-16 00:17:50.327408 | instance | cd+++++++++ helm/ 2026-04-16 00:17:50.327436 | instance | cd+++++++++ helm/releases/ 2026-04-16 00:17:50.327458 | instance | cd+++++++++ helm/values/ 2026-04-16 00:17:50.336656 | 2026-04-16 00:17:50.336727 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-16 00:17:50.562354 | instance | changed 2026-04-16 00:17:50.568937 | 2026-04-16 00:17:50.569026 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-16 00:17:50.773303 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:50.773522 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:50.779390 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:50.780792 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:50.781433 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:50.783033 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:50.783603 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:50.784426 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:50.785755 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:50.787243 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:50.788893 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:50.789741 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:51.105394 | instance | ok: Runtime: 0:00:00.025323 2026-04-16 00:17:51.112025 | 2026-04-16 00:17:51.112101 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-16 00:17:51.309366 | instance | changed 2026-04-16 00:17:51.315241 | 2026-04-16 00:17:51.315314 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-16 00:17:51.550886 | instance | environment: line 5: kubectl: command not found 2026-04-16 00:17:51.552016 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:51.552147 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:51.552846 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:51.884435 | instance | ok: Runtime: 0:00:00.009379 2026-04-16 00:17:51.890186 | 2026-04-16 00:17:51.890257 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-16 00:17:52.400190 | instance | changed: 2026-04-16 00:17:52.400360 | instance | cd+++++++++ objects/ 2026-04-16 00:17:52.400388 | instance | cd+++++++++ objects/cluster/ 2026-04-16 00:17:52.400410 | instance | cd+++++++++ objects/namespaced/ 2026-04-16 00:17:52.409351 | 2026-04-16 00:17:52.409415 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-16 00:17:52.605129 | instance | changed 2026-04-16 00:17:52.611658 | 2026-04-16 00:17:52.611720 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-16 00:17:52.828890 | instance | changed 2026-04-16 00:17:52.833655 | 2026-04-16 00:17:52.833720 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-16 00:17:53.039818 | instance | environment: line 3: kubectl: command not found 2026-04-16 00:17:53.369779 | instance | ok: Runtime: 0:00:00.010014 2026-04-16 00:17:53.375899 | 2026-04-16 00:17:53.375963 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-16 00:17:53.864300 | instance | changed: 2026-04-16 00:17:53.864510 | instance | cd+++++++++ pod-logs/ 2026-04-16 00:17:53.864548 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-16 00:17:53.876151 | 2026-04-16 00:17:53.876215 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-16 00:17:54.081277 | instance | changed 2026-04-16 00:17:54.087912 | 2026-04-16 00:17:54.088008 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-16 00:17:54.288564 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-16 00:17:54.621716 | instance | ok: Runtime: 0:00:00.036172 2026-04-16 00:17:54.626525 | 2026-04-16 00:17:54.626589 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-16 00:17:54.839843 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-16 00:17:54.867790 | instance | ceph-mgr endpoints: 2026-04-16 00:17:55.161918 | instance | ok: Runtime: 0:00:00.035312 2026-04-16 00:17:55.168014 | 2026-04-16 00:17:55.168077 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-16 00:17:55.367096 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-16 00:17:55.702863 | instance | ok: Runtime: 0:00:00.042715 2026-04-16 00:17:55.709914 | 2026-04-16 00:17:55.710011 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-16 00:17:56.207168 | instance | changed: cd+++++++++ prometheus/ 2026-04-16 00:17:56.217619 | 2026-04-16 00:17:56.217682 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-16 00:17:56.414131 | instance | changed 2026-04-16 00:17:56.418777 | 2026-04-16 00:17:56.418838 | TASK [gather-selenium-data : Get selenium data] 2026-04-16 00:17:56.611769 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-16 00:17:56.612926 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-16 00:17:56.952560 | instance | ERROR 2026-04-16 00:17:56.952792 | instance | { 2026-04-16 00:17:56.952858 | instance | "delta": "0:00:00.006577", 2026-04-16 00:17:56.952906 | instance | "end": "2026-04-16 00:17:56.613241", 2026-04-16 00:17:56.952949 | instance | "msg": "non-zero return code", 2026-04-16 00:17:56.953042 | instance | "rc": 1, 2026-04-16 00:17:56.953073 | instance | "start": "2026-04-16 00:17:56.606664" 2026-04-16 00:17:56.953091 | instance | } 2026-04-16 00:17:56.953115 | instance | ERROR: Ignoring Errors 2026-04-16 00:17:56.957845 | 2026-04-16 00:17:56.957907 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-16 00:17:57.437571 | instance | changed: cd+++++++++ selenium/ 2026-04-16 00:17:57.443410 | 2026-04-16 00:17:57.443462 | PLAY RECAP 2026-04-16 00:17:57.443509 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-16 00:17:57.443532 | 2026-04-16 00:17:57.560826 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-16 00:17:57.565024 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-16 00:17:58.142699 | 2026-04-16 00:17:58.143039 | PLAY [all] 2026-04-16 00:17:58.159157 | 2026-04-16 00:17:58.159256 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-16 00:17:58.206124 | instance | skipping: Conditional result was False 2026-04-16 00:17:58.216019 | 2026-04-16 00:17:58.216131 | TASK [fetch-output : Set log path for single node] 2026-04-16 00:17:58.259204 | instance | ok 2026-04-16 00:17:58.266029 | 2026-04-16 00:17:58.266127 | LOOP [fetch-output : Ensure local output dirs] 2026-04-16 00:17:58.666057 | instance -> localhost | ok: "/var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/logs" 2026-04-16 00:17:58.892857 | instance -> localhost | changed: "/var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/artifacts" 2026-04-16 00:17:59.093934 | instance -> localhost | changed: "/var/lib/zuul/builds/c8bfed6369664973a1ed5167fca749c4/work/docs" 2026-04-16 00:17:59.111640 | 2026-04-16 00:17:59.111806 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-16 00:17:59.743088 | instance | changed: .d..t...... ./ 2026-04-16 00:17:59.743342 | instance | changed: All items complete 2026-04-16 00:17:59.743369 | 2026-04-16 00:18:00.189730 | instance | changed: .d..t...... ./ 2026-04-16 00:18:00.654783 | instance | changed: .d..t...... ./ 2026-04-16 00:18:00.675598 | 2026-04-16 00:18:00.675732 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-16 00:18:01.091503 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007132 2026-04-16 00:18:01.310093 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007005 2026-04-16 00:18:01.325626 | 2026-04-16 00:18:01.325740 | PLAY [all] 2026-04-16 00:18:01.332536 | 2026-04-16 00:18:01.332601 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-16 00:18:01.740696 | instance | changed 2026-04-16 00:18:01.746861 | 2026-04-16 00:18:01.808170 | PLAY RECAP 2026-04-16 00:18:01.808321 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-16 00:18:01.808379 | 2026-04-16 00:18:01.917744 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-16 00:18:01.922193 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-16 00:18:02.489732 | 2026-04-16 00:18:02.489852 | PLAY [localhost] 2026-04-16 00:18:02.499290 | 2026-04-16 00:18:02.499360 | TASK [Generate Zuul manifest] 2026-04-16 00:18:02.521768 | localhost | ok 2026-04-16 00:18:02.535479 | 2026-04-16 00:18:02.535551 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-16 00:18:02.867169 | localhost | changed 2026-04-16 00:18:02.879988 | 2026-04-16 00:18:02.880067 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-16 00:18:02.909182 | localhost | ok 2026-04-16 00:18:02.917053 | 2026-04-16 00:18:02.917118 | TASK [Upload logs] 2026-04-16 00:18:02.949577 | localhost | ok 2026-04-16 00:18:03.003665 | 2026-04-16 00:18:03.003777 | TASK [Set zuul-log-path fact] 2026-04-16 00:18:03.024915 | localhost | ok 2026-04-16 00:18:03.037833 | 2026-04-16 00:18:03.037955 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-16 00:18:03.070469 | localhost | ok 2026-04-16 00:18:03.093023 | 2026-04-16 00:18:03.093101 | TASK [upload-logs : Create log directories] 2026-04-16 00:18:03.478177 | localhost | changed 2026-04-16 00:18:03.484617 | 2026-04-16 00:18:03.484712 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-16 00:18:03.890430 | localhost -> localhost | ok: Runtime: 0:00:00.006611 2026-04-16 00:18:03.895343 | 2026-04-16 00:18:03.895411 | TASK [upload-logs : Upload logs to log server] 2026-04-16 00:18:04.391707 | localhost | Output suppressed because no_log was given 2026-04-16 00:18:04.396488 | 2026-04-16 00:18:04.396577 | LOOP [upload-logs : Compress console log and json output] 2026-04-16 00:18:04.454043 | localhost | skipping: Conditional result was False 2026-04-16 00:18:04.454798 | localhost | skipping: Conditional result was False 2026-04-16 00:18:04.470484 | 2026-04-16 00:18:04.470573 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-16 00:18:04.510728 | localhost | skipping: Conditional result was False 2026-04-16 00:18:04.511067 | 2026-04-16 00:18:04.520008 | localhost | skipping: Conditional result was False 2026-04-16 00:18:04.533654 | 2026-04-16 00:18:04.533830 | LOOP [upload-logs : Upload console log and json output]