2026-03-17 15:00:12.729755 | Job console starting 2026-03-17 15:00:12.744633 | Updating git repos 2026-03-17 15:00:12.815776 | Cloning repos into workspace 2026-03-17 15:00:12.873423 | Restoring repo states 2026-03-17 15:00:12.895190 | Merging changes 2026-03-17 15:00:13.922567 | Checking out repos 2026-03-17 15:00:14.327512 | Preparing playbooks 2026-03-17 15:00:16.998681 | Running Ansible setup 2026-03-17 15:00:20.361262 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 15:00:20.950330 | 2026-03-17 15:00:20.950516 | PLAY [localhost] 2026-03-17 15:00:20.962117 | 2026-03-17 15:00:20.962271 | TASK [Gathering Facts] 2026-03-17 15:00:21.876823 | localhost | ok 2026-03-17 15:00:21.887024 | 2026-03-17 15:00:21.887147 | TASK [Setup log path fact] 2026-03-17 15:00:21.909394 | localhost | ok 2026-03-17 15:00:21.922541 | 2026-03-17 15:00:21.925209 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 15:00:21.957086 | localhost | ok 2026-03-17 15:00:21.968084 | 2026-03-17 15:00:21.970323 | TASK [emit-job-header : Print job information] 2026-03-17 15:00:22.012644 | # Job Information 2026-03-17 15:00:22.012902 | Ansible Version: 2.16.16 2026-03-17 15:00:22.012950 | Job: atmosphere-molecule-csi-rbd 2026-03-17 15:00:22.013013 | Pipeline: check 2026-03-17 15:00:22.013043 | Executor: 0a8996d2b663 2026-03-17 15:00:22.013072 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3736 2026-03-17 15:00:22.013105 | Event ID: 95a80140-2211-11f1-8657-3af9ed05a18b 2026-03-17 15:00:22.017545 | 2026-03-17 15:00:22.017645 | LOOP [emit-job-header : Print node information] 2026-03-17 15:00:22.113398 | localhost | ok: 2026-03-17 15:00:22.113599 | localhost | # Node Information 2026-03-17 15:00:22.113638 | localhost | Inventory Hostname: instance 2026-03-17 15:00:22.113668 | localhost | Hostname: np0000159392 2026-03-17 15:00:22.113695 | localhost | Username: zuul 2026-03-17 15:00:22.113725 | localhost | Distro: Ubuntu 22.04 2026-03-17 15:00:22.113752 | localhost | Provider: yul1 2026-03-17 15:00:22.113777 | localhost | Region: ca-ymq-1 2026-03-17 15:00:22.113803 | localhost | Label: ubuntu-jammy 2026-03-17 15:00:22.113835 | localhost | Product Name: OpenStack Nova 2026-03-17 15:00:22.113872 | localhost | Interface IP: 199.19.213.247 2026-03-17 15:00:22.138717 | 2026-03-17 15:00:22.139216 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-17 15:00:22.520729 | localhost -> localhost | changed 2026-03-17 15:00:22.530697 | 2026-03-17 15:00:22.530841 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-17 15:00:23.521086 | localhost -> localhost | changed 2026-03-17 15:00:23.531521 | 2026-03-17 15:00:23.531618 | PLAY [all] 2026-03-17 15:00:23.541455 | 2026-03-17 15:00:23.541523 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 15:00:23.800270 | instance -> localhost | ok 2026-03-17 15:00:23.808605 | 2026-03-17 15:00:23.808704 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 15:00:23.837550 | instance | ok 2026-03-17 15:00:23.862434 | instance | included: /var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 15:00:23.868765 | 2026-03-17 15:00:23.868852 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 15:00:26.985042 | instance -> localhost | Generating public/private rsa key pair. 2026-03-17 15:00:26.985330 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/40bc8ee0f0b54abf8680b2c0eeda9857_id_rsa 2026-03-17 15:00:26.985383 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/40bc8ee0f0b54abf8680b2c0eeda9857_id_rsa.pub 2026-03-17 15:00:26.985418 | instance -> localhost | The key fingerprint is: 2026-03-17 15:00:26.985626 | instance -> localhost | SHA256:Q5SSGFW/GEbDFu4H2BJBsAyl0wDM5QmcDQljpgx4auw zuul-build-sshkey 2026-03-17 15:00:26.985798 | instance -> localhost | The key's randomart image is: 2026-03-17 15:00:26.985847 | instance -> localhost | +---[RSA 3072]----+ 2026-03-17 15:00:26.985893 | instance -> localhost | |@*Oo+*==*o | 2026-03-17 15:00:26.985933 | instance -> localhost | |BB+Bo.oB+o | 2026-03-17 15:00:26.985968 | instance -> localhost | |o+oo+ ooB . | 2026-03-17 15:00:26.986004 | instance -> localhost | |.o . = + . | 2026-03-17 15:00:26.986039 | instance -> localhost | |o S o | 2026-03-17 15:00:26.986076 | instance -> localhost | | E o | 2026-03-17 15:00:26.986114 | instance -> localhost | | | 2026-03-17 15:00:26.986151 | instance -> localhost | | | 2026-03-17 15:00:26.986195 | instance -> localhost | | | 2026-03-17 15:00:26.986236 | instance -> localhost | +----[SHA256]-----+ 2026-03-17 15:00:26.986340 | instance -> localhost | ok: Runtime: 0:00:02.691517 2026-03-17 15:00:26.994416 | 2026-03-17 15:00:26.994624 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 15:00:27.028404 | instance | ok 2026-03-17 15:00:27.042214 | instance | included: /var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 15:00:27.054023 | 2026-03-17 15:00:27.054147 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 15:00:27.079567 | instance | skipping: Conditional result was False 2026-03-17 15:00:27.089082 | 2026-03-17 15:00:27.089235 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 15:00:27.572588 | instance | changed 2026-03-17 15:00:27.582350 | 2026-03-17 15:00:27.582515 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 15:00:27.782569 | instance | ok 2026-03-17 15:00:27.788405 | 2026-03-17 15:00:27.788535 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 15:00:28.278349 | instance | changed 2026-03-17 15:00:28.283551 | 2026-03-17 15:00:28.283656 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 15:00:28.741545 | instance | changed 2026-03-17 15:00:28.749135 | 2026-03-17 15:00:28.749254 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 15:00:28.773096 | instance | skipping: Conditional result was False 2026-03-17 15:00:28.780673 | 2026-03-17 15:00:28.780783 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 15:00:29.172460 | instance -> localhost | changed 2026-03-17 15:00:29.191033 | 2026-03-17 15:00:29.191280 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 15:00:29.486926 | instance -> localhost | Identity added: /var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/40bc8ee0f0b54abf8680b2c0eeda9857_id_rsa (zuul-build-sshkey) 2026-03-17 15:00:29.487304 | instance -> localhost | ok: Runtime: 0:00:00.013999 2026-03-17 15:00:29.498566 | 2026-03-17 15:00:29.498690 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 15:00:29.809855 | instance | ok 2026-03-17 15:00:29.814690 | 2026-03-17 15:00:29.814787 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 15:00:29.839065 | instance | skipping: Conditional result was False 2026-03-17 15:00:29.854479 | 2026-03-17 15:00:29.854645 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-17 15:00:30.170927 | instance | ok 2026-03-17 15:00:30.179445 | 2026-03-17 15:00:30.179519 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-17 15:00:31.775750 | instance | Output suppressed because no_log was given 2026-03-17 15:00:31.784695 | 2026-03-17 15:00:31.784769 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-17 15:00:31.992119 | instance | ok: "logs" 2026-03-17 15:00:31.992354 | instance | ok: All items complete 2026-03-17 15:00:31.992394 | 2026-03-17 15:00:32.159541 | instance | ok: "artifacts" 2026-03-17 15:00:32.318721 | instance | ok: "docs" 2026-03-17 15:00:32.330121 | 2026-03-17 15:00:32.330257 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-17 15:00:32.516758 | instance | changed: "logs" 2026-03-17 15:00:32.674763 | instance | changed: "artifacts" 2026-03-17 15:00:32.829493 | instance | changed: "docs" 2026-03-17 15:00:32.853017 | 2026-03-17 15:00:32.853158 | PLAY RECAP 2026-03-17 15:00:32.853235 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-17 15:00:32.853277 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 15:00:32.853311 | 2026-03-17 15:00:32.978741 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 15:00:32.981074 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 15:00:33.548564 | 2026-03-17 15:00:33.548671 | PLAY [all] 2026-03-17 15:00:33.559543 | 2026-03-17 15:00:33.559620 | TASK [setup-uv : Extract archive] 2026-03-17 15:00:35.917907 | instance | changed 2026-03-17 15:00:36.561364 | 2026-03-17 15:00:36.561601 | TASK [setup-uv : Print version] 2026-03-17 15:00:36.894195 | instance | uv 0.8.13 2026-03-17 15:00:37.100142 | instance | ok: Runtime: 0:00:00.011922 2026-03-17 15:00:37.108578 | 2026-03-17 15:00:37.108650 | PLAY RECAP 2026-03-17 15:00:37.108711 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 15:00:37.108747 | 2026-03-17 15:00:37.204779 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 15:00:37.208746 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/2024.1] 2026-03-17 15:00:37.820870 | 2026-03-17 15:00:37.821029 | PLAY [all] 2026-03-17 15:00:37.832303 | 2026-03-17 15:00:37.832400 | TASK [Install "jq" for log collection] 2026-03-17 15:30:27.258399 | PRE-RUN END RESULT_TIMED_OUT: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/2024.1] 2026-03-17 15:30:27.262874 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/2024.1] 2026-03-17 15:30:27.833136 | 2026-03-17 15:30:27.833256 | PLAY [all] 2026-03-17 15:30:27.847711 | 2026-03-17 15:30:27.847798 | TASK [gather-host-logs : creating directory for system status] 2026-03-17 15:30:28.162826 | instance | changed 2026-03-17 15:30:28.169698 | 2026-03-17 15:30:28.169800 | TASK [gather-host-logs : Get logs for each host] 2026-03-17 15:30:28.485081 | instance | + systemd-cgls --full --all --no-pager 2026-03-17 15:30:28.496776 | instance | + ip addr 2026-03-17 15:30:28.499801 | instance | + ip route 2026-03-17 15:30:28.501614 | instance | + lsblk 2026-03-17 15:30:28.506595 | instance | + mount 2026-03-17 15:30:28.509598 | instance | + docker images 2026-03-17 15:30:28.510378 | instance | /bin/bash: line 7: docker: command not found 2026-03-17 15:30:28.510691 | instance | + brctl show 2026-03-17 15:30:28.511406 | instance | /bin/bash: line 8: brctl: command not found 2026-03-17 15:30:28.511788 | instance | + ps aux --sort=-%mem 2026-03-17 15:30:28.527784 | instance | + dpkg -l 2026-03-17 15:30:28.538763 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-03-17 15:30:28.539260 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-03-17 15:30:28.539297 | instance | /bin/bash: line 11: docker: command not found 2026-03-17 15:30:28.539641 | instance | + '[' '!' -z '' ']' 2026-03-17 15:30:28.706128 | instance | ok: Runtime: 0:00:00.058973 2026-03-17 15:30:28.712299 | 2026-03-17 15:30:28.712362 | TASK [gather-host-logs : Downloads logs to executor] 2026-03-17 15:30:29.344799 | instance | changed: 2026-03-17 15:30:29.345081 | instance | created directory /var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/logs/instance 2026-03-17 15:30:29.345152 | instance | cd+++++++++ system/ 2026-03-17 15:30:29.345207 | instance | >f+++++++++ system/brctl-show.txt 2026-03-17 15:30:29.345276 | instance | >f+++++++++ system/docker-images.txt 2026-03-17 15:30:29.345331 | instance | >f+++++++++ system/ip-addr.txt 2026-03-17 15:30:29.345388 | instance | >f+++++++++ system/ip-route.txt 2026-03-17 15:30:29.345442 | instance | >f+++++++++ system/lsblk.txt 2026-03-17 15:30:29.345495 | instance | >f+++++++++ system/mount.txt 2026-03-17 15:30:29.345548 | instance | >f+++++++++ system/packages.txt 2026-03-17 15:30:29.345598 | instance | >f+++++++++ system/ps.txt 2026-03-17 15:30:29.345647 | instance | >f+++++++++ system/systemd-cgls.txt 2026-03-17 15:30:29.357745 | 2026-03-17 15:30:29.357810 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-17 15:30:29.549490 | instance | changed: "values" 2026-03-17 15:30:29.737094 | instance | changed: "releases" 2026-03-17 15:30:29.757176 | 2026-03-17 15:30:29.757311 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-17 15:30:29.957751 | instance | /bin/bash: line 3: kubectl: command not found 2026-03-17 15:30:30.294503 | instance | ok: Runtime: 0:00:00.005261 2026-03-17 15:30:30.299899 | 2026-03-17 15:30:30.299964 | TASK [helm-release-status : Downloads logs to executor] 2026-03-17 15:30:30.779050 | instance | changed: 2026-03-17 15:30:30.779280 | instance | cd+++++++++ helm/ 2026-03-17 15:30:30.779341 | instance | cd+++++++++ helm/releases/ 2026-03-17 15:30:30.779391 | instance | cd+++++++++ helm/values/ 2026-03-17 15:30:30.788436 | 2026-03-17 15:30:30.788499 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-17 15:30:30.979975 | instance | changed 2026-03-17 15:30:30.986250 | 2026-03-17 15:30:30.986333 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-17 15:30:31.194308 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 15:30:31.194388 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 15:30:31.199226 | instance | environment: line 1: kubectl: command not found 2026-03-17 15:30:31.200765 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 15:30:31.201407 | instance | environment: line 1: kubectl: command not found 2026-03-17 15:30:31.202633 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 15:30:31.204528 | instance | environment: line 1: kubectl: command not found 2026-03-17 15:30:31.205831 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 15:30:31.207055 | instance | environment: line 1: kubectl: command not found 2026-03-17 15:30:31.207967 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 15:30:31.209648 | instance | environment: line 1: kubectl: command not found 2026-03-17 15:30:31.210542 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 15:30:31.530593 | instance | ok: Runtime: 0:00:00.026833 2026-03-17 15:30:31.537027 | 2026-03-17 15:30:31.537113 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-17 15:30:31.745825 | instance | changed 2026-03-17 15:30:31.752883 | 2026-03-17 15:30:31.753015 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-17 15:30:32.015887 | instance | environment: line 5: kubectl: command not found 2026-03-17 15:30:32.016072 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 15:30:32.017104 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 15:30:32.017268 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 15:30:32.339283 | instance | ok: Runtime: 0:00:00.008793 2026-03-17 15:30:32.347844 | 2026-03-17 15:30:32.347994 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-17 15:30:32.816723 | instance | changed: 2026-03-17 15:30:32.816944 | instance | cd+++++++++ objects/ 2026-03-17 15:30:32.817015 | instance | cd+++++++++ objects/cluster/ 2026-03-17 15:30:32.817050 | instance | cd+++++++++ objects/namespaced/ 2026-03-17 15:30:32.829759 | 2026-03-17 15:30:32.829848 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-17 15:30:33.035439 | instance | changed 2026-03-17 15:30:33.042248 | 2026-03-17 15:30:33.042307 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-17 15:30:33.238533 | instance | changed 2026-03-17 15:30:33.244937 | 2026-03-17 15:30:33.245097 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-17 15:30:33.454191 | instance | environment: line 3: kubectl: command not found 2026-03-17 15:30:33.779865 | instance | ok: Runtime: 0:00:00.009187 2026-03-17 15:30:33.791536 | 2026-03-17 15:30:33.791672 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-17 15:30:34.280225 | instance | changed: 2026-03-17 15:30:34.280415 | instance | cd+++++++++ pod-logs/ 2026-03-17 15:30:34.280455 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-03-17 15:30:34.291765 | 2026-03-17 15:30:34.291826 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-03-17 15:30:34.484638 | instance | changed 2026-03-17 15:30:34.491537 | 2026-03-17 15:30:34.491608 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-03-17 15:30:34.692982 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-17 15:30:34.693085 | instance | /bin/bash: line 2: jq: command not found 2026-03-17 15:30:35.026923 | instance | ERROR 2026-03-17 15:30:35.027087 | instance | { 2026-03-17 15:30:35.027131 | instance | "delta": "0:00:00.007212", 2026-03-17 15:30:35.027161 | instance | "end": "2026-03-17 15:30:34.694386", 2026-03-17 15:30:35.027188 | instance | "msg": "non-zero return code", 2026-03-17 15:30:35.027214 | instance | "rc": 127, 2026-03-17 15:30:35.027240 | instance | "start": "2026-03-17 15:30:34.687174" 2026-03-17 15:30:35.027266 | instance | } 2026-03-17 15:30:35.027300 | instance | ERROR: Ignoring Errors 2026-03-17 15:30:35.032857 | 2026-03-17 15:30:35.032921 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-03-17 15:30:35.225697 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-17 15:30:35.225952 | instance | /bin/bash: line 2: jq: command not found 2026-03-17 15:30:35.568696 | instance | ERROR 2026-03-17 15:30:35.568989 | instance | { 2026-03-17 15:30:35.569064 | instance | "delta": "0:00:00.006490", 2026-03-17 15:30:35.569112 | instance | "end": "2026-03-17 15:30:35.227082", 2026-03-17 15:30:35.569157 | instance | "msg": "non-zero return code", 2026-03-17 15:30:35.569200 | instance | "rc": 127, 2026-03-17 15:30:35.569245 | instance | "start": "2026-03-17 15:30:35.220592" 2026-03-17 15:30:35.569288 | instance | } 2026-03-17 15:30:35.569349 | instance | ERROR: Ignoring Errors 2026-03-17 15:30:35.576484 | 2026-03-17 15:30:35.576573 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-03-17 15:30:35.783748 | instance | /bin/bash: line 4: jq: command not found 2026-03-17 15:30:35.783829 | instance | /bin/bash: line 4: kubectl: command not found 2026-03-17 15:30:36.111042 | instance | ERROR 2026-03-17 15:30:36.111305 | instance | { 2026-03-17 15:30:36.111371 | instance | "delta": "0:00:00.008157", 2026-03-17 15:30:36.111417 | instance | "end": "2026-03-17 15:30:35.785005", 2026-03-17 15:30:36.111459 | instance | "msg": "non-zero return code", 2026-03-17 15:30:36.111499 | instance | "rc": 127, 2026-03-17 15:30:36.111581 | instance | "start": "2026-03-17 15:30:35.776848" 2026-03-17 15:30:36.111630 | instance | } 2026-03-17 15:30:36.111683 | instance | ERROR: Ignoring Errors 2026-03-17 15:30:36.118640 | 2026-03-17 15:30:36.118714 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-03-17 15:30:36.596795 | instance | changed: cd+++++++++ prometheus/ 2026-03-17 15:30:36.614099 | 2026-03-17 15:30:36.614292 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-03-17 15:30:36.823770 | instance | changed 2026-03-17 15:30:36.829856 | 2026-03-17 15:30:36.829927 | TASK [gather-selenium-data : Get selenium data] 2026-03-17 15:30:37.025922 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-03-17 15:30:37.027493 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-03-17 15:30:37.367285 | instance | ERROR 2026-03-17 15:30:37.367567 | instance | { 2026-03-17 15:30:37.367618 | instance | "delta": "0:00:00.006410", 2026-03-17 15:30:37.367650 | instance | "end": "2026-03-17 15:30:37.027873", 2026-03-17 15:30:37.367672 | instance | "msg": "non-zero return code", 2026-03-17 15:30:37.367690 | instance | "rc": 1, 2026-03-17 15:30:37.367708 | instance | "start": "2026-03-17 15:30:37.021463" 2026-03-17 15:30:37.367725 | instance | } 2026-03-17 15:30:37.367750 | instance | ERROR: Ignoring Errors 2026-03-17 15:30:37.372509 | 2026-03-17 15:30:37.372574 | TASK [gather-selenium-data : Downloads logs to executor] 2026-03-17 15:30:37.848900 | instance | changed: cd+++++++++ selenium/ 2026-03-17 15:30:37.856944 | 2026-03-17 15:30:37.857006 | PLAY RECAP 2026-03-17 15:30:37.857051 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 4 2026-03-17 15:30:37.857073 | 2026-03-17 15:30:37.952865 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/2024.1] 2026-03-17 15:30:37.955825 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 15:30:38.542059 | 2026-03-17 15:30:38.542172 | PLAY [all] 2026-03-17 15:30:38.553650 | 2026-03-17 15:30:38.553738 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-17 15:30:38.598625 | instance | skipping: Conditional result was False 2026-03-17 15:30:38.607804 | 2026-03-17 15:30:38.607917 | TASK [fetch-output : Set log path for single node] 2026-03-17 15:30:38.653212 | instance | ok 2026-03-17 15:30:38.658064 | 2026-03-17 15:30:38.658135 | LOOP [fetch-output : Ensure local output dirs] 2026-03-17 15:30:39.015339 | instance -> localhost | ok: "/var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/logs" 2026-03-17 15:30:39.234727 | instance -> localhost | changed: "/var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/artifacts" 2026-03-17 15:30:39.462354 | instance -> localhost | changed: "/var/lib/zuul/builds/40bc8ee0f0b54abf8680b2c0eeda9857/work/docs" 2026-03-17 15:30:39.476101 | 2026-03-17 15:30:39.476259 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-17 15:30:40.078048 | instance | changed: .d..t...... ./ 2026-03-17 15:30:40.078262 | instance | changed: All items complete 2026-03-17 15:30:40.078300 | 2026-03-17 15:30:40.513357 | instance | changed: .d..t...... ./ 2026-03-17 15:30:40.941856 | instance | changed: .d..t...... ./ 2026-03-17 15:30:41.111190 | 2026-03-17 15:30:41.111290 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-17 15:30:41.561046 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006810 2026-03-17 15:30:41.793512 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006836 2026-03-17 15:30:41.813047 | 2026-03-17 15:30:41.813145 | PLAY [all] 2026-03-17 15:30:41.818830 | 2026-03-17 15:30:41.818890 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-17 15:30:42.234512 | instance | changed 2026-03-17 15:30:42.241483 | 2026-03-17 15:30:42.241549 | PLAY RECAP 2026-03-17 15:30:42.241611 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-17 15:30:42.241656 | 2026-03-17 15:30:42.340155 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 15:30:42.343999 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-17 15:30:42.869879 | 2026-03-17 15:30:42.869985 | PLAY [localhost] 2026-03-17 15:30:42.879252 | 2026-03-17 15:30:42.879320 | TASK [Generate Zuul manifest] 2026-03-17 15:30:42.900374 | localhost | ok 2026-03-17 15:30:42.914961 | 2026-03-17 15:30:42.915033 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-17 15:30:43.217110 | localhost | changed 2026-03-17 15:30:43.227792 | 2026-03-17 15:30:43.227867 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-17 15:30:43.258067 | localhost | ok 2026-03-17 15:30:43.266751 | 2026-03-17 15:30:43.266834 | TASK [Upload logs] 2026-03-17 15:30:43.288787 | localhost | ok 2026-03-17 15:30:43.342235 | 2026-03-17 15:30:43.342351 | TASK [Set zuul-log-path fact] 2026-03-17 15:30:43.361561 | localhost | ok 2026-03-17 15:30:43.374634 | 2026-03-17 15:30:43.374698 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 15:30:43.404546 | localhost | ok 2026-03-17 15:30:43.413188 | 2026-03-17 15:30:43.413271 | TASK [upload-logs : Create log directories] 2026-03-17 15:30:43.809775 | localhost | changed 2026-03-17 15:30:43.814736 | 2026-03-17 15:30:43.814811 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-17 15:30:44.181737 | localhost -> localhost | ok: Runtime: 0:00:00.005658 2026-03-17 15:30:44.189911 | 2026-03-17 15:30:44.189975 | TASK [upload-logs : Upload logs to log server] 2026-03-17 15:30:44.629356 | localhost | Output suppressed because no_log was given 2026-03-17 15:30:44.634247 | 2026-03-17 15:30:44.634335 | LOOP [upload-logs : Compress console log and json output] 2026-03-17 15:30:44.682618 | localhost | skipping: Conditional result was False 2026-03-17 15:30:44.690603 | localhost | skipping: Conditional result was False 2026-03-17 15:30:44.707076 | 2026-03-17 15:30:44.707241 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-17 15:30:44.744690 | localhost | skipping: Conditional result was False 2026-03-17 15:30:44.745094 | 2026-03-17 15:30:44.748935 | localhost | skipping: Conditional result was False 2026-03-17 15:30:44.760113 | 2026-03-17 15:30:44.760321 | LOOP [upload-logs : Upload console log and json output]