2026-04-16 00:16:31.430615 | Job console starting
2026-04-16 00:16:31.449471 | Updating git repos
2026-04-16 00:16:31.504560 | Cloning repos into workspace
2026-04-16 00:16:31.700777 | Restoring repo states
2026-04-16 00:16:31.861252 | Merging changes
2026-04-16 00:16:32.794178 | Checking out repos
2026-04-16 00:16:33.123123 | Preparing playbooks
2026-04-16 00:16:35.616512 | Running Ansible setup
2026-04-16 00:16:39.349500 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-16 00:16:39.922529 | 
2026-04-16 00:16:39.922691 | PLAY [localhost]
2026-04-16 00:16:39.931572 | 
2026-04-16 00:16:39.931676 | TASK [Gathering Facts]
2026-04-16 00:16:40.782815 | localhost | ok
2026-04-16 00:16:40.791776 | 
2026-04-16 00:16:40.791876 | TASK [Setup log path fact]
2026-04-16 00:16:40.812519 | localhost | ok
2026-04-16 00:16:40.824384 | 
2026-04-16 00:16:40.824449 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-16 00:16:40.853085 | localhost | ok
2026-04-16 00:16:40.860771 | 
2026-04-16 00:16:40.860860 | TASK [emit-job-header : Print job information]
2026-04-16 00:16:40.892709 | # Job Information
2026-04-16 00:16:40.892855 | Ansible Version: 2.16.16
2026-04-16 00:16:40.892899 | Job: atmosphere-molecule-csi-local-path-provisioner
2026-04-16 00:16:40.892930 | Pipeline: check
2026-04-16 00:16:40.892981 | Executor: 0a8996d2b663
2026-04-16 00:16:40.893012 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3835
2026-04-16 00:16:40.893043 | Event ID: 69329484-3929-11f1-806c-0c126485a0af
2026-04-16 00:16:40.896577 | 
2026-04-16 00:16:40.896675 | LOOP [emit-job-header : Print node information]
2026-04-16 00:16:40.993130 | localhost | ok:
2026-04-16 00:16:40.993504 | localhost | # Node Information
2026-04-16 00:16:40.993578 | localhost | Inventory Hostname: instance
2026-04-16 00:16:40.993629 | localhost | Hostname: np0000166501
2026-04-16 00:16:40.993674 | localhost | Username: zuul
2026-04-16 00:16:40.993724 | localhost | Distro: Ubuntu 22.04
2026-04-16 00:16:40.993770 | localhost | Provider: yul1
2026-04-16 00:16:40.993814 | localhost | Region: ca-ymq-1
2026-04-16 00:16:40.993857 | localhost | Label: ubuntu-jammy
2026-04-16 00:16:40.993899 | localhost | Product Name: OpenStack Nova
2026-04-16 00:16:40.993943 | localhost | Interface IP: 199.204.45.129
2026-04-16 00:16:41.013252 | 
2026-04-16 00:16:41.013397 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-16 00:16:41.414122 | localhost -> localhost | changed
2026-04-16 00:16:41.423528 | 
2026-04-16 00:16:41.423670 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-16 00:16:42.217689 | localhost -> localhost | changed
2026-04-16 00:16:42.226370 | 
2026-04-16 00:16:42.226446 | PLAY [all]
2026-04-16 00:16:42.235569 | 
2026-04-16 00:16:42.235633 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-16 00:16:42.475608 | instance -> localhost | ok
2026-04-16 00:16:42.486457 | 
2026-04-16 00:16:42.486533 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-16 00:16:42.519425 | instance | ok
2026-04-16 00:16:42.533058 | instance | included: /var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-16 00:16:42.538326 | 
2026-04-16 00:16:42.538385 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-16 00:16:44.303386 | instance -> localhost | Generating public/private rsa key pair.
2026-04-16 00:16:44.303547 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/cf051d10d3434f999750c1e3c1d0dc38_id_rsa
2026-04-16 00:16:44.303576 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/cf051d10d3434f999750c1e3c1d0dc38_id_rsa.pub
2026-04-16 00:16:44.303599 | instance -> localhost | The key fingerprint is:
2026-04-16 00:16:44.303619 | instance -> localhost | SHA256:Ag7xOU1yS+BojEXZ3WD3Fhw7yadJsLAftBAbHklpWwc zuul-build-sshkey
2026-04-16 00:16:44.303650 | instance -> localhost | The key's randomart image is:
2026-04-16 00:16:44.303672 | instance -> localhost | +---[RSA 3072]----+
2026-04-16 00:16:44.303699 | instance -> localhost | | .+oo+&*Eoo.     |
2026-04-16 00:16:44.303723 | instance -> localhost | | +.=.X=@o*o+     |
2026-04-16 00:16:44.303743 | instance -> localhost | |. = *.*o+.O .    |
2026-04-16 00:16:44.303763 | instance -> localhost | | . o o.. + =     |
2026-04-16 00:16:44.303782 | instance -> localhost | |    . . S o      |
2026-04-16 00:16:44.303802 | instance -> localhost | |       .         |
2026-04-16 00:16:44.303821 | instance -> localhost | |                 |
2026-04-16 00:16:44.303841 | instance -> localhost | |                 |
2026-04-16 00:16:44.303862 | instance -> localhost | |                 |
2026-04-16 00:16:44.303883 | instance -> localhost | +----[SHA256]-----+
2026-04-16 00:16:44.303925 | instance -> localhost | ok: Runtime: 0:00:01.382601
2026-04-16 00:16:44.308727 | 
2026-04-16 00:16:44.308789 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-16 00:16:44.340377 | instance | ok
2026-04-16 00:16:44.350852 | instance | included: /var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-16 00:16:44.357905 | 
2026-04-16 00:16:44.357967 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-16 00:16:44.381716 | instance | skipping: Conditional result was False
2026-04-16 00:16:44.389953 | 
2026-04-16 00:16:44.390037 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-16 00:16:44.804948 | instance | changed
2026-04-16 00:16:44.809950 | 
2026-04-16 00:16:44.810009 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-16 00:16:44.985069 | instance | ok
2026-04-16 00:16:44.990416 | 
2026-04-16 00:16:44.990481 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-16 00:16:45.442166 | instance | changed
2026-04-16 00:16:45.447114 | 
2026-04-16 00:16:45.447175 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-16 00:16:45.899635 | instance | changed
2026-04-16 00:16:45.906142 | 
2026-04-16 00:16:45.906204 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-16 00:16:45.930121 | instance | skipping: Conditional result was False
2026-04-16 00:16:45.939021 | 
2026-04-16 00:16:45.939121 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-16 00:16:46.297614 | instance -> localhost | changed
2026-04-16 00:16:46.311094 | 
2026-04-16 00:16:46.311185 | TASK [add-build-sshkey : Add back temp key]
2026-04-16 00:16:46.594299 | instance -> localhost | Identity added: /var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/cf051d10d3434f999750c1e3c1d0dc38_id_rsa (zuul-build-sshkey)
2026-04-16 00:16:46.594490 | instance -> localhost | ok: Runtime: 0:00:00.016198
2026-04-16 00:16:46.600647 | 
2026-04-16 00:16:46.600707 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-16 00:16:46.970744 | instance | ok
2026-04-16 00:16:46.975458 | 
2026-04-16 00:16:46.975521 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-16 00:16:46.999615 | instance | skipping: Conditional result was False
2026-04-16 00:16:47.011157 | 
2026-04-16 00:16:47.011218 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-16 00:16:47.349184 | instance | ok
2026-04-16 00:16:47.357164 | 
2026-04-16 00:16:47.357227 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-16 00:16:48.935614 | instance | Output suppressed because no_log was given
2026-04-16 00:16:48.946998 | 
2026-04-16 00:16:48.984715 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-16 00:16:49.190363 | instance | ok: "logs"
2026-04-16 00:16:49.190711 | instance | ok: All items complete
2026-04-16 00:16:49.190749 | 
2026-04-16 00:16:49.341236 | instance | ok: "artifacts"
2026-04-16 00:16:49.495154 | instance | ok: "docs"
2026-04-16 00:16:49.507562 | 
2026-04-16 00:16:49.507771 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-16 00:16:49.692486 | instance | changed: "logs"
2026-04-16 00:16:49.851869 | instance | changed: "artifacts"
2026-04-16 00:16:50.005203 | instance | changed: "docs"
2026-04-16 00:16:50.028137 | 
2026-04-16 00:16:50.028339 | PLAY RECAP
2026-04-16 00:16:50.028426 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-16 00:16:50.028475 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-16 00:16:50.028512 | 
2026-04-16 00:16:50.189544 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-16 00:16:50.193966 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-16 00:16:50.760086 | 
2026-04-16 00:16:50.760205 | PLAY [all]
2026-04-16 00:16:50.771655 | 
2026-04-16 00:16:50.771729 | TASK [setup-uv : Extract archive]
2026-04-16 00:16:52.970255 | instance | changed
2026-04-16 00:16:52.977169 | 
2026-04-16 00:16:52.977243 | TASK [setup-uv : Print version]
2026-04-16 00:16:52.351936 | instance | uv 0.8.13
2026-04-16 00:16:53.513943 | instance | ok: Runtime: 0:00:00.011588
2026-04-16 00:16:53.520764 | 
2026-04-16 00:16:53.520814 | PLAY RECAP
2026-04-16 00:16:53.520858 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-16 00:16:53.520882 | 
2026-04-16 00:16:53.615586 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-16 00:16:53.619798 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre-install-deps.yml@main]
2026-04-16 00:16:54.210699 | 
2026-04-16 00:16:54.210855 | PLAY [all]
2026-04-16 00:16:54.223072 | 
2026-04-16 00:16:54.223161 | TASK [Install system packages]
2026-04-16 00:17:21.425981 | instance | changed
2026-04-16 00:17:21.432640 | 
2026-04-16 00:17:21.432716 | TASK [Enable iscsid service]
2026-04-16 00:17:22.533967 | instance | changed
2026-04-16 00:17:22.546724 | 
2026-04-16 00:17:22.546799 | TASK [Enable multipathd service]
2026-04-16 00:17:22.873439 | instance | ok
2026-04-16 00:17:22.883945 | 
2026-04-16 00:17:22.884015 | TASK [Install Helm 3.14.4]
2026-04-16 00:17:23.927051 | instance | ok: Runtime: 0:00:00.542434
2026-04-16 00:17:23.934353 | 
2026-04-16 00:17:23.934428 | TASK [Install Go 1.24.2]
2026-04-16 00:17:26.472699 | instance | ok: Runtime: 0:00:02.243051
2026-04-16 00:17:26.479001 | 
2026-04-16 00:17:26.479074 | TASK [Create Python venv and install openstacksdk]
2026-04-16 00:17:41.541624 | instance | changed
2026-04-16 00:17:41.545602 | 
2026-04-16 00:17:41.545665 | PLAY RECAP
2026-04-16 00:17:41.545719 | instance | ok: 6 changed: 5 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-16 00:17:41.545748 | 
2026-04-16 00:17:41.686344 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre-install-deps.yml@main]
2026-04-16 00:17:41.690330 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-04-16 00:17:42.238880 | 
2026-04-16 00:17:42.239494 | PLAY [all]
2026-04-16 00:17:42.246384 | 
2026-04-16 00:17:42.246447 | PLAY RECAP
2026-04-16 00:17:42.246481 | 
2026-04-16 00:17:42.338392 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-04-16 00:17:42.342246 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/csi/converge.yml@main]
2026-04-16 00:17:42.891679 | 
2026-04-16 00:17:42.892159 | PLAY [all]
2026-04-16 00:17:42.903014 | 
2026-04-16 00:17:42.903085 | TASK [Build atmosphere binary]
2026-04-16 00:17:43.264722 | instance | go: downloading go1.24.4 (linux/amd64)
2026-04-16 00:17:48.826187 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-04-16 00:17:48.829973 | instance | go: downloading golang.org/x/sync v0.18.0
2026-04-16 00:17:48.991026 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-04-16 00:17:55.450141 | instance | ok: Runtime: 0:00:11.734889
2026-04-16 00:17:55.455938 | 
2026-04-16 00:17:55.456004 | TASK [Deploy with parallel orchestrator]
2026-04-16 00:17:55.647829 | instance | /bin/bash: line 1: .venv/bin/activate: No such file or directory
2026-04-16 00:17:56.003552 | instance | ERROR
2026-04-16 00:17:56.003762 | instance | {
2026-04-16 00:17:56.003791 | instance |   "delta": "0:00:00.006878",
2026-04-16 00:17:56.003812 | instance |   "end": "2026-04-16 00:17:55.648176",
2026-04-16 00:17:56.003831 | instance |   "msg": "non-zero return code",
2026-04-16 00:17:56.003879 | instance |   "rc": 1,
2026-04-16 00:17:56.003899 | instance |   "start": "2026-04-16 00:17:55.641298"
2026-04-16 00:17:56.003923 | instance | }
failure
2026-04-16 00:17:56.013206 | 
2026-04-16 00:17:56.013268 | PLAY RECAP
2026-04-16 00:17:56.013314 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-04-16 00:17:56.013362 | 
2026-04-16 00:17:56.141049 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/csi/converge.yml@main]
2026-04-16 00:17:56.145140 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-04-16 00:17:56.735671 | 
2026-04-16 00:17:56.735800 | PLAY [all]
2026-04-16 00:17:56.749509 | 
2026-04-16 00:17:56.749586 | TASK [gather-host-logs : creating directory for system status]
2026-04-16 00:17:57.086919 | instance | changed
2026-04-16 00:17:57.093701 | 
2026-04-16 00:17:57.093776 | TASK [gather-host-logs : Get logs for each host]
2026-04-16 00:17:57.476843 | instance | + systemd-cgls --full --all --no-pager
2026-04-16 00:17:57.490037 | instance | + ip addr
2026-04-16 00:17:57.492809 | instance | + ip route
2026-04-16 00:17:57.495766 | instance | + lsblk
2026-04-16 00:17:57.498678 | instance | + mount
2026-04-16 00:17:57.501749 | instance | + docker images
2026-04-16 00:17:57.502405 | instance | /bin/bash: line 7: docker: command not found
2026-04-16 00:17:57.502778 | instance | + brctl show
2026-04-16 00:17:57.503442 | instance | /bin/bash: line 8: brctl: command not found
2026-04-16 00:17:57.503781 | instance | + ps aux --sort=-%mem
2026-04-16 00:17:57.519628 | instance | + dpkg -l
2026-04-16 00:17:57.530376 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-04-16 00:17:57.530689 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-04-16 00:17:57.530723 | instance | /bin/bash: line 11: docker: command not found
2026-04-16 00:17:57.530879 | instance | + '[' '!' -z '' ']'
2026-04-16 00:17:57.627346 | instance | ok: Runtime: 0:00:00.059080
2026-04-16 00:17:57.634351 | 
2026-04-16 00:17:57.634419 | TASK [gather-host-logs : Downloads logs to executor]
2026-04-16 00:17:58.251753 | instance | changed:
2026-04-16 00:17:58.251922 | instance | created directory /var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/logs/instance
2026-04-16 00:17:58.251951 | instance | cd+++++++++ system/
2026-04-16 00:17:58.251973 | instance | >f+++++++++ system/brctl-show.txt
2026-04-16 00:17:58.251994 | instance | >f+++++++++ system/docker-images.txt
2026-04-16 00:17:58.252014 | instance | >f+++++++++ system/ip-addr.txt
2026-04-16 00:17:58.252036 | instance | >f+++++++++ system/ip-route.txt
2026-04-16 00:17:58.252058 | instance | >f+++++++++ system/lsblk.txt
2026-04-16 00:17:58.252078 | instance | >f+++++++++ system/mount.txt
2026-04-16 00:17:58.252099 | instance | >f+++++++++ system/packages.txt
2026-04-16 00:17:58.252119 | instance | >f+++++++++ system/ps.txt
2026-04-16 00:17:58.252138 | instance | >f+++++++++ system/systemd-cgls.txt
2026-04-16 00:17:58.260940 | 
2026-04-16 00:17:58.261021 | LOOP [helm-release-status : creating directory for helm release status]
2026-04-16 00:17:58.463942 | instance | changed: "values"
2026-04-16 00:17:58.633422 | instance | changed: "releases"
2026-04-16 00:17:58.646609 | 
2026-04-16 00:17:58.646744 | TASK [helm-release-status : Gather get release status for helm charts]
2026-04-16 00:17:58.846119 | instance | /bin/bash: line 3: kubectl: command not found
2026-04-16 00:17:59.181900 | instance | ok: Runtime: 0:00:00.005590
2026-04-16 00:17:59.188635 | 
2026-04-16 00:17:59.188736 | TASK [helm-release-status : Downloads logs to executor]
2026-04-16 00:17:59.660820 | instance | changed:
2026-04-16 00:17:59.661105 | instance | cd+++++++++ helm/
2026-04-16 00:17:59.661169 | instance | cd+++++++++ helm/releases/
2026-04-16 00:17:59.661217 | instance | cd+++++++++ helm/values/
2026-04-16 00:17:59.671928 | 
2026-04-16 00:17:59.671997 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-04-16 00:17:59.880695 | instance | changed
2026-04-16 00:17:59.885675 | 
2026-04-16 00:17:59.885745 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-04-16 00:18:00.090682 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-16 00:18:00.091065 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-16 00:18:00.096951 | instance | environment: line 1: kubectl: command not found
2026-04-16 00:18:00.098109 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-16 00:18:00.098660 | instance | environment: line 1: kubectl: command not found
2026-04-16 00:18:00.100486 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-16 00:18:00.101014 | instance | environment: line 1: kubectl: command not found
2026-04-16 00:18:00.101892 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-16 00:18:00.104110 | instance | environment: line 1: kubectl: command not found
2026-04-16 00:18:00.105154 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-16 00:18:00.106279 | instance | environment: line 1: kubectl: command not found
2026-04-16 00:18:00.107223 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-16 00:18:00.420730 | instance | ok: Runtime: 0:00:00.023923
2026-04-16 00:18:00.426432 | 
2026-04-16 00:18:00.426498 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-04-16 00:18:00.615209 | instance | changed
2026-04-16 00:18:00.620075 | 
2026-04-16 00:18:00.620145 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-04-16 00:18:00.869312 | instance | environment: line 5: kubectl: command not found
2026-04-16 00:18:00.869664 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-16 00:18:00.869973 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-16 00:18:00.870589 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-16 00:18:01.197308 | instance | ok: Runtime: 0:00:00.006548
2026-04-16 00:18:01.204900 | 
2026-04-16 00:18:01.205012 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-04-16 00:18:01.682854 | instance | changed:
2026-04-16 00:18:01.683042 | instance | cd+++++++++ objects/
2026-04-16 00:18:01.683070 | instance | cd+++++++++ objects/cluster/
2026-04-16 00:18:01.683091 | instance | cd+++++++++ objects/namespaced/
2026-04-16 00:18:01.692287 | 
2026-04-16 00:18:01.692426 | TASK [gather-pod-logs : creating directory for pod logs]
2026-04-16 00:18:01.898609 | instance | changed
2026-04-16 00:18:01.903471 | 
2026-04-16 00:18:01.903533 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-04-16 00:18:02.112641 | instance | changed
2026-04-16 00:18:02.117796 | 
2026-04-16 00:18:02.117882 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-04-16 00:18:02.336793 | instance | environment: line 3: kubectl: command not found
2026-04-16 00:18:02.655512 | instance | ok: Runtime: 0:00:00.009542
2026-04-16 00:18:02.662541 | 
2026-04-16 00:18:02.662631 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-04-16 00:18:03.144825 | instance | changed:
2026-04-16 00:18:03.145022 | instance | cd+++++++++ pod-logs/
2026-04-16 00:18:03.145052 | instance | cd+++++++++ pod-logs/failed-pods/
2026-04-16 00:18:03.154681 | 
2026-04-16 00:18:03.154820 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-04-16 00:18:03.350840 | instance | changed
2026-04-16 00:18:03.356604 | 
2026-04-16 00:18:03.356671 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-04-16 00:18:03.569463 | instance | /bin/bash: line 2: kubectl: command not found
2026-04-16 00:18:03.891477 | instance | ok: Runtime: 0:00:00.034485
2026-04-16 00:18:03.898310 | 
2026-04-16 00:18:03.898404 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-04-16 00:18:04.118527 | instance | /bin/bash: line 2: kubectl: command not found
2026-04-16 00:18:04.148898 | instance | ceph-mgr endpoints:
2026-04-16 00:18:04.450762 | instance | ok: Runtime: 0:00:00.035727
2026-04-16 00:18:04.458498 | 
2026-04-16 00:18:04.458616 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-04-16 00:18:04.662469 | instance | /bin/bash: line 4: kubectl: command not found
2026-04-16 00:18:04.992006 | instance | ok: Runtime: 0:00:00.039789
2026-04-16 00:18:04.997937 | 
2026-04-16 00:18:04.998037 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-04-16 00:18:05.495244 | instance | changed: cd+++++++++ prometheus/
2026-04-16 00:18:05.508396 | 
2026-04-16 00:18:05.508509 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-04-16 00:18:05.705966 | instance | changed
2026-04-16 00:18:05.712555 | 
2026-04-16 00:18:05.712647 | TASK [gather-selenium-data : Get selenium data]
2026-04-16 00:18:05.922000 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-04-16 00:18:05.923530 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-04-16 00:18:06.250258 | instance | ERROR
2026-04-16 00:18:06.250497 | instance | {
2026-04-16 00:18:06.250639 | instance |   "delta": "0:00:00.006081",
2026-04-16 00:18:06.250693 | instance |   "end": "2026-04-16 00:18:05.923886",
2026-04-16 00:18:06.250736 | instance |   "msg": "non-zero return code",
2026-04-16 00:18:06.250776 | instance |   "rc": 1,
2026-04-16 00:18:06.250817 | instance |   "start": "2026-04-16 00:18:05.917805"
2026-04-16 00:18:06.250856 | instance | }
2026-04-16 00:18:06.250906 | instance | ERROR: Ignoring Errors
2026-04-16 00:18:06.257682 | 
2026-04-16 00:18:06.257770 | TASK [gather-selenium-data : Downloads logs to executor]
2026-04-16 00:18:06.754892 | instance | changed: cd+++++++++ selenium/
2026-04-16 00:18:06.762583 | 
2026-04-16 00:18:06.762633 | PLAY RECAP
2026-04-16 00:18:06.762707 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-04-16 00:18:06.762736 | 
2026-04-16 00:18:06.879634 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-04-16 00:18:06.883827 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-16 00:18:07.464433 | 
2026-04-16 00:18:07.465022 | PLAY [all]
2026-04-16 00:18:07.477363 | 
2026-04-16 00:18:07.477443 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-16 00:18:07.523549 | instance | skipping: Conditional result was False
2026-04-16 00:18:07.533053 | 
2026-04-16 00:18:07.533151 | TASK [fetch-output : Set log path for single node]
2026-04-16 00:18:07.579290 | instance | ok
2026-04-16 00:18:07.584058 | 
2026-04-16 00:18:07.584128 | LOOP [fetch-output : Ensure local output dirs]
2026-04-16 00:18:07.968195 | instance -> localhost | ok: "/var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/logs"
2026-04-16 00:18:08.201794 | instance -> localhost | changed: "/var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/artifacts"
2026-04-16 00:18:08.421005 | instance -> localhost | changed: "/var/lib/zuul/builds/cf051d10d3434f999750c1e3c1d0dc38/work/docs"
2026-04-16 00:18:08.441857 | 
2026-04-16 00:18:08.441989 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-16 00:18:09.061230 | instance | changed: .d..t...... ./
2026-04-16 00:18:09.061475 | instance | changed: All items complete
2026-04-16 00:18:09.061514 | 
2026-04-16 00:18:09.500863 | instance | changed: .d..t...... ./
2026-04-16 00:18:09.961365 | instance | changed: .d..t...... ./
2026-04-16 00:18:09.985601 | 
2026-04-16 00:18:09.985792 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-16 00:18:10.406069 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006457
2026-04-16 00:18:10.636673 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007347
2026-04-16 00:18:10.649924 | 
2026-04-16 00:18:10.650060 | PLAY [all]
2026-04-16 00:18:10.656439 | 
2026-04-16 00:18:10.656506 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-16 00:18:11.044830 | instance | changed
2026-04-16 00:18:11.053021 | 
2026-04-16 00:18:11.053089 | PLAY RECAP
2026-04-16 00:18:11.053148 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-16 00:18:11.053180 | 
2026-04-16 00:18:11.160655 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-16 00:18:11.165873 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-16 00:18:11.725733 | 
2026-04-16 00:18:11.726183 | PLAY [localhost]
2026-04-16 00:18:11.735815 | 
2026-04-16 00:18:11.735884 | TASK [Generate Zuul manifest]
2026-04-16 00:18:11.778427 | localhost | ok
2026-04-16 00:18:11.792914 | 
2026-04-16 00:18:11.793006 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-16 00:18:12.106182 | localhost | changed
2026-04-16 00:18:12.117821 | 
2026-04-16 00:18:12.117891 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-16 00:18:12.148549 | localhost | ok
2026-04-16 00:18:12.158966 | 
2026-04-16 00:18:12.159028 | TASK [Upload logs]
2026-04-16 00:18:12.182718 | localhost | ok
2026-04-16 00:18:12.237035 | 
2026-04-16 00:18:12.237120 | TASK [Set zuul-log-path fact]
2026-04-16 00:18:12.255799 | localhost | ok
2026-04-16 00:18:12.268307 | 
2026-04-16 00:18:12.268376 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-16 00:18:12.298357 | localhost | ok
2026-04-16 00:18:12.306912 | 
2026-04-16 00:18:12.306998 | TASK [upload-logs : Create log directories]
2026-04-16 00:18:12.784296 | localhost | changed
2026-04-16 00:18:12.791130 | 
2026-04-16 00:18:12.791203 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-16 00:18:13.198452 | localhost -> localhost | ok: Runtime: 0:00:00.005665
2026-04-16 00:18:13.204997 | 
2026-04-16 00:18:13.205090 | TASK [upload-logs : Upload logs to log server]
2026-04-16 00:18:13.665035 | localhost | Output suppressed because no_log was given
2026-04-16 00:18:13.668862 | 
2026-04-16 00:18:13.668932 | LOOP [upload-logs : Compress console log and json output]
2026-04-16 00:18:13.713871 | localhost | skipping: Conditional result was False
2026-04-16 00:18:13.720830 | localhost | skipping: Conditional result was False
2026-04-16 00:18:13.733277 | 
2026-04-16 00:18:13.733434 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-16 00:18:13.776080 | localhost | skipping: Conditional result was False
2026-04-16 00:18:13.776452 | 
2026-04-16 00:18:13.780574 | localhost | skipping: Conditional result was False
2026-04-16 00:18:13.796193 | 
2026-04-16 00:18:13.796329 | LOOP [upload-logs : Upload console log and json output]