2026-04-13 16:35:35.490687 | Job console starting
2026-04-13 16:35:35.499561 | Updating git repos
2026-04-13 16:35:35.576664 | Cloning repos into workspace
2026-04-13 16:35:35.974984 | Restoring repo states
2026-04-13 16:35:35.991130 | Merging changes
2026-04-13 16:35:37.134770 | Checking out repos
2026-04-13 16:35:37.267482 | Preparing playbooks
2026-04-13 16:35:40.557183 | Running Ansible setup
2026-04-13 16:35:43.763054 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-13 16:35:44.326095 | 
2026-04-13 16:35:44.326214 | PLAY [localhost]
2026-04-13 16:35:44.334153 | 
2026-04-13 16:35:44.334225 | TASK [Gathering Facts]
2026-04-13 16:35:45.205528 | localhost | ok
2026-04-13 16:35:45.215476 | 
2026-04-13 16:35:45.215551 | TASK [Setup log path fact]
2026-04-13 16:35:45.236886 | localhost | ok
2026-04-13 16:35:45.250345 | 
2026-04-13 16:35:45.250415 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-13 16:35:45.279724 | localhost | ok
2026-04-13 16:35:45.287645 | 
2026-04-13 16:35:45.287724 | TASK [emit-job-header : Print job information]
2026-04-13 16:35:45.328822 | # Job Information
2026-04-13 16:35:45.329066 | Ansible Version: 2.16.16
2026-04-13 16:35:45.329138 | Job: atmosphere-molecule-csi-local-path-provisioner
2026-04-13 16:35:45.329188 | Pipeline: check
2026-04-13 16:35:45.329233 | Executor: 0a8996d2b663
2026-04-13 16:35:45.329277 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818
2026-04-13 16:35:45.329325 | Event ID: 5dc2aaf0-3756-11f1-8508-ec1623968e8a
2026-04-13 16:35:45.335225 | 
2026-04-13 16:35:45.335288 | LOOP [emit-job-header : Print node information]
2026-04-13 16:35:45.424574 | localhost | ok:
2026-04-13 16:35:45.425455 | localhost | # Node Information
2026-04-13 16:35:45.425546 | localhost | Inventory Hostname: instance
2026-04-13 16:35:45.425602 | localhost | Hostname: np0000165547
2026-04-13 16:35:45.425650 | localhost | Username: zuul
2026-04-13 16:35:45.425702 | localhost | Distro: Ubuntu 22.04
2026-04-13 16:35:45.425748 | localhost | Provider: yul1
2026-04-13 16:35:45.425792 | localhost | Region: ca-ymq-1
2026-04-13 16:35:45.425836 | localhost | Label: ubuntu-jammy
2026-04-13 16:35:45.425881 | localhost | Product Name: OpenStack Nova
2026-04-13 16:35:45.425995 | localhost | Interface IP: 199.204.45.77
2026-04-13 16:35:45.443882 | 
2026-04-13 16:35:45.444019 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-13 16:35:45.814153 | localhost -> localhost | changed
2026-04-13 16:35:45.822246 | 
2026-04-13 16:35:45.822336 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-13 16:35:46.626907 | localhost -> localhost | changed
2026-04-13 16:35:46.636166 | 
2026-04-13 16:35:46.636237 | PLAY [all]
2026-04-13 16:35:46.645693 | 
2026-04-13 16:35:46.645762 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-13 16:35:46.854060 | instance -> localhost | ok
2026-04-13 16:35:46.865845 | 
2026-04-13 16:35:46.865947 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-13 16:35:46.900673 | instance | ok
2026-04-13 16:35:46.913417 | instance | included: /var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-13 16:35:46.918791 | 
2026-04-13 16:35:46.918848 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-13 16:35:47.723336 | instance -> localhost | Generating public/private rsa key pair.
2026-04-13 16:35:47.723536 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/a36b9ad379f240edaf8ce780ee08d4bc_id_rsa
2026-04-13 16:35:47.723578 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/a36b9ad379f240edaf8ce780ee08d4bc_id_rsa.pub
2026-04-13 16:35:47.723609 | instance -> localhost | The key fingerprint is:
2026-04-13 16:35:47.723638 | instance -> localhost | SHA256:MxA1p0NS/ocV/x6lbIRqabesq4nA3HKpiHalUekJhPo zuul-build-sshkey
2026-04-13 16:35:47.723683 | instance -> localhost | The key's randomart image is:
2026-04-13 16:35:47.723713 | instance -> localhost | +---[RSA 3072]----+
2026-04-13 16:35:47.723748 | instance -> localhost | |  .   oo= . .    |
2026-04-13 16:35:47.723777 | instance -> localhost | | . .   = +   +   |
2026-04-13 16:35:47.723805 | instance -> localhost | |. .   o +   o o .|
2026-04-13 16:35:47.723832 | instance -> localhost | |.  . o . o = o o.|
2026-04-13 16:35:47.723858 | instance -> localhost | | .  + . S B o +..|
2026-04-13 16:35:47.723885 | instance -> localhost | |  E+ = . = + o ..|
2026-04-13 16:35:47.723912 | instance -> localhost | |    O +     o   .|
2026-04-13 16:35:47.723939 | instance -> localhost | | o + = . . .     |
2026-04-13 16:35:47.723970 | instance -> localhost | |o o . . o.o.     |
2026-04-13 16:35:47.723998 | instance -> localhost | +----[SHA256]-----+
2026-04-13 16:35:47.724059 | instance -> localhost | ok: Runtime: 0:00:00.419379
2026-04-13 16:35:47.729471 | 
2026-04-13 16:35:47.729531 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-13 16:35:47.748280 | instance | ok
2026-04-13 16:35:47.758528 | instance | included: /var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-13 16:35:47.766252 | 
2026-04-13 16:35:47.766316 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-13 16:35:47.789338 | instance | skipping: Conditional result was False
2026-04-13 16:35:47.798667 | 
2026-04-13 16:35:47.798765 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-13 16:35:48.249587 | instance | changed
2026-04-13 16:35:48.256049 | 
2026-04-13 16:35:48.256110 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-13 16:35:48.429202 | instance | ok
2026-04-13 16:35:48.455052 | 
2026-04-13 16:35:48.455112 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-13 16:35:48.903089 | instance | changed
2026-04-13 16:35:48.907941 | 
2026-04-13 16:35:48.908003 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-13 16:35:49.360567 | instance | changed
2026-04-13 16:35:49.366188 | 
2026-04-13 16:35:49.366261 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-13 16:35:49.391586 | instance | skipping: Conditional result was False
2026-04-13 16:35:49.401436 | 
2026-04-13 16:35:49.401502 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-13 16:35:49.975862 | instance -> localhost | changed
2026-04-13 16:35:49.989717 | 
2026-04-13 16:35:49.989779 | TASK [add-build-sshkey : Add back temp key]
2026-04-13 16:35:50.298052 | instance -> localhost | Identity added: /var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/a36b9ad379f240edaf8ce780ee08d4bc_id_rsa (zuul-build-sshkey)
2026-04-13 16:35:50.298323 | instance -> localhost | ok: Runtime: 0:00:00.013801
2026-04-13 16:35:50.305554 | 
2026-04-13 16:35:50.305621 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-13 16:35:50.604289 | instance | ok
2026-04-13 16:35:50.609429 | 
2026-04-13 16:35:50.609496 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-13 16:35:50.634129 | instance | skipping: Conditional result was False
2026-04-13 16:35:50.649054 | 
2026-04-13 16:35:50.649119 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-13 16:35:50.956024 | instance | ok
2026-04-13 16:35:50.964781 | 
2026-04-13 16:35:50.964852 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-13 16:35:52.532609 | instance | Output suppressed because no_log was given
2026-04-13 16:35:52.543529 | 
2026-04-13 16:35:52.543589 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-13 16:35:52.728258 | instance | ok: "logs"
2026-04-13 16:35:52.728547 | instance | ok: All items complete
2026-04-13 16:35:52.728588 | 
2026-04-13 16:35:52.918076 | instance | ok: "artifacts"
2026-04-13 16:35:53.071813 | instance | ok: "docs"
2026-04-13 16:35:53.085060 | 
2026-04-13 16:35:53.085233 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-13 16:35:53.267131 | instance | changed: "logs"
2026-04-13 16:35:53.414224 | instance | changed: "artifacts"
2026-04-13 16:35:53.566564 | instance | changed: "docs"
2026-04-13 16:35:53.575271 | 
2026-04-13 16:35:53.575383 | PLAY RECAP
2026-04-13 16:35:53.575433 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-13 16:35:53.575462 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-13 16:35:53.575483 | 
2026-04-13 16:35:53.691585 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-13 16:35:53.694334 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-13 16:35:54.262595 | 
2026-04-13 16:35:54.262731 | PLAY [all]
2026-04-13 16:35:54.274047 | 
2026-04-13 16:35:54.274129 | TASK [setup-uv : Extract archive]
2026-04-13 16:35:56.469845 | instance | changed
2026-04-13 16:35:56.476745 | 
2026-04-13 16:35:56.476831 | TASK [setup-uv : Print version]
2026-04-13 16:35:55.704888 | instance | uv 0.8.13
2026-04-13 16:35:57.011323 | instance | ok: Runtime: 0:00:00.013181
2026-04-13 16:35:57.019219 | 
2026-04-13 16:35:57.019267 | PLAY RECAP
2026-04-13 16:35:57.019315 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-13 16:35:57.019340 | 
2026-04-13 16:35:57.117549 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-13 16:35:57.119754 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-04-13 16:35:57.666796 | 
2026-04-13 16:35:57.666949 | PLAY [all]
2026-04-13 16:35:57.681665 | 
2026-04-13 16:35:57.681783 | TASK [Install "jq" for log collection]
2026-04-13 16:36:09.113798 | instance | changed
2026-04-13 16:36:09.120779 | 
2026-04-13 16:36:09.120883 | TASK [Install Python "kubernetes" library for kubernetes.core modules]
2026-04-13 16:36:09.566237 | instance | ERROR
2026-04-13 16:36:09.566581 | instance | {
2026-04-13 16:36:09.566614 | instance |   "msg": "Unable to find any of pip3 to use.  pip needs to be installed."
2026-04-13 16:36:09.566637 | instance | }
failure
2026-04-13 16:36:09.567925 | 
2026-04-13 16:36:09.567972 | PLAY RECAP
2026-04-13 16:36:09.568019 | instance | ok: 1 changed: 1 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-04-13 16:36:09.568042 | 
2026-04-13 16:36:09.701498 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-04-13 16:36:09.704657 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-04-13 16:36:10.278159 | 
2026-04-13 16:36:10.278688 | PLAY [all]
2026-04-13 16:36:10.292543 | 
2026-04-13 16:36:10.292620 | TASK [gather-host-logs : creating directory for system status]
2026-04-13 16:36:10.628648 | instance | changed
2026-04-13 16:36:10.635703 | 
2026-04-13 16:36:10.635815 | TASK [gather-host-logs : Get logs for each host]
2026-04-13 16:36:11.008477 | instance | + systemd-cgls --full --all --no-pager
2026-04-13 16:36:11.018769 | instance | + ip addr
2026-04-13 16:36:11.020494 | instance | + ip route
2026-04-13 16:36:11.021856 | instance | + lsblk
2026-04-13 16:36:11.024031 | instance | + mount
2026-04-13 16:36:11.025308 | instance | + docker images
2026-04-13 16:36:11.025683 | instance | /bin/bash: line 7: docker: command not found
2026-04-13 16:36:11.025847 | instance | + brctl show
2026-04-13 16:36:11.026244 | instance | /bin/bash: line 8: brctl: command not found
2026-04-13 16:36:11.026449 | instance | + ps aux --sort=-%mem
2026-04-13 16:36:11.036540 | instance | + dpkg -l
2026-04-13 16:36:11.043860 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-04-13 16:36:11.044292 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-04-13 16:36:11.044325 | instance | /bin/bash: line 11: docker: command not found
2026-04-13 16:36:11.044644 | instance | + '[' '!' -z '' ']'
2026-04-13 16:36:11.176258 | instance | ok: Runtime: 0:00:00.041874
2026-04-13 16:36:11.186088 | 
2026-04-13 16:36:11.186161 | TASK [gather-host-logs : Downloads logs to executor]
2026-04-13 16:36:11.785557 | instance | changed:
2026-04-13 16:36:11.785793 | instance | created directory /var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/logs/instance
2026-04-13 16:36:11.785845 | instance | cd+++++++++ system/
2026-04-13 16:36:11.785884 | instance | >f+++++++++ system/brctl-show.txt
2026-04-13 16:36:11.785917 | instance | >f+++++++++ system/docker-images.txt
2026-04-13 16:36:11.785945 | instance | >f+++++++++ system/ip-addr.txt
2026-04-13 16:36:11.785976 | instance | >f+++++++++ system/ip-route.txt
2026-04-13 16:36:11.786009 | instance | >f+++++++++ system/lsblk.txt
2026-04-13 16:36:11.786038 | instance | >f+++++++++ system/mount.txt
2026-04-13 16:36:11.786067 | instance | >f+++++++++ system/packages.txt
2026-04-13 16:36:11.786095 | instance | >f+++++++++ system/ps.txt
2026-04-13 16:36:11.786121 | instance | >f+++++++++ system/systemd-cgls.txt
2026-04-13 16:36:11.797652 | 
2026-04-13 16:36:11.797739 | LOOP [helm-release-status : creating directory for helm release status]
2026-04-13 16:36:11.995264 | instance | changed: "values"
2026-04-13 16:36:12.181492 | instance | changed: "releases"
2026-04-13 16:36:12.199561 | 
2026-04-13 16:36:12.199776 | TASK [helm-release-status : Gather get release status for helm charts]
2026-04-13 16:36:12.418958 | instance | /bin/bash: line 3: kubectl: command not found
2026-04-13 16:36:12.739058 | instance | ok: Runtime: 0:00:00.006221
2026-04-13 16:36:12.747252 | 
2026-04-13 16:36:12.747347 | TASK [helm-release-status : Downloads logs to executor]
2026-04-13 16:36:13.209949 | instance | changed:
2026-04-13 16:36:13.210171 | instance | cd+++++++++ helm/
2026-04-13 16:36:13.210232 | instance | cd+++++++++ helm/releases/
2026-04-13 16:36:13.210263 | instance | cd+++++++++ helm/values/
2026-04-13 16:36:13.221001 | 
2026-04-13 16:36:13.221075 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-04-13 16:36:13.417614 | instance | changed
2026-04-13 16:36:13.425391 | 
2026-04-13 16:36:13.425480 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-04-13 16:36:13.632269 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:36:13.632330 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:36:13.636922 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:36:13.638336 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:36:13.639971 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:36:13.640996 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:36:13.641141 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:36:13.642914 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:36:13.643759 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:36:13.645320 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:36:13.646697 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:36:13.647561 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:36:13.960236 | instance | ok: Runtime: 0:00:00.025966
2026-04-13 16:36:13.966955 | 
2026-04-13 16:36:13.967036 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-04-13 16:36:14.162942 | instance | changed
2026-04-13 16:36:14.167728 | 
2026-04-13 16:36:14.167798 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-04-13 16:36:14.413840 | instance | environment: line 5: kubectl: command not found
2026-04-13 16:36:14.414059 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:36:14.415225 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:36:14.415368 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:36:14.728465 | instance | ok: Runtime: 0:00:00.010135
2026-04-13 16:36:14.734264 | 
2026-04-13 16:36:14.734329 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-04-13 16:36:15.210976 | instance | changed:
2026-04-13 16:36:15.211167 | instance | cd+++++++++ objects/
2026-04-13 16:36:15.211207 | instance | cd+++++++++ objects/cluster/
2026-04-13 16:36:15.211238 | instance | cd+++++++++ objects/namespaced/
2026-04-13 16:36:15.223573 | 
2026-04-13 16:36:15.223661 | TASK [gather-pod-logs : creating directory for pod logs]
2026-04-13 16:36:15.418621 | instance | changed
2026-04-13 16:36:16.125881 | 
2026-04-13 16:36:16.125983 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-04-13 16:36:16.342537 | instance | changed
2026-04-13 16:36:16.347396 | 
2026-04-13 16:36:16.347462 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-04-13 16:36:16.554679 | instance | environment: line 3: kubectl: command not found
2026-04-13 16:36:16.882976 | instance | ok: Runtime: 0:00:00.009290
2026-04-13 16:36:16.888675 | 
2026-04-13 16:36:16.888742 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-04-13 16:36:17.368655 | instance | changed:
2026-04-13 16:36:17.368849 | instance | cd+++++++++ pod-logs/
2026-04-13 16:36:17.368890 | instance | cd+++++++++ pod-logs/failed-pods/
2026-04-13 16:36:17.381352 | 
2026-04-13 16:36:17.381467 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-04-13 16:36:17.607480 | instance | changed
2026-04-13 16:36:17.612352 | 
2026-04-13 16:36:17.612415 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-04-13 16:36:17.825741 | instance | /bin/bash: line 2: kubectl: command not found
2026-04-13 16:36:18.147154 | instance | ok: Runtime: 0:00:00.036599
2026-04-13 16:36:18.153298 | 
2026-04-13 16:36:18.153364 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-04-13 16:36:18.356917 | instance | /bin/bash: line 2: kubectl: command not found
2026-04-13 16:36:18.386323 | instance | ceph-mgr endpoints:
2026-04-13 16:36:18.688307 | instance | ok: Runtime: 0:00:00.036571
2026-04-13 16:36:18.695347 | 
2026-04-13 16:36:18.695430 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-04-13 16:36:18.903163 | instance | /bin/bash: line 4: kubectl: command not found
2026-04-13 16:36:19.230575 | instance | ok: Runtime: 0:00:00.036446
2026-04-13 16:36:19.237552 | 
2026-04-13 16:36:19.237624 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-04-13 16:36:19.716853 | instance | changed: cd+++++++++ prometheus/
2026-04-13 16:36:19.728675 | 
2026-04-13 16:36:19.728745 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-04-13 16:36:19.927506 | instance | changed
2026-04-13 16:36:19.937135 | 
2026-04-13 16:36:19.937236 | TASK [gather-selenium-data : Get selenium data]
2026-04-13 16:36:20.151084 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-04-13 16:36:20.152255 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-04-13 16:36:20.482300 | instance | ERROR
2026-04-13 16:36:20.482577 | instance | {
2026-04-13 16:36:20.482622 | instance |   "delta": "0:00:00.006395",
2026-04-13 16:36:20.482673 | instance |   "end": "2026-04-13 16:36:20.152567",
2026-04-13 16:36:20.482702 | instance |   "msg": "non-zero return code",
2026-04-13 16:36:20.482728 | instance |   "rc": 1,
2026-04-13 16:36:20.482755 | instance |   "start": "2026-04-13 16:36:20.146172"
2026-04-13 16:36:20.482781 | instance | }
2026-04-13 16:36:20.482814 | instance | ERROR: Ignoring Errors
2026-04-13 16:36:20.489963 | 
2026-04-13 16:36:20.490084 | TASK [gather-selenium-data : Downloads logs to executor]
2026-04-13 16:36:20.988367 | instance | changed: cd+++++++++ selenium/
2026-04-13 16:36:20.997927 | 
2026-04-13 16:36:20.997991 | PLAY RECAP
2026-04-13 16:36:20.998058 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-04-13 16:36:20.998104 | 
2026-04-13 16:36:21.142995 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-04-13 16:36:21.147121 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-13 16:36:21.733643 | 
2026-04-13 16:36:21.733767 | PLAY [all]
2026-04-13 16:36:21.745432 | 
2026-04-13 16:36:21.745509 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-13 16:36:21.790619 | instance | skipping: Conditional result was False
2026-04-13 16:36:21.800616 | 
2026-04-13 16:36:21.800703 | TASK [fetch-output : Set log path for single node]
2026-04-13 16:36:21.844649 | instance | ok
2026-04-13 16:36:21.850905 | 
2026-04-13 16:36:21.850976 | LOOP [fetch-output : Ensure local output dirs]
2026-04-13 16:36:22.229051 | instance -> localhost | ok: "/var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/logs"
2026-04-13 16:36:22.453902 | instance -> localhost | changed: "/var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/artifacts"
2026-04-13 16:36:22.662113 | instance -> localhost | changed: "/var/lib/zuul/builds/a36b9ad379f240edaf8ce780ee08d4bc/work/docs"
2026-04-13 16:36:22.682697 | 
2026-04-13 16:36:22.682953 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-13 16:36:23.283721 | instance | changed: .d..t...... ./
2026-04-13 16:36:23.284008 | instance | changed: All items complete
2026-04-13 16:36:23.284045 | 
2026-04-13 16:36:23.720937 | instance | changed: .d..t...... ./
2026-04-13 16:36:24.165750 | instance | changed: .d..t...... ./
2026-04-13 16:36:24.184351 | 
2026-04-13 16:36:24.184517 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-13 16:36:24.615546 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.010011
2026-04-13 16:36:24.838136 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007640
2026-04-13 16:36:24.851350 | 
2026-04-13 16:36:24.851482 | PLAY [all]
2026-04-13 16:36:24.857840 | 
2026-04-13 16:36:24.857908 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-13 16:36:25.277134 | instance | changed
2026-04-13 16:36:25.283164 | 
2026-04-13 16:36:25.283217 | PLAY RECAP
2026-04-13 16:36:25.283265 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-13 16:36:25.283287 | 
2026-04-13 16:36:25.384364 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-13 16:36:25.388458 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-13 16:36:25.968266 | 
2026-04-13 16:36:25.968430 | PLAY [localhost]
2026-04-13 16:36:25.979114 | 
2026-04-13 16:36:25.979191 | TASK [Generate Zuul manifest]
2026-04-13 16:36:26.001432 | localhost | ok
2026-04-13 16:36:26.017128 | 
2026-04-13 16:36:26.017209 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-13 16:36:26.322497 | localhost | changed
2026-04-13 16:36:26.333768 | 
2026-04-13 16:36:26.333839 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-13 16:36:26.365763 | localhost | ok
2026-04-13 16:36:26.375951 | 
2026-04-13 16:36:26.376017 | TASK [Upload logs]
2026-04-13 16:36:26.409799 | localhost | ok
2026-04-13 16:36:26.465689 | 
2026-04-13 16:36:26.465802 | TASK [Set zuul-log-path fact]
2026-04-13 16:36:26.487148 | localhost | ok
2026-04-13 16:36:26.498782 | 
2026-04-13 16:36:26.498850 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-13 16:36:26.529682 | localhost | ok
2026-04-13 16:36:26.538383 | 
2026-04-13 16:36:26.538469 | TASK [upload-logs : Create log directories]
2026-04-13 16:36:26.917297 | localhost | changed
2026-04-13 16:36:26.923958 | 
2026-04-13 16:36:26.924026 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-13 16:36:27.331560 | localhost -> localhost | ok: Runtime: 0:00:00.005514
2026-04-13 16:36:27.336721 | 
2026-04-13 16:36:27.336793 | TASK [upload-logs : Upload logs to log server]
2026-04-13 16:36:27.793929 | localhost | Output suppressed because no_log was given
2026-04-13 16:36:27.798699 | 
2026-04-13 16:36:27.798798 | LOOP [upload-logs : Compress console log and json output]
2026-04-13 16:36:27.843818 | localhost | skipping: Conditional result was False
2026-04-13 16:36:27.851168 | localhost | skipping: Conditional result was False
2026-04-13 16:36:27.858728 | 
2026-04-13 16:36:27.858810 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-13 16:36:27.899878 | localhost | skipping: Conditional result was False
2026-04-13 16:36:27.900244 | 
2026-04-13 16:36:27.904275 | localhost | skipping: Conditional result was False
2026-04-13 16:36:27.919066 | 
2026-04-13 16:36:27.919160 | LOOP [upload-logs : Upload console log and json output]