2026-03-18 13:12:00.955311 | Job console starting
2026-03-18 13:12:01.882553 | Updating git repos
2026-03-18 13:12:01.950205 | Cloning repos into workspace
2026-03-18 13:12:06.063426 | Restoring repo states
2026-03-18 13:12:06.084998 | Merging changes
2026-03-18 13:12:07.365871 | Checking out repos
2026-03-18 13:12:07.692074 | Preparing playbooks
2026-03-18 13:12:25.859273 | Running Ansible setup
2026-03-18 13:12:29.341699 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-18 13:12:30.012598 | 
2026-03-18 13:12:30.012905 | PLAY [localhost]
2026-03-18 13:12:30.021614 | 
2026-03-18 13:12:30.021698 | TASK [Gathering Facts]
2026-03-18 13:12:30.904195 | localhost | ok
2026-03-18 13:12:30.913803 | 
2026-03-18 13:12:30.914023 | TASK [Setup log path fact]
2026-03-18 13:12:30.931786 | localhost | ok
2026-03-18 13:12:30.944379 | 
2026-03-18 13:12:30.944501 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-18 13:12:30.974865 | localhost | ok
2026-03-18 13:12:30.983712 | 
2026-03-18 13:12:30.983827 | TASK [emit-job-header : Print job information]
2026-03-18 13:12:31.026476 | # Job Information
2026-03-18 13:12:31.026687 | Ansible Version: 2.16.16
2026-03-18 13:12:31.026737 | Job: atmosphere-molecule-csi-rbd
2026-03-18 13:12:31.026769 | Pipeline: check
2026-03-18 13:12:31.026795 | Executor: 0a8996d2b663
2026-03-18 13:12:31.026821 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501
2026-03-18 13:12:31.026853 | Event ID: 22b80e80-22c7-11f1-9939-0f4f6e9b239e
2026-03-18 13:12:31.030619 | 
2026-03-18 13:12:31.030708 | LOOP [emit-job-header : Print node information]
2026-03-18 13:12:31.133976 | localhost | ok:
2026-03-18 13:12:31.134323 | localhost | # Node Information
2026-03-18 13:12:31.134417 | localhost | Inventory Hostname: instance
2026-03-18 13:12:31.134505 | localhost | Hostname: np0000159854
2026-03-18 13:12:31.134586 | localhost | Username: zuul
2026-03-18 13:12:31.134665 | localhost | Distro: Ubuntu 22.04
2026-03-18 13:12:31.134736 | localhost | Provider: yul1
2026-03-18 13:12:31.134804 | localhost | Region: ca-ymq-1
2026-03-18 13:12:31.134872 | localhost | Label: ubuntu-jammy
2026-03-18 13:12:31.134935 | localhost | Product Name: OpenStack Nova
2026-03-18 13:12:31.135000 | localhost | Interface IP: 199.19.213.145
2026-03-18 13:12:31.152248 | 
2026-03-18 13:12:31.152420 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-18 13:12:31.831240 | localhost -> localhost | changed
2026-03-18 13:12:31.840228 | 
2026-03-18 13:12:31.840388 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-18 13:12:32.926987 | localhost -> localhost | changed
2026-03-18 13:12:32.935158 | 
2026-03-18 13:12:32.935261 | PLAY [all]
2026-03-18 13:12:32.946847 | 
2026-03-18 13:12:32.947043 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-18 13:12:33.185051 | instance -> localhost | ok
2026-03-18 13:12:33.194963 | 
2026-03-18 13:12:33.195060 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-18 13:12:33.230514 | instance | ok
2026-03-18 13:12:33.249483 | instance | included: /var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-18 13:12:33.261605 | 
2026-03-18 13:12:33.261784 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-18 13:12:34.109654 | instance -> localhost | Generating public/private rsa key pair.
2026-03-18 13:12:34.109899 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/ac230f08096f48b68f43cf0c48092d9e_id_rsa
2026-03-18 13:12:34.109951 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/ac230f08096f48b68f43cf0c48092d9e_id_rsa.pub
2026-03-18 13:12:34.109988 | instance -> localhost | The key fingerprint is:
2026-03-18 13:12:34.110022 | instance -> localhost | SHA256:QWb9mnjUzL4xv9fLv+0regZglTOww+LPvyPjB+XdLVc zuul-build-sshkey
2026-03-18 13:12:34.110073 | instance -> localhost | The key's randomart image is:
2026-03-18 13:12:34.110105 | instance -> localhost | +---[RSA 3072]----+
2026-03-18 13:12:34.110144 | instance -> localhost | |        +o. .    |
2026-03-18 13:12:34.110176 | instance -> localhost | |       +. o=     |
2026-03-18 13:12:34.110207 | instance -> localhost | |       ..+.=o    |
2026-03-18 13:12:34.110237 | instance -> localhost | |      . .+o.=   E|
2026-03-18 13:12:34.110268 | instance -> localhost | |       .So++. . o|
2026-03-18 13:12:34.110298 | instance -> localhost | |        +.+o+...o|
2026-03-18 13:12:34.110352 | instance -> localhost | |         +. .= o.|
2026-03-18 13:12:34.110420 | instance -> localhost | |         o.o.+o +|
2026-03-18 13:12:34.110464 | instance -> localhost | |        ..++* oOO|
2026-03-18 13:12:34.110496 | instance -> localhost | +----[SHA256]-----+
2026-03-18 13:12:34.110579 | instance -> localhost | ok: Runtime: 0:00:00.430573
2026-03-18 13:12:34.118731 | 
2026-03-18 13:12:34.118884 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-18 13:12:34.150221 | instance | ok
2026-03-18 13:12:34.161208 | instance | included: /var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-18 13:12:34.169665 | 
2026-03-18 13:12:34.169805 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-18 13:12:34.194834 | instance | skipping: Conditional result was False
2026-03-18 13:12:34.206803 | 
2026-03-18 13:12:34.206985 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-18 13:12:34.693782 | instance | changed
2026-03-18 13:12:34.699521 | 
2026-03-18 13:12:34.699612 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-18 13:12:34.884265 | instance | ok
2026-03-18 13:12:34.890876 | 
2026-03-18 13:12:34.890949 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-18 13:12:35.371520 | instance | changed
2026-03-18 13:12:36.575395 | 
2026-03-18 13:12:36.575568 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-18 13:12:37.060541 | instance | changed
2026-03-18 13:12:37.066312 | 
2026-03-18 13:12:37.066417 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-18 13:12:37.090220 | instance | skipping: Conditional result was False
2026-03-18 13:12:37.100162 | 
2026-03-18 13:12:37.100257 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-18 13:12:37.479264 | instance -> localhost | changed
2026-03-18 13:12:37.494590 | 
2026-03-18 13:12:37.494704 | TASK [add-build-sshkey : Add back temp key]
2026-03-18 13:12:37.782576 | instance -> localhost | Identity added: /var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/ac230f08096f48b68f43cf0c48092d9e_id_rsa (zuul-build-sshkey)
2026-03-18 13:12:37.782833 | instance -> localhost | ok: Runtime: 0:00:00.012087
2026-03-18 13:12:37.795175 | 
2026-03-18 13:12:37.795439 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-18 13:12:38.138426 | instance | ok
2026-03-18 13:12:38.146569 | 
2026-03-18 13:12:38.146684 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-18 13:12:38.172537 | instance | skipping: Conditional result was False
2026-03-18 13:12:38.189808 | 
2026-03-18 13:12:38.189978 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-18 13:12:38.536347 | instance | ok
2026-03-18 13:12:38.546264 | 
2026-03-18 13:12:38.546397 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-18 13:12:41.028554 | instance | Output suppressed because no_log was given
2026-03-18 13:12:41.038672 | 
2026-03-18 13:12:41.038827 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-18 13:12:41.226553 | instance | ok: "logs"
2026-03-18 13:12:41.227144 | instance | ok: All items complete
2026-03-18 13:12:41.227197 | 
2026-03-18 13:12:41.405896 | instance | ok: "artifacts"
2026-03-18 13:12:41.567162 | instance | ok: "docs"
2026-03-18 13:12:41.584769 | 
2026-03-18 13:12:41.585176 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-18 13:12:41.774616 | instance | changed: "logs"
2026-03-18 13:12:41.936145 | instance | changed: "artifacts"
2026-03-18 13:12:42.096455 | instance | changed: "docs"
2026-03-18 13:12:42.115754 | 
2026-03-18 13:12:42.115867 | PLAY RECAP
2026-03-18 13:12:42.115915 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-18 13:12:42.115944 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-18 13:12:42.115967 | 
2026-03-18 13:12:42.273654 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-18 13:12:42.275604 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-18 13:12:42.920236 | 
2026-03-18 13:12:42.920367 | PLAY [all]
2026-03-18 13:12:42.931674 | 
2026-03-18 13:12:42.931765 | TASK [setup-uv : Extract archive]
2026-03-18 13:12:45.244296 | instance | changed
2026-03-18 13:12:45.252880 | 
2026-03-18 13:12:45.253123 | TASK [setup-uv : Print version]
2026-03-18 13:12:45.624442 | instance | uv 0.8.13
2026-03-18 13:12:45.793028 | instance | ok: Runtime: 0:00:00.010949
2026-03-18 13:12:45.802700 | 
2026-03-18 13:12:45.802822 | PLAY RECAP
2026-03-18 13:12:45.802899 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-18 13:12:45.802944 | 
2026-03-18 13:12:45.970412 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-18 13:12:45.974030 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-03-18 13:12:46.659921 | 
2026-03-18 13:12:46.660103 | PLAY [all]
2026-03-18 13:12:46.675897 | 
2026-03-18 13:12:46.676091 | TASK [Install "jq" for log collection]
2026-03-18 13:13:03.280683 | instance | ERROR
2026-03-18 13:13:03.281065 | instance | {
2026-03-18 13:13:03.281124 | instance |   "cache_update_time": 1773839572,
2026-03-18 13:13:03.281166 | instance |   "cache_updated": true,
2026-03-18 13:13:03.281237 | instance |   "msg": "'/usr/bin/apt-get -y -o \"Dpkg::Options::=--force-confdef\" -o \"Dpkg::Options::=--force-confold\"       install 'jq=1.6-2.1ubuntu3.1'' failed: E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/libo/libonig/libonig5_6.9.7.1-2build1_amd64.deb  503  Service Unavailable [IP: 91.189.91.94 80]\nE: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?\n",
2026-03-18 13:13:03.281278 | instance |   "rc": 100
2026-03-18 13:13:03.281311 | instance | }
failure
2026-03-18 13:13:03.283482 | 
2026-03-18 13:13:03.283538 | PLAY RECAP
2026-03-18 13:13:03.283590 | instance | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-03-18 13:13:03.283616 | 
2026-03-18 13:13:03.486592 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-03-18 13:13:03.490886 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-03-18 13:13:04.154194 | 
2026-03-18 13:13:04.154373 | PLAY [all]
2026-03-18 13:13:04.171144 | 
2026-03-18 13:13:04.171329 | TASK [gather-host-logs : creating directory for system status]
2026-03-18 13:13:04.601545 | instance | changed
2026-03-18 13:13:04.606962 | 
2026-03-18 13:13:04.607082 | TASK [gather-host-logs : Get logs for each host]
2026-03-18 13:13:04.961583 | instance | + systemd-cgls --full --all --no-pager
2026-03-18 13:13:04.971171 | instance | + ip addr
2026-03-18 13:13:04.973118 | instance | + ip route
2026-03-18 13:13:04.974520 | instance | + lsblk
2026-03-18 13:13:04.977100 | instance | + mount
2026-03-18 13:13:04.978604 | instance | + docker images
2026-03-18 13:13:04.978973 | instance | /bin/bash: line 7: docker: command not found
2026-03-18 13:13:04.979193 | instance | + brctl show
2026-03-18 13:13:04.979523 | instance | /bin/bash: line 8: brctl: command not found
2026-03-18 13:13:04.979740 | instance | + ps aux --sort=-%mem
2026-03-18 13:13:04.991295 | instance | + dpkg -l
2026-03-18 13:13:04.997452 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-03-18 13:13:04.997713 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-03-18 13:13:04.997733 | instance | /bin/bash: line 11: docker: command not found
2026-03-18 13:13:04.997934 | instance | + '[' '!' -z '' ']'
2026-03-18 13:13:05.143312 | instance | ok: Runtime: 0:00:00.041135
2026-03-18 13:13:05.151442 | 
2026-03-18 13:13:05.151545 | TASK [gather-host-logs : Downloads logs to executor]
2026-03-18 13:13:05.799640 | instance | changed:
2026-03-18 13:13:05.799835 | instance | created directory /var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/logs/instance
2026-03-18 13:13:05.799865 | instance | cd+++++++++ system/
2026-03-18 13:13:05.799887 | instance | >f+++++++++ system/brctl-show.txt
2026-03-18 13:13:05.799908 | instance | >f+++++++++ system/docker-images.txt
2026-03-18 13:13:05.799928 | instance | >f+++++++++ system/ip-addr.txt
2026-03-18 13:13:05.799951 | instance | >f+++++++++ system/ip-route.txt
2026-03-18 13:13:05.799973 | instance | >f+++++++++ system/lsblk.txt
2026-03-18 13:13:05.799993 | instance | >f+++++++++ system/mount.txt
2026-03-18 13:13:05.800015 | instance | >f+++++++++ system/packages.txt
2026-03-18 13:13:05.800035 | instance | >f+++++++++ system/ps.txt
2026-03-18 13:13:05.800054 | instance | >f+++++++++ system/systemd-cgls.txt
2026-03-18 13:13:05.809273 | 
2026-03-18 13:13:05.809354 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-18 13:13:06.009681 | instance | changed: "values"
2026-03-18 13:13:06.199519 | instance | changed: "releases"
2026-03-18 13:13:06.212523 | 
2026-03-18 13:13:06.212735 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-18 13:13:06.423260 | instance | /bin/bash: line 3: kubectl: command not found
2026-03-18 13:13:06.754460 | instance | ok: Runtime: 0:00:00.005423
2026-03-18 13:13:06.761792 | 
2026-03-18 13:13:06.761947 | TASK [helm-release-status : Downloads logs to executor]
2026-03-18 13:13:07.386238 | instance | changed:
2026-03-18 13:13:07.386603 | instance | cd+++++++++ helm/
2026-03-18 13:13:07.386667 | instance | cd+++++++++ helm/releases/
2026-03-18 13:13:07.386710 | instance | cd+++++++++ helm/values/
2026-03-18 13:13:07.402555 | 
2026-03-18 13:13:07.402687 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-18 13:13:07.617929 | instance | changed
2026-03-18 13:13:07.627271 | 
2026-03-18 13:13:07.627343 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-18 13:13:07.837978 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-18 13:13:07.838378 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-18 13:13:07.843392 | instance | environment: line 1: kubectl: command not found
2026-03-18 13:13:07.844057 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-18 13:13:07.844852 | instance | environment: line 1: kubectl: command not found
2026-03-18 13:13:07.845478 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-18 13:13:07.847524 | instance | environment: line 1: kubectl: command not found
2026-03-18 13:13:07.848544 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-18 13:13:07.850908 | instance | environment: line 1: kubectl: command not found
2026-03-18 13:13:07.850929 | instance | environment: line 1: kubectl: command not found
2026-03-18 13:13:07.852185 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-18 13:13:07.852840 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-18 13:13:08.163218 | instance | ok: Runtime: 0:00:00.023193
2026-03-18 13:13:08.171487 | 
2026-03-18 13:13:08.171642 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-18 13:13:08.367107 | instance | changed
2026-03-18 13:13:08.373239 | 
2026-03-18 13:13:08.373323 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-18 13:13:08.611271 | instance | environment: line 5: kubectl: command not found
2026-03-18 13:13:08.612548 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-18 13:13:08.612583 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-18 13:13:08.613157 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-18 13:13:08.947343 | instance | ok: Runtime: 0:00:00.006331
2026-03-18 13:13:08.953438 | 
2026-03-18 13:13:08.953510 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-18 13:13:09.443978 | instance | changed:
2026-03-18 13:13:09.444137 | instance | cd+++++++++ objects/
2026-03-18 13:13:09.444166 | instance | cd+++++++++ objects/cluster/
2026-03-18 13:13:09.444188 | instance | cd+++++++++ objects/namespaced/
2026-03-18 13:13:09.454208 | 
2026-03-18 13:13:09.454285 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-18 13:13:09.661776 | instance | changed
2026-03-18 13:13:09.669325 | 
2026-03-18 13:13:09.669419 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-18 13:13:09.887623 | instance | changed
2026-03-18 13:13:09.892685 | 
2026-03-18 13:13:09.892758 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-18 13:13:10.115149 | instance | environment: line 3: kubectl: command not found
2026-03-18 13:13:10.429393 | instance | ok: Runtime: 0:00:00.010012
2026-03-18 13:13:10.435450 | 
2026-03-18 13:13:10.435540 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-18 13:13:10.921293 | instance | changed:
2026-03-18 13:13:10.921495 | instance | cd+++++++++ pod-logs/
2026-03-18 13:13:10.921524 | instance | cd+++++++++ pod-logs/failed-pods/
2026-03-18 13:13:10.932216 | 
2026-03-18 13:13:10.932359 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-03-18 13:13:11.130303 | instance | changed
2026-03-18 13:13:11.137778 | 
2026-03-18 13:13:11.137919 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-03-18 13:13:11.348633 | instance | /bin/bash: line 2: kubectl: command not found
2026-03-18 13:13:11.348821 | instance | /bin/bash: line 2: jq: command not found
2026-03-18 13:13:11.685223 | instance | ERROR
2026-03-18 13:13:11.685583 | instance | {
2026-03-18 13:13:11.685651 | instance |   "delta": "0:00:00.006786",
2026-03-18 13:13:11.685844 | instance |   "end": "2026-03-18 13:13:11.350028",
2026-03-18 13:13:11.685905 | instance |   "msg": "non-zero return code",
2026-03-18 13:13:11.685947 | instance |   "rc": 127,
2026-03-18 13:13:11.685987 | instance |   "start": "2026-03-18 13:13:11.343242"
2026-03-18 13:13:11.686025 | instance | }
2026-03-18 13:13:11.686077 | instance | ERROR: Ignoring Errors
2026-03-18 13:13:11.694646 | 
2026-03-18 13:13:11.694767 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-03-18 13:13:11.893888 | instance | /bin/bash: line 2: kubectl: command not found
2026-03-18 13:13:11.894243 | instance | /bin/bash: line 2: jq: command not found
2026-03-18 13:13:12.233476 | instance | ERROR
2026-03-18 13:13:12.233727 | instance | {
2026-03-18 13:13:12.233770 | instance |   "delta": "0:00:00.005875",
2026-03-18 13:13:12.233801 | instance |   "end": "2026-03-18 13:13:11.895294",
2026-03-18 13:13:12.233849 | instance |   "msg": "non-zero return code",
2026-03-18 13:13:12.233881 | instance |   "rc": 127,
2026-03-18 13:13:12.233908 | instance |   "start": "2026-03-18 13:13:11.889419"
2026-03-18 13:13:12.233934 | instance | }
2026-03-18 13:13:12.233973 | instance | ERROR: Ignoring Errors
2026-03-18 13:13:12.241314 | 
2026-03-18 13:13:12.241400 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-03-18 13:13:12.452180 | instance | /bin/bash: line 4: kubectl: command not found
2026-03-18 13:13:12.452557 | instance | /bin/bash: line 4: jq: command not found
2026-03-18 13:13:12.777809 | instance | ERROR
2026-03-18 13:13:12.778026 | instance | {
2026-03-18 13:13:12.778057 | instance |   "delta": "0:00:00.005928",
2026-03-18 13:13:12.778078 | instance |   "end": "2026-03-18 13:13:12.453493",
2026-03-18 13:13:12.778097 | instance |   "msg": "non-zero return code",
2026-03-18 13:13:12.778115 | instance |   "rc": 127,
2026-03-18 13:13:12.778133 | instance |   "start": "2026-03-18 13:13:12.447565"
2026-03-18 13:13:12.778151 | instance | }
2026-03-18 13:13:12.778175 | instance | ERROR: Ignoring Errors
2026-03-18 13:13:12.783199 | 
2026-03-18 13:13:12.783274 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-03-18 13:13:13.285471 | instance | changed: cd+++++++++ prometheus/
2026-03-18 13:13:13.296814 | 
2026-03-18 13:13:13.296930 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-03-18 13:13:13.514201 | instance | changed
2026-03-18 13:13:13.520990 | 
2026-03-18 13:13:13.521073 | TASK [gather-selenium-data : Get selenium data]
2026-03-18 13:13:13.723581 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-03-18 13:13:13.725235 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-03-18 13:13:14.060480 | instance | ERROR
2026-03-18 13:13:14.060845 | instance | {
2026-03-18 13:13:14.060895 | instance |   "delta": "0:00:00.005644",
2026-03-18 13:13:14.060925 | instance |   "end": "2026-03-18 13:13:13.725682",
2026-03-18 13:13:14.060952 | instance |   "msg": "non-zero return code",
2026-03-18 13:13:14.060977 | instance |   "rc": 1,
2026-03-18 13:13:14.061027 | instance |   "start": "2026-03-18 13:13:13.720038"
2026-03-18 13:13:14.061053 | instance | }
2026-03-18 13:13:14.061085 | instance | ERROR: Ignoring Errors
2026-03-18 13:13:14.067394 | 
2026-03-18 13:13:14.067460 | TASK [gather-selenium-data : Downloads logs to executor]
2026-03-18 13:13:14.550634 | instance | changed: cd+++++++++ selenium/
2026-03-18 13:13:14.557061 | 
2026-03-18 13:13:14.557135 | PLAY RECAP
2026-03-18 13:13:14.557193 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 4
2026-03-18 13:13:14.557238 | 
2026-03-18 13:13:14.711258 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-03-18 13:13:14.715676 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-18 13:13:15.329682 | 
2026-03-18 13:13:15.329813 | PLAY [all]
2026-03-18 13:13:15.341373 | 
2026-03-18 13:13:15.341452 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-18 13:13:15.386914 | instance | skipping: Conditional result was False
2026-03-18 13:13:15.394643 | 
2026-03-18 13:13:15.394794 | TASK [fetch-output : Set log path for single node]
2026-03-18 13:13:15.434538 | instance | ok
2026-03-18 13:13:15.441721 | 
2026-03-18 13:13:15.441795 | LOOP [fetch-output : Ensure local output dirs]
2026-03-18 13:13:15.856506 | instance -> localhost | ok: "/var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/logs"
2026-03-18 13:13:16.092229 | instance -> localhost | changed: "/var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/artifacts"
2026-03-18 13:13:16.311846 | instance -> localhost | changed: "/var/lib/zuul/builds/ac230f08096f48b68f43cf0c48092d9e/work/docs"
2026-03-18 13:13:16.330457 | 
2026-03-18 13:13:16.330594 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-18 13:13:16.961846 | instance | changed: .d..t...... ./
2026-03-18 13:13:16.962162 | instance | changed: All items complete
2026-03-18 13:13:16.962203 | 
2026-03-18 13:13:17.423003 | instance | changed: .d..t...... ./
2026-03-18 13:13:17.866513 | instance | changed: .d..t...... ./
2026-03-18 13:13:17.879178 | 
2026-03-18 13:13:17.879314 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-18 13:13:18.331192 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007751
2026-03-18 13:13:18.601232 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.045115
2026-03-18 13:13:18.625626 | 
2026-03-18 13:13:18.625766 | PLAY [all]
2026-03-18 13:13:18.631960 | 
2026-03-18 13:13:18.632029 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-18 13:13:19.118572 | instance | changed
2026-03-18 13:13:19.124512 | 
2026-03-18 13:13:19.124592 | PLAY RECAP
2026-03-18 13:13:19.124640 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-18 13:13:19.124662 | 
2026-03-18 13:13:19.259337 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-18 13:13:19.263749 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-18 13:13:19.891271 | 
2026-03-18 13:13:19.891499 | PLAY [localhost]
2026-03-18 13:13:19.903136 | 
2026-03-18 13:13:19.903294 | TASK [Generate Zuul manifest]
2026-03-18 13:13:19.924917 | localhost | ok
2026-03-18 13:13:19.943914 | 
2026-03-18 13:13:19.944097 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-18 13:13:20.342848 | localhost | changed
2026-03-18 13:13:20.355892 | 
2026-03-18 13:13:20.356070 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-18 13:13:20.390882 | localhost | ok
2026-03-18 13:13:20.400046 | 
2026-03-18 13:13:20.400201 | TASK [Upload logs]
2026-03-18 13:13:20.435240 | localhost | ok
2026-03-18 13:13:20.498678 | 
2026-03-18 13:13:20.498841 | TASK [Set zuul-log-path fact]
2026-03-18 13:13:20.520014 | localhost | ok
2026-03-18 13:13:20.681274 | 
2026-03-18 13:13:20.681442 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-18 13:13:20.714161 | localhost | ok
2026-03-18 13:13:20.723666 | 
2026-03-18 13:13:20.723790 | TASK [upload-logs : Create log directories]
2026-03-18 13:13:21.195975 | localhost | changed
2026-03-18 13:13:21.202130 | 
2026-03-18 13:13:21.202246 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-18 13:13:21.658790 | localhost -> localhost | ok: Runtime: 0:00:00.007049
2026-03-18 13:13:21.664458 | 
2026-03-18 13:13:21.664523 | TASK [upload-logs : Upload logs to log server]
2026-03-18 13:13:22.151363 | localhost | Output suppressed because no_log was given
2026-03-18 13:13:22.156482 | 
2026-03-18 13:13:22.156603 | LOOP [upload-logs : Compress console log and json output]
2026-03-18 13:13:22.204096 | localhost | skipping: Conditional result was False
2026-03-18 13:13:22.212114 | localhost | skipping: Conditional result was False
2026-03-18 13:13:22.222939 | 
2026-03-18 13:13:22.223026 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-18 13:13:22.264246 | localhost | skipping: Conditional result was False
2026-03-18 13:13:22.264651 | 
2026-03-18 13:13:22.268271 | localhost | skipping: Conditional result was False
2026-03-18 13:13:22.286858 | 
2026-03-18 13:13:22.287002 | LOOP [upload-logs : Upload console log and json output]