2026-04-13 20:39:03.632736 | Job console starting 2026-04-13 20:39:03.643205 | Updating git repos 2026-04-13 20:39:03.694253 | Cloning repos into workspace 2026-04-13 20:39:03.771274 | Restoring repo states 2026-04-13 20:39:03.788410 | Merging changes 2026-04-13 20:39:05.075090 | Checking out repos 2026-04-13 20:39:05.162507 | Preparing playbooks 2026-04-13 20:39:07.329309 | Running Ansible setup 2026-04-13 20:39:11.030238 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 20:39:11.660740 | 2026-04-13 20:39:11.660980 | PLAY [localhost] 2026-04-13 20:39:11.673588 | 2026-04-13 20:39:11.673746 | TASK [Gathering Facts] 2026-04-13 20:39:12.894364 | localhost | ok 2026-04-13 20:39:12.905642 | 2026-04-13 20:39:12.905829 | TASK [Setup log path fact] 2026-04-13 20:39:12.923644 | localhost | ok 2026-04-13 20:39:12.937665 | 2026-04-13 20:39:12.937816 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 20:39:12.967957 | localhost | ok 2026-04-13 20:39:12.977876 | 2026-04-13 20:39:12.978069 | TASK [emit-job-header : Print job information] 2026-04-13 20:39:13.018572 | # Job Information 2026-04-13 20:39:13.018813 | Ansible Version: 2.16.16 2026-04-13 20:39:13.018869 | Job: atmosphere-molecule-csi-local-path-provisioner 2026-04-13 20:39:13.018905 | Pipeline: check 2026-04-13 20:39:13.018935 | Executor: 0a8996d2b663 2026-04-13 20:39:13.018983 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818 2026-04-13 20:39:13.019046 | Event ID: af35ae10-3778-11f1-8810-704e89e38670 2026-04-13 20:39:13.023477 | 2026-04-13 20:39:13.023560 | LOOP [emit-job-header : Print node information] 2026-04-13 20:39:13.115751 | localhost | ok: 2026-04-13 20:39:13.116758 | localhost | # Node Information 2026-04-13 20:39:13.116820 | localhost | Inventory Hostname: instance 2026-04-13 20:39:13.116856 | localhost | Hostname: np0000165706 2026-04-13 20:39:13.116899 | localhost | Username: zuul 2026-04-13 20:39:13.116941 | localhost | Distro: Ubuntu 22.04 2026-04-13 20:39:13.116997 | localhost | Provider: yul1 2026-04-13 20:39:13.117027 | localhost | Region: ca-ymq-1 2026-04-13 20:39:13.117055 | localhost | Label: ubuntu-jammy 2026-04-13 20:39:13.117081 | localhost | Product Name: OpenStack Nova 2026-04-13 20:39:13.117108 | localhost | Interface IP: 199.204.45.33 2026-04-13 20:39:13.134500 | 2026-04-13 20:39:13.134755 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-13 20:39:13.529657 | localhost -> localhost | changed 2026-04-13 20:39:13.538335 | 2026-04-13 20:39:13.538556 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-13 20:39:15.388422 | localhost -> localhost | changed 2026-04-13 20:39:15.398255 | 2026-04-13 20:39:15.398320 | PLAY [all] 2026-04-13 20:39:15.406529 | 2026-04-13 20:39:15.406598 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-13 20:39:15.647229 | instance -> localhost | ok 2026-04-13 20:39:15.657645 | 2026-04-13 20:39:15.657764 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-13 20:39:15.688803 | instance | ok 2026-04-13 20:39:15.703589 | instance | included: /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-13 20:39:15.709555 | 2026-04-13 20:39:15.709652 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-13 20:39:16.538723 | instance -> localhost | Generating public/private rsa key pair. 2026-04-13 20:39:16.538914 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/00ab2dfddc5f499ebfe59d15f9f68163_id_rsa 2026-04-13 20:39:16.538952 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/00ab2dfddc5f499ebfe59d15f9f68163_id_rsa.pub 2026-04-13 20:39:16.538982 | instance -> localhost | The key fingerprint is: 2026-04-13 20:39:16.539010 | instance -> localhost | SHA256:TdoZoDKbshqL/OPM5WjYTUou3mYsxcpFMg+9apHOdik zuul-build-sshkey 2026-04-13 20:39:16.539054 | instance -> localhost | The key's randomart image is: 2026-04-13 20:39:16.539084 | instance -> localhost | +---[RSA 3072]----+ 2026-04-13 20:39:16.539117 | instance -> localhost | | . | 2026-04-13 20:39:16.539145 | instance -> localhost | | . . | 2026-04-13 20:39:16.539171 | instance -> localhost | | . o . o | 2026-04-13 20:39:16.539195 | instance -> localhost | | + o = = o | 2026-04-13 20:39:16.539220 | instance -> localhost | | X + S + | 2026-04-13 20:39:16.539246 | instance -> localhost | | o X . | 2026-04-13 20:39:16.539272 | instance -> localhost | |= & =. | 2026-04-13 20:39:16.539296 | instance -> localhost | |oE+%+. | 2026-04-13 20:39:16.539323 | instance -> localhost | |Bo@B.. | 2026-04-13 20:39:16.539348 | instance -> localhost | +----[SHA256]-----+ 2026-04-13 20:39:16.539401 | instance -> localhost | ok: Runtime: 0:00:00.430244 2026-04-13 20:39:16.544820 | 2026-04-13 20:39:16.544896 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-13 20:39:16.577890 | instance | ok 2026-04-13 20:39:16.589220 | instance | included: /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-13 20:39:16.596302 | 2026-04-13 20:39:16.596367 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-13 20:39:16.620438 | instance | skipping: Conditional result was False 2026-04-13 20:39:16.631920 | 2026-04-13 20:39:16.632015 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-13 20:39:17.093060 | instance | changed 2026-04-13 20:39:17.099969 | 2026-04-13 20:39:17.100066 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-13 20:39:17.294471 | instance | ok 2026-04-13 20:39:17.304687 | 2026-04-13 20:39:17.304843 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-13 20:39:17.792948 | instance | changed 2026-04-13 20:39:17.798724 | 2026-04-13 20:39:17.798823 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-13 20:39:18.278377 | instance | changed 2026-04-13 20:39:18.309288 | 2026-04-13 20:39:18.309399 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-13 20:39:18.334013 | instance | skipping: Conditional result was False 2026-04-13 20:39:18.344076 | 2026-04-13 20:39:18.344248 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-13 20:39:18.695094 | instance -> localhost | changed 2026-04-13 20:39:18.709481 | 2026-04-13 20:39:18.709601 | TASK [add-build-sshkey : Add back temp key] 2026-04-13 20:39:18.993202 | instance -> localhost | Identity added: /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/00ab2dfddc5f499ebfe59d15f9f68163_id_rsa (zuul-build-sshkey) 2026-04-13 20:39:18.993358 | instance -> localhost | ok: Runtime: 0:00:00.008718 2026-04-13 20:39:18.999374 | 2026-04-13 20:39:18.999447 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-13 20:39:19.312052 | instance | ok 2026-04-13 20:39:19.317193 | 2026-04-13 20:39:19.317265 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-13 20:39:19.341196 | instance | skipping: Conditional result was False 2026-04-13 20:39:19.355502 | 2026-04-13 20:39:19.355630 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-13 20:39:19.681058 | instance | ok 2026-04-13 20:39:19.690278 | 2026-04-13 20:39:19.690386 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-13 20:39:21.544599 | instance | Output suppressed because no_log was given 2026-04-13 20:39:21.556300 | 2026-04-13 20:39:21.556363 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-13 20:39:21.743764 | instance | ok: "logs" 2026-04-13 20:39:21.744016 | instance | ok: All items complete 2026-04-13 20:39:21.744056 | 2026-04-13 20:39:21.902807 | instance | ok: "artifacts" 2026-04-13 20:39:22.054114 | instance | ok: "docs" 2026-04-13 20:39:22.071656 | 2026-04-13 20:39:22.071793 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-13 20:39:22.248577 | instance | changed: "logs" 2026-04-13 20:39:22.410315 | instance | changed: "artifacts" 2026-04-13 20:39:22.594457 | instance | changed: "docs" 2026-04-13 20:39:22.618215 | 2026-04-13 20:39:22.618388 | PLAY RECAP 2026-04-13 20:39:22.618447 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-13 20:39:22.618476 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:39:22.618499 | 2026-04-13 20:39:22.825534 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 20:39:22.829674 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 20:39:23.443606 | 2026-04-13 20:39:23.443758 | PLAY [all] 2026-04-13 20:39:23.457357 | 2026-04-13 20:39:23.457499 | TASK [setup-uv : Extract archive] 2026-04-13 20:39:25.612480 | instance | changed 2026-04-13 20:39:25.623638 | 2026-04-13 20:39:25.623873 | TASK [setup-uv : Print version] 2026-04-13 20:39:26.060123 | instance | uv 0.8.13 2026-04-13 20:39:26.171868 | instance | ok: Runtime: 0:00:00.010129 2026-04-13 20:39:26.180120 | 2026-04-13 20:39:26.180221 | PLAY RECAP 2026-04-13 20:39:26.180284 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:39:26.180312 | 2026-04-13 20:39:26.587524 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 20:39:26.589627 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 20:39:27.239080 | 2026-04-13 20:39:27.239245 | PLAY [all] 2026-04-13 20:39:27.252836 | 2026-04-13 20:39:27.253083 | TASK [Install "jq" for log collection] 2026-04-13 20:39:40.600641 | instance | changed 2026-04-13 20:39:40.608165 | 2026-04-13 20:39:40.608307 | TASK [Install pip3 for Python package management] 2026-04-13 20:39:45.127071 | instance | changed 2026-04-13 20:39:45.133811 | 2026-04-13 20:39:45.133904 | TASK [Install Python "kubernetes" library for kubernetes.core modules] 2026-04-13 20:39:48.215516 | instance | changed 2026-04-13 20:39:48.218344 | 2026-04-13 20:39:48.218400 | PLAY [all] 2026-04-13 20:39:48.237395 | 2026-04-13 20:39:48.237561 | TASK [ensure-go : Check installed go version] 2026-04-13 20:39:48.780788 | instance | ok: ERROR (ignored) 2026-04-13 20:39:48.781078 | instance | { 2026-04-13 20:39:48.781127 | instance | "failed_when_result": false, 2026-04-13 20:39:48.781157 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-04-13 20:39:48.781187 | instance | "rc": 2 2026-04-13 20:39:48.781217 | instance | } 2026-04-13 20:39:48.787833 | 2026-04-13 20:39:48.787930 | TASK [ensure-go : Skip if correct version of go is installed] 2026-04-13 20:39:48.841313 | instance | ok 2026-04-13 20:39:48.849405 | instance | included: /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-04-13 20:39:48.854399 | 2026-04-13 20:39:48.854473 | TASK [ensure-go : Create temp directory] 2026-04-13 20:39:49.150744 | instance | changed 2026-04-13 20:39:49.161077 | 2026-04-13 20:39:49.161329 | TASK [ensure-go : Get archive checksum] 2026-04-13 20:39:49.707660 | instance | ok: OK (64 bytes) 2026-04-13 20:39:49.715162 | 2026-04-13 20:39:49.715263 | TASK [ensure-go : Download go archive] 2026-04-13 20:39:51.437427 | instance | changed: OK (78559214 bytes) 2026-04-13 20:39:51.443147 | 2026-04-13 20:39:51.443208 | TASK [ensure-go : Install go] 2026-04-13 20:39:57.301721 | instance | changed 2026-04-13 20:39:57.309857 | 2026-04-13 20:39:57.310095 | PLAY [all] 2026-04-13 20:39:57.316034 | 2026-04-13 20:39:57.316118 | TASK [Build atmosphere binary] 2026-04-13 20:39:57.625881 | instance -> localhost | ERROR 2026-04-13 20:39:57.626231 | instance -> localhost | { 2026-04-13 20:39:57.626309 | instance -> localhost | "delta": null, 2026-04-13 20:39:57.626344 | instance -> localhost | "end": null, 2026-04-13 20:39:57.626371 | instance -> localhost | "msg": "Unable to change directory before execution: [Errno 2] No such file or directory: b'src/github.com/vexxhost/atmosphere'", 2026-04-13 20:39:57.626400 | instance -> localhost | "rc": null, 2026-04-13 20:39:57.626452 | instance -> localhost | "start": null 2026-04-13 20:39:57.626500 | instance -> localhost | } failure 2026-04-13 20:39:57.628581 | 2026-04-13 20:39:57.628677 | PLAY RECAP 2026-04-13 20:39:57.628779 | instance | ok: 9 changed: 6 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-13 20:39:57.628830 | 2026-04-13 20:39:57.792113 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 20:39:57.795837 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 20:39:58.412460 | 2026-04-13 20:39:58.955060 | PLAY [all] 2026-04-13 20:39:58.976742 | 2026-04-13 20:39:58.976935 | TASK [gather-host-logs : creating directory for system status] 2026-04-13 20:39:59.421533 | instance | changed 2026-04-13 20:39:59.429000 | 2026-04-13 20:39:59.429089 | TASK [gather-host-logs : Get logs for each host] 2026-04-13 20:39:59.828417 | instance | + systemd-cgls --full --all --no-pager 2026-04-13 20:39:59.840434 | instance | + ip addr 2026-04-13 20:39:59.842239 | instance | + ip route 2026-04-13 20:39:59.843809 | instance | + lsblk 2026-04-13 20:39:59.846223 | instance | + mount 2026-04-13 20:39:59.847480 | instance | + docker images 2026-04-13 20:39:59.847956 | instance | /bin/bash: line 7: docker: command not found 2026-04-13 20:39:59.848069 | instance | + brctl show 2026-04-13 20:39:59.848421 | instance | /bin/bash: line 8: brctl: command not found 2026-04-13 20:39:59.848611 | instance | + ps aux --sort=-%mem 2026-04-13 20:39:59.858645 | instance | + dpkg -l 2026-04-13 20:39:59.865019 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-13 20:39:59.865432 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-13 20:39:59.865483 | instance | /bin/bash: line 11: docker: command not found 2026-04-13 20:39:59.866072 | instance | + '[' '!' -z '' ']' 2026-04-13 20:39:59.968281 | instance | ok: Runtime: 0:00:00.043555 2026-04-13 20:39:59.976986 | 2026-04-13 20:39:59.977098 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-13 20:40:00.646474 | instance | changed: 2026-04-13 20:40:00.646648 | instance | created directory /var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/logs/instance 2026-04-13 20:40:00.646680 | instance | cd+++++++++ system/ 2026-04-13 20:40:00.646705 | instance | >f+++++++++ system/brctl-show.txt 2026-04-13 20:40:00.646728 | instance | >f+++++++++ system/docker-images.txt 2026-04-13 20:40:00.646750 | instance | >f+++++++++ system/ip-addr.txt 2026-04-13 20:40:00.646775 | instance | >f+++++++++ system/ip-route.txt 2026-04-13 20:40:00.646800 | instance | >f+++++++++ system/lsblk.txt 2026-04-13 20:40:00.646823 | instance | >f+++++++++ system/mount.txt 2026-04-13 20:40:00.646847 | instance | >f+++++++++ system/packages.txt 2026-04-13 20:40:00.646868 | instance | >f+++++++++ system/ps.txt 2026-04-13 20:40:00.646889 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-13 20:40:00.657537 | 2026-04-13 20:40:00.657665 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-13 20:40:00.871841 | instance | changed: "values" 2026-04-13 20:40:01.041963 | instance | changed: "releases" 2026-04-13 20:40:01.061187 | 2026-04-13 20:40:01.061393 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-13 20:40:01.268304 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-13 20:40:01.737812 | instance | ok: Runtime: 0:00:00.005150 2026-04-13 20:40:01.745267 | 2026-04-13 20:40:01.745427 | TASK [helm-release-status : Downloads logs to executor] 2026-04-13 20:40:02.256712 | instance | changed: 2026-04-13 20:40:02.256908 | instance | cd+++++++++ helm/ 2026-04-13 20:40:02.256952 | instance | cd+++++++++ helm/releases/ 2026-04-13 20:40:02.257027 | instance | cd+++++++++ helm/values/ 2026-04-13 20:40:02.268065 | 2026-04-13 20:40:02.268162 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-13 20:40:02.466825 | instance | changed 2026-04-13 20:40:02.474952 | 2026-04-13 20:40:02.475045 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-13 20:40:02.673517 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:40:02.673706 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:40:02.678815 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:40:02.679806 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:40:02.679953 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:40:02.681842 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:40:02.682588 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:40:02.683935 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:40:02.685348 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:40:02.685964 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:40:02.687240 | instance | environment: line 1: kubectl: command not found 2026-04-13 20:40:02.688276 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 20:40:03.009594 | instance | ok: Runtime: 0:00:00.023346 2026-04-13 20:40:03.016151 | 2026-04-13 20:40:03.016293 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-13 20:40:03.214851 | instance | changed 2026-04-13 20:40:03.220063 | 2026-04-13 20:40:03.220134 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-13 20:40:03.467200 | instance | environment: line 5: kubectl: command not found 2026-04-13 20:40:03.468239 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:40:03.468498 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:40:03.468532 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 20:40:03.786542 | instance | ok: Runtime: 0:00:00.009656 2026-04-13 20:40:03.792536 | 2026-04-13 20:40:03.792602 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-13 20:40:04.388429 | instance | changed: 2026-04-13 20:40:04.388689 | instance | cd+++++++++ objects/ 2026-04-13 20:40:04.388737 | instance | cd+++++++++ objects/cluster/ 2026-04-13 20:40:04.388775 | instance | cd+++++++++ objects/namespaced/ 2026-04-13 20:40:04.400672 | 2026-04-13 20:40:04.400796 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-13 20:40:04.612614 | instance | changed 2026-04-13 20:40:04.618438 | 2026-04-13 20:40:04.618539 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-13 20:40:04.829808 | instance | changed 2026-04-13 20:40:04.836461 | 2026-04-13 20:40:04.836553 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-13 20:40:05.050893 | instance | environment: line 3: kubectl: command not found 2026-04-13 20:40:05.370135 | instance | ok: Runtime: 0:00:00.009779 2026-04-13 20:40:05.375655 | 2026-04-13 20:40:05.375732 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-13 20:40:05.871244 | instance | changed: 2026-04-13 20:40:05.871472 | instance | cd+++++++++ pod-logs/ 2026-04-13 20:40:05.871515 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-13 20:40:05.889562 | 2026-04-13 20:40:05.889682 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-13 20:40:06.087508 | instance | changed 2026-04-13 20:40:06.094711 | 2026-04-13 20:40:06.094808 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-13 20:40:06.297292 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 20:40:07.588132 | instance | ok: Runtime: 0:00:00.032504 2026-04-13 20:40:07.595752 | 2026-04-13 20:40:07.595868 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-13 20:40:07.794748 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 20:40:07.822480 | instance | ceph-mgr endpoints: 2026-04-13 20:40:08.130743 | instance | ok: Runtime: 0:00:00.033445 2026-04-13 20:40:08.138221 | 2026-04-13 20:40:08.138300 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-13 20:40:08.332932 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-13 20:40:08.672712 | instance | ok: Runtime: 0:00:00.035797 2026-04-13 20:40:08.678088 | 2026-04-13 20:40:08.678152 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-13 20:40:09.155029 | instance | changed: cd+++++++++ prometheus/ 2026-04-13 20:40:09.165423 | 2026-04-13 20:40:09.165543 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-13 20:40:09.372733 | instance | changed 2026-04-13 20:40:09.379966 | 2026-04-13 20:40:09.380099 | TASK [gather-selenium-data : Get selenium data] 2026-04-13 20:40:09.587848 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-13 20:40:09.589358 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-13 20:40:09.916374 | instance | ERROR 2026-04-13 20:40:09.916595 | instance | { 2026-04-13 20:40:09.916644 | instance | "delta": "0:00:00.005979", 2026-04-13 20:40:09.916676 | instance | "end": "2026-04-13 20:40:09.589673", 2026-04-13 20:40:09.916703 | instance | "msg": "non-zero return code", 2026-04-13 20:40:09.916729 | instance | "rc": 1, 2026-04-13 20:40:09.916756 | instance | "start": "2026-04-13 20:40:09.583694" 2026-04-13 20:40:09.916781 | instance | } 2026-04-13 20:40:09.916814 | instance | ERROR: Ignoring Errors 2026-04-13 20:40:09.923659 | 2026-04-13 20:40:09.923751 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-13 20:40:10.410071 | instance | changed: cd+++++++++ selenium/ 2026-04-13 20:40:10.419395 | 2026-04-13 20:40:10.419584 | PLAY RECAP 2026-04-13 20:40:10.419643 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-13 20:40:10.419669 | 2026-04-13 20:40:10.579363 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 20:40:10.583617 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 20:40:11.251315 | 2026-04-13 20:40:11.251453 | PLAY [all] 2026-04-13 20:40:11.270047 | 2026-04-13 20:40:11.270240 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-13 20:40:11.315438 | instance | skipping: Conditional result was False 2026-04-13 20:40:11.323675 | 2026-04-13 20:40:11.323794 | TASK [fetch-output : Set log path for single node] 2026-04-13 20:40:11.354107 | instance | ok 2026-04-13 20:40:11.361250 | 2026-04-13 20:40:11.361432 | LOOP [fetch-output : Ensure local output dirs] 2026-04-13 20:40:13.227943 | instance -> localhost | ok: "/var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/logs" 2026-04-13 20:40:13.465538 | instance -> localhost | changed: "/var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/artifacts" 2026-04-13 20:40:13.691342 | instance -> localhost | changed: "/var/lib/zuul/builds/00ab2dfddc5f499ebfe59d15f9f68163/work/docs" 2026-04-13 20:40:13.709587 | 2026-04-13 20:40:13.709720 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-13 20:40:14.316484 | instance | changed: .d..t...... ./ 2026-04-13 20:40:14.316748 | instance | changed: All items complete 2026-04-13 20:40:14.316788 | 2026-04-13 20:40:14.804881 | instance | changed: .d..t...... ./ 2026-04-13 20:40:15.286336 | instance | changed: .d..t...... ./ 2026-04-13 20:40:15.305777 | 2026-04-13 20:40:15.305928 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-13 20:40:15.744051 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009710 2026-04-13 20:40:15.996997 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006146 2026-04-13 20:40:16.011988 | 2026-04-13 20:40:16.012096 | PLAY [all] 2026-04-13 20:40:16.018467 | 2026-04-13 20:40:16.018551 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-13 20:40:16.417101 | instance | changed 2026-04-13 20:40:16.422989 | 2026-04-13 20:40:16.423042 | PLAY RECAP 2026-04-13 20:40:16.423086 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 20:40:16.423108 | 2026-04-13 20:40:16.541734 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 20:40:16.546096 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-13 20:40:17.116486 | 2026-04-13 20:40:22.335583 | PLAY [localhost] 2026-04-13 20:40:22.356046 | 2026-04-13 20:40:22.356196 | TASK [Generate Zuul manifest] 2026-04-13 20:40:22.375499 | localhost | ok 2026-04-13 20:40:22.393135 | 2026-04-13 20:40:22.393281 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-13 20:40:22.780252 | localhost | changed 2026-04-13 20:40:22.793242 | 2026-04-13 20:40:22.793358 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-13 20:40:23.097806 | localhost | ok 2026-04-13 20:40:23.107093 | 2026-04-13 20:40:23.107191 | TASK [Upload logs] 2026-04-13 20:40:23.129460 | localhost | ok 2026-04-13 20:40:23.192411 | 2026-04-13 20:40:23.192534 | TASK [Set zuul-log-path fact] 2026-04-13 20:40:23.209550 | localhost | ok 2026-04-13 20:40:23.219823 | 2026-04-13 20:40:23.219902 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 20:40:23.248901 | localhost | ok 2026-04-13 20:40:23.259808 | 2026-04-13 20:40:23.259916 | TASK [upload-logs : Create log directories] 2026-04-13 20:40:23.654636 | localhost | changed 2026-04-13 20:40:23.661978 | 2026-04-13 20:40:23.662090 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-13 20:40:24.111919 | localhost -> localhost | ok: Runtime: 0:00:00.005501 2026-04-13 20:40:24.117404 | 2026-04-13 20:40:24.117471 | TASK [upload-logs : Upload logs to log server] 2026-04-13 20:40:24.627462 | localhost | Output suppressed because no_log was given 2026-04-13 20:40:24.632127 | 2026-04-13 20:40:24.632221 | LOOP [upload-logs : Compress console log and json output] 2026-04-13 20:40:24.685617 | localhost | skipping: Conditional result was False 2026-04-13 20:40:24.694171 | localhost | skipping: Conditional result was False 2026-04-13 20:40:24.709183 | 2026-04-13 20:40:24.709366 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-13 20:40:24.757673 | localhost | skipping: Conditional result was False 2026-04-13 20:40:24.758105 | 2026-04-13 20:40:24.763048 | localhost | skipping: Conditional result was False 2026-04-13 20:40:24.774382 | 2026-04-13 20:40:24.774559 | LOOP [upload-logs : Upload console log and json output]