2026-04-13 16:33:04.840948 | Job console starting
2026-04-13 16:33:04.856027 | Updating git repos
2026-04-13 16:33:04.975549 | Cloning repos into workspace
2026-04-13 16:33:05.059076 | Restoring repo states
2026-04-13 16:33:05.075469 | Merging changes
2026-04-13 16:33:06.111005 | Checking out repos
2026-04-13 16:33:06.265885 | Preparing playbooks
2026-04-13 16:33:09.474007 | Running Ansible setup
2026-04-13 16:33:13.124434 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-13 16:33:13.775482 | 
2026-04-13 16:33:13.775688 | PLAY [localhost]
2026-04-13 16:33:13.786728 | 
2026-04-13 16:33:13.786857 | TASK [Gathering Facts]
2026-04-13 16:33:14.752151 | localhost | ok
2026-04-13 16:33:14.763297 | 
2026-04-13 16:33:14.763468 | TASK [Setup log path fact]
2026-04-13 16:33:14.784302 | localhost | ok
2026-04-13 16:33:14.796385 | 
2026-04-13 16:33:14.796452 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-13 16:33:14.823714 | localhost | ok
2026-04-13 16:33:14.832762 | 
2026-04-13 16:33:14.832832 | TASK [emit-job-header : Print job information]
2026-04-13 16:33:14.874279 | # Job Information
2026-04-13 16:33:14.874486 | Ansible Version: 2.16.16
2026-04-13 16:33:14.874532 | Job: atmosphere-molecule-aio-ovn
2026-04-13 16:33:14.874562 | Pipeline: check
2026-04-13 16:33:14.874591 | Executor: 0a8996d2b663
2026-04-13 16:33:14.874619 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818
2026-04-13 16:33:14.874650 | Event ID: 5dc2aaf0-3756-11f1-8508-ec1623968e8a
2026-04-13 16:33:14.878504 | 
2026-04-13 16:33:14.878593 | LOOP [emit-job-header : Print node information]
2026-04-13 16:33:14.978702 | localhost | ok:
2026-04-13 16:33:14.979034 | localhost | # Node Information
2026-04-13 16:33:14.979098 | localhost | Inventory Hostname: instance
2026-04-13 16:33:14.979149 | localhost | Hostname: np0000165538
2026-04-13 16:33:14.979193 | localhost | Username: zuul
2026-04-13 16:33:14.979243 | localhost | Distro: Ubuntu 22.04
2026-04-13 16:33:14.979287 | localhost | Provider: yul1
2026-04-13 16:33:14.979329 | localhost | Region: ca-ymq-1
2026-04-13 16:33:14.979436 | localhost | Label: ubuntu-jammy-16
2026-04-13 16:33:14.979483 | localhost | Product Name: OpenStack Nova
2026-04-13 16:33:14.979525 | localhost | Interface IP: 199.204.45.23
2026-04-13 16:33:15.000539 | 
2026-04-13 16:33:15.000816 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-04-13 16:33:15.423640 | localhost -> localhost | changed
2026-04-13 16:33:15.445784 | 
2026-04-13 16:33:15.445882 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-04-13 16:33:16.326231 | localhost -> localhost | changed
2026-04-13 16:33:16.338673 | 
2026-04-13 16:33:16.338729 | PLAY [all]
2026-04-13 16:33:16.347363 | 
2026-04-13 16:33:16.347427 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-04-13 16:33:16.566053 | instance -> localhost | ok
2026-04-13 16:33:16.576400 | 
2026-04-13 16:33:16.576489 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-04-13 16:33:16.612149 | instance | ok
2026-04-13 16:33:16.625862 | instance | included: /var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-04-13 16:33:16.631334 | 
2026-04-13 16:33:16.631393 | TASK [add-build-sshkey : Create Temp SSH key]
2026-04-13 16:33:17.839721 | instance -> localhost | Generating public/private rsa key pair.
2026-04-13 16:33:17.839907 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/a8e5d66dd941426f9ff2b18bd746afcd_id_rsa
2026-04-13 16:33:17.839937 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/a8e5d66dd941426f9ff2b18bd746afcd_id_rsa.pub
2026-04-13 16:33:17.839960 | instance -> localhost | The key fingerprint is:
2026-04-13 16:33:17.839981 | instance -> localhost | SHA256:MJgDEN3ttzZUEXr0ECP/PvgHGsYga8HdvuYe4QzrBOU zuul-build-sshkey
2026-04-13 16:33:17.840015 | instance -> localhost | The key's randomart image is:
2026-04-13 16:33:17.840037 | instance -> localhost | +---[RSA 3072]----+
2026-04-13 16:33:17.840062 | instance -> localhost | |o+.. .  . B+     |
2026-04-13 16:33:17.840084 | instance -> localhost | |  ...o.  =.+     |
2026-04-13 16:33:17.840105 | instance -> localhost | |    +oo.ooo .    |
2026-04-13 16:33:17.840125 | instance -> localhost | |     .===...     |
2026-04-13 16:33:17.840145 | instance -> localhost | |      .*E=. .    |
2026-04-13 16:33:17.840165 | instance -> localhost | |      o.+==+.    |
2026-04-13 16:33:17.840185 | instance -> localhost | |     . .oo=+o.   |
2026-04-13 16:33:17.840205 | instance -> localhost | |       o  +o ..  |
2026-04-13 16:33:17.840228 | instance -> localhost | |        .+o ..   |
2026-04-13 16:33:17.840248 | instance -> localhost | +----[SHA256]-----+
2026-04-13 16:33:17.840293 | instance -> localhost | ok: Runtime: 0:00:00.827981
2026-04-13 16:33:17.845423 | 
2026-04-13 16:33:17.845481 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-04-13 16:33:17.880682 | instance | ok
2026-04-13 16:33:17.889719 | instance | included: /var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-04-13 16:33:17.897003 | 
2026-04-13 16:33:17.897065 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-04-13 16:33:17.921522 | instance | skipping: Conditional result was False
2026-04-13 16:33:17.932430 | 
2026-04-13 16:33:17.932513 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-04-13 16:33:18.364044 | instance | changed
2026-04-13 16:33:18.371453 | 
2026-04-13 16:33:18.371520 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-04-13 16:33:18.547460 | instance | ok
2026-04-13 16:33:18.552530 | 
2026-04-13 16:33:18.552596 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-04-13 16:33:18.996637 | instance | changed
2026-04-13 16:33:19.003408 | 
2026-04-13 16:33:19.003496 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-04-13 16:33:19.469753 | instance | changed
2026-04-13 16:33:19.474863 | 
2026-04-13 16:33:19.474927 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-04-13 16:33:19.499841 | instance | skipping: Conditional result was False
2026-04-13 16:33:19.512313 | 
2026-04-13 16:33:19.512420 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-04-13 16:33:19.893130 | instance -> localhost | changed
2026-04-13 16:33:19.938897 | 
2026-04-13 16:33:19.939027 | TASK [add-build-sshkey : Add back temp key]
2026-04-13 16:33:20.216118 | instance -> localhost | Identity added: /var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/a8e5d66dd941426f9ff2b18bd746afcd_id_rsa (zuul-build-sshkey)
2026-04-13 16:33:20.216374 | instance -> localhost | ok: Runtime: 0:00:00.014535
2026-04-13 16:33:20.223691 | 
2026-04-13 16:33:20.223802 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-04-13 16:33:20.475038 | instance | ok
2026-04-13 16:33:20.481905 | 
2026-04-13 16:33:20.482002 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-04-13 16:33:20.507281 | instance | skipping: Conditional result was False
2026-04-13 16:33:20.523144 | 
2026-04-13 16:33:20.523267 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-04-13 16:33:20.811254 | instance | ok
2026-04-13 16:33:20.819065 | 
2026-04-13 16:33:20.819128 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-04-13 16:33:22.354775 | instance | Output suppressed because no_log was given
2026-04-13 16:33:22.363960 | 
2026-04-13 16:33:22.364061 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-04-13 16:33:22.565514 | instance | ok: "logs"
2026-04-13 16:33:22.565798 | instance | ok: All items complete
2026-04-13 16:33:22.565838 | 
2026-04-13 16:33:22.716041 | instance | ok: "artifacts"
2026-04-13 16:33:22.867520 | instance | ok: "docs"
2026-04-13 16:33:22.881026 | 
2026-04-13 16:33:22.881222 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-04-13 16:33:23.064630 | instance | changed: "logs"
2026-04-13 16:33:23.217138 | instance | changed: "artifacts"
2026-04-13 16:33:23.375547 | instance | changed: "docs"
2026-04-13 16:33:23.395372 | 
2026-04-13 16:33:23.395501 | PLAY RECAP
2026-04-13 16:33:23.395554 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-04-13 16:33:23.395583 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-13 16:33:23.395603 | 
2026-04-13 16:33:23.533856 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-04-13 16:33:23.544922 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-13 16:33:24.124698 | 
2026-04-13 16:33:24.124840 | PLAY [all]
2026-04-13 16:33:24.137137 | 
2026-04-13 16:33:24.137255 | TASK [setup-uv : Extract archive]
2026-04-13 16:33:26.434303 | instance | changed
2026-04-13 16:33:26.440057 | 
2026-04-13 16:33:26.440145 | TASK [setup-uv : Print version]
2026-04-13 16:33:26.256753 | instance | uv 0.8.13
2026-04-13 16:33:26.985707 | instance | ok: Runtime: 0:00:00.013958
2026-04-13 16:33:26.991888 | 
2026-04-13 16:33:26.991935 | PLAY RECAP
2026-04-13 16:33:26.991978 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-04-13 16:33:26.992001 | 
2026-04-13 16:33:27.094746 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-04-13 16:33:27.107226 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-04-13 16:33:27.710610 | 
2026-04-13 16:33:27.710735 | PLAY [all]
2026-04-13 16:33:27.721542 | 
2026-04-13 16:33:27.721613 | TASK [Install "jq" for log collection]
2026-04-13 16:34:17.873844 | instance | changed
2026-04-13 16:34:17.880788 | 
2026-04-13 16:34:17.880885 | TASK [Install Python "kubernetes" library for kubernetes.core modules]
2026-04-13 16:34:18.341887 | instance | ERROR
2026-04-13 16:34:18.342199 | instance | {
2026-04-13 16:34:18.342233 | instance |   "msg": "Unable to find any of pip3 to use.  pip needs to be installed."
2026-04-13 16:34:18.342255 | instance | }
failure
2026-04-13 16:34:18.343354 | 
2026-04-13 16:34:18.343398 | PLAY RECAP
2026-04-13 16:34:18.343442 | instance | ok: 1 changed: 1 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-04-13 16:34:18.343462 | 
2026-04-13 16:34:18.451338 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-04-13 16:34:18.461454 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-04-13 16:34:19.049100 | 
2026-04-13 16:34:19.049241 | PLAY [all]
2026-04-13 16:34:19.063519 | 
2026-04-13 16:34:19.063610 | TASK [gather-host-logs : creating directory for system status]
2026-04-13 16:34:19.414653 | instance | changed
2026-04-13 16:34:19.420104 | 
2026-04-13 16:34:19.420181 | TASK [gather-host-logs : Get logs for each host]
2026-04-13 16:34:19.797749 | instance | + systemd-cgls --full --all --no-pager
2026-04-13 16:34:19.810141 | instance | + ip addr
2026-04-13 16:34:19.812783 | instance | + ip route
2026-04-13 16:34:19.815118 | instance | + lsblk
2026-04-13 16:34:19.819210 | instance | + mount
2026-04-13 16:34:19.821842 | instance | + docker images
2026-04-13 16:34:19.822337 | instance | /bin/bash: line 7: docker: command not found
2026-04-13 16:34:19.822592 | instance | + brctl show
2026-04-13 16:34:19.823123 | instance | /bin/bash: line 8: brctl: command not found
2026-04-13 16:34:19.823415 | instance | + ps aux --sort=-%mem
2026-04-13 16:34:19.840526 | instance | + dpkg -l
2026-04-13 16:34:19.846476 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-04-13 16:34:19.847044 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-04-13 16:34:19.847198 | instance | /bin/bash: line 11: docker: command not found
2026-04-13 16:34:19.847582 | instance | + '[' '!' -z '' ']'
2026-04-13 16:34:19.958381 | instance | ok: Runtime: 0:00:00.056450
2026-04-13 16:34:19.966612 | 
2026-04-13 16:34:19.966679 | TASK [gather-host-logs : Downloads logs to executor]
2026-04-13 16:34:20.588929 | instance | changed:
2026-04-13 16:34:20.589170 | instance | created directory /var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/logs/instance
2026-04-13 16:34:20.589211 | instance | cd+++++++++ system/
2026-04-13 16:34:20.589241 | instance | >f+++++++++ system/brctl-show.txt
2026-04-13 16:34:20.589269 | instance | >f+++++++++ system/docker-images.txt
2026-04-13 16:34:20.589296 | instance | >f+++++++++ system/ip-addr.txt
2026-04-13 16:34:20.589326 | instance | >f+++++++++ system/ip-route.txt
2026-04-13 16:34:20.589355 | instance | >f+++++++++ system/lsblk.txt
2026-04-13 16:34:20.589384 | instance | >f+++++++++ system/mount.txt
2026-04-13 16:34:20.589414 | instance | >f+++++++++ system/packages.txt
2026-04-13 16:34:20.589441 | instance | >f+++++++++ system/ps.txt
2026-04-13 16:34:20.589467 | instance | >f+++++++++ system/systemd-cgls.txt
2026-04-13 16:34:20.601100 | 
2026-04-13 16:34:20.601167 | LOOP [helm-release-status : creating directory for helm release status]
2026-04-13 16:34:20.800886 | instance | changed: "values"
2026-04-13 16:34:20.984111 | instance | changed: "releases"
2026-04-13 16:34:20.995750 | 
2026-04-13 16:34:20.995856 | TASK [helm-release-status : Gather get release status for helm charts]
2026-04-13 16:34:21.197268 | instance | /bin/bash: line 3: kubectl: command not found
2026-04-13 16:34:21.533590 | instance | ok: Runtime: 0:00:00.006543
2026-04-13 16:34:21.541030 | 
2026-04-13 16:34:21.541122 | TASK [helm-release-status : Downloads logs to executor]
2026-04-13 16:34:22.021701 | instance | changed:
2026-04-13 16:34:22.021901 | instance | cd+++++++++ helm/
2026-04-13 16:34:22.021940 | instance | cd+++++++++ helm/releases/
2026-04-13 16:34:22.021970 | instance | cd+++++++++ helm/values/
2026-04-13 16:34:22.032159 | 
2026-04-13 16:34:22.032226 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-04-13 16:34:22.259585 | instance | changed
2026-04-13 16:34:22.309523 | 
2026-04-13 16:34:22.309698 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-04-13 16:34:22.520451 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:34:22.520531 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:34:22.526029 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:34:22.527538 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:34:22.529356 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:34:22.530889 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:34:22.532818 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:34:22.534492 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:34:22.535447 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:34:22.536784 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:34:22.538529 | instance | environment: line 1: kubectl: command not found
2026-04-13 16:34:22.539432 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-04-13 16:34:22.847920 | instance | ok: Runtime: 0:00:00.031272
2026-04-13 16:34:22.853623 | 
2026-04-13 16:34:22.853693 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-04-13 16:34:23.041054 | instance | changed
2026-04-13 16:34:23.048401 | 
2026-04-13 16:34:23.048504 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-04-13 16:34:23.268510 | instance | environment: line 5: kubectl: command not found
2026-04-13 16:34:23.269977 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:34:23.270018 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:34:23.270041 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-04-13 16:34:23.641240 | instance | ok: Runtime: 0:00:00.009576
2026-04-13 16:34:23.648979 | 
2026-04-13 16:34:23.649049 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-04-13 16:34:24.128997 | instance | changed:
2026-04-13 16:34:24.129158 | instance | cd+++++++++ objects/
2026-04-13 16:34:24.129203 | instance | cd+++++++++ objects/cluster/
2026-04-13 16:34:24.129226 | instance | cd+++++++++ objects/namespaced/
2026-04-13 16:34:24.138422 | 
2026-04-13 16:34:24.138493 | TASK [gather-pod-logs : creating directory for pod logs]
2026-04-13 16:34:24.332598 | instance | changed
2026-04-13 16:34:24.339699 | 
2026-04-13 16:34:24.339859 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-04-13 16:34:24.549003 | instance | changed
2026-04-13 16:34:24.553750 | 
2026-04-13 16:34:24.553817 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-04-13 16:34:24.757912 | instance | environment: line 3: kubectl: command not found
2026-04-13 16:34:25.088569 | instance | ok: Runtime: 0:00:00.009508
2026-04-13 16:34:25.093499 | 
2026-04-13 16:34:25.093564 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-04-13 16:34:25.573772 | instance | changed:
2026-04-13 16:34:25.573989 | instance | cd+++++++++ pod-logs/
2026-04-13 16:34:25.574029 | instance | cd+++++++++ pod-logs/failed-pods/
2026-04-13 16:34:25.586565 | 
2026-04-13 16:34:25.586630 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-04-13 16:34:25.782806 | instance | changed
2026-04-13 16:34:25.789501 | 
2026-04-13 16:34:25.789594 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-04-13 16:34:25.999157 | instance | /bin/bash: line 2: kubectl: command not found
2026-04-13 16:34:26.326806 | instance | ok: Runtime: 0:00:00.037478
2026-04-13 16:34:26.333539 | 
2026-04-13 16:34:26.333612 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-04-13 16:34:26.538324 | instance | /bin/bash: line 2: kubectl: command not found
2026-04-13 16:34:26.566623 | instance | ceph-mgr endpoints:
2026-04-13 16:34:26.870110 | instance | ok: Runtime: 0:00:00.035820
2026-04-13 16:34:26.877019 | 
2026-04-13 16:34:26.877114 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-04-13 16:34:27.089923 | instance | /bin/bash: line 4: kubectl: command not found
2026-04-13 16:34:27.415713 | instance | ok: Runtime: 0:00:00.035122
2026-04-13 16:34:27.422354 | 
2026-04-13 16:34:27.422416 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-04-13 16:34:27.910591 | instance | changed: cd+++++++++ prometheus/
2026-04-13 16:34:27.921745 | 
2026-04-13 16:34:27.921809 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-04-13 16:34:28.169321 | instance | changed
2026-04-13 16:34:28.174368 | 
2026-04-13 16:34:28.174434 | TASK [gather-selenium-data : Get selenium data]
2026-04-13 16:34:28.384957 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-04-13 16:34:28.386593 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-04-13 16:34:28.707550 | instance | ERROR
2026-04-13 16:34:28.707822 | instance | {
2026-04-13 16:34:28.707874 | instance |   "delta": "0:00:00.007689",
2026-04-13 16:34:28.707925 | instance |   "end": "2026-04-13 16:34:28.386926",
2026-04-13 16:34:28.707957 | instance |   "msg": "non-zero return code",
2026-04-13 16:34:28.707986 | instance |   "rc": 1,
2026-04-13 16:34:28.708014 | instance |   "start": "2026-04-13 16:34:28.379237"
2026-04-13 16:34:28.708042 | instance | }
2026-04-13 16:34:28.708082 | instance | ERROR: Ignoring Errors
2026-04-13 16:34:28.715295 | 
2026-04-13 16:34:28.715384 | TASK [gather-selenium-data : Downloads logs to executor]
2026-04-13 16:34:29.195220 | instance | changed: cd+++++++++ selenium/
2026-04-13 16:34:29.200933 | 
2026-04-13 16:34:29.200998 | PLAY RECAP
2026-04-13 16:34:29.201042 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-04-13 16:34:29.201065 | 
2026-04-13 16:34:29.319759 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-04-13 16:34:29.331068 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-13 16:34:29.939808 | 
2026-04-13 16:34:30.052037 | PLAY [all]
2026-04-13 16:34:30.067499 | 
2026-04-13 16:34:30.067593 | TASK [fetch-output : Set log path for multiple nodes]
2026-04-13 16:34:30.112590 | instance | skipping: Conditional result was False
2026-04-13 16:34:30.124656 | 
2026-04-13 16:34:30.124739 | TASK [fetch-output : Set log path for single node]
2026-04-13 16:34:30.167120 | instance | ok
2026-04-13 16:34:30.173176 | 
2026-04-13 16:34:30.173246 | LOOP [fetch-output : Ensure local output dirs]
2026-04-13 16:34:30.539433 | instance -> localhost | ok: "/var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/logs"
2026-04-13 16:34:30.733036 | instance -> localhost | changed: "/var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/artifacts"
2026-04-13 16:34:30.938960 | instance -> localhost | changed: "/var/lib/zuul/builds/a8e5d66dd941426f9ff2b18bd746afcd/work/docs"
2026-04-13 16:34:30.959205 | 
2026-04-13 16:34:30.959371 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-04-13 16:34:31.580406 | instance | changed: .d..t...... ./
2026-04-13 16:34:31.580654 | instance | changed: All items complete
2026-04-13 16:34:31.580707 | 
2026-04-13 16:34:32.044035 | instance | changed: .d..t...... ./
2026-04-13 16:34:32.497990 | instance | changed: .d..t...... ./
2026-04-13 16:34:32.516764 | 
2026-04-13 16:34:32.516910 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-04-13 16:34:32.937932 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007220
2026-04-13 16:34:33.172219 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007730
2026-04-13 16:34:33.184420 | 
2026-04-13 16:34:33.184542 | PLAY [all]
2026-04-13 16:34:33.191455 | 
2026-04-13 16:34:33.191587 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-04-13 16:34:33.579033 | instance | changed
2026-04-13 16:34:33.585341 | 
2026-04-13 16:34:33.585385 | PLAY RECAP
2026-04-13 16:34:33.585429 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-04-13 16:34:33.585450 | 
2026-04-13 16:34:33.714705 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-04-13 16:34:33.728075 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-04-13 16:34:34.314629 | 
2026-04-13 16:34:34.315200 | PLAY [localhost]
2026-04-13 16:34:34.325746 | 
2026-04-13 16:34:34.325816 | TASK [Generate Zuul manifest]
2026-04-13 16:34:34.347322 | localhost | ok
2026-04-13 16:34:34.362799 | 
2026-04-13 16:34:34.362878 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-04-13 16:34:34.720010 | localhost | changed
2026-04-13 16:34:34.731873 | 
2026-04-13 16:34:34.731946 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-04-13 16:34:34.763296 | localhost | ok
2026-04-13 16:34:34.771997 | 
2026-04-13 16:34:34.772066 | TASK [Upload logs]
2026-04-13 16:34:34.792580 | localhost | ok
2026-04-13 16:34:34.894266 | 
2026-04-13 16:34:34.894413 | TASK [Set zuul-log-path fact]
2026-04-13 16:34:34.916373 | localhost | ok
2026-04-13 16:34:34.930591 | 
2026-04-13 16:34:34.930672 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-04-13 16:34:34.971806 | localhost | ok
2026-04-13 16:34:34.982641 | 
2026-04-13 16:34:34.982716 | TASK [upload-logs : Create log directories]
2026-04-13 16:34:35.364555 | localhost | changed
2026-04-13 16:34:35.370097 | 
2026-04-13 16:34:35.370174 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-04-13 16:34:35.735062 | localhost -> localhost | ok: Runtime: 0:00:00.005615
2026-04-13 16:34:35.741465 | 
2026-04-13 16:34:35.741563 | TASK [upload-logs : Upload logs to log server]
2026-04-13 16:34:36.152865 | localhost | Output suppressed because no_log was given
2026-04-13 16:34:36.157729 | 
2026-04-13 16:34:36.157851 | LOOP [upload-logs : Compress console log and json output]
2026-04-13 16:34:36.203462 | localhost | skipping: Conditional result was False
2026-04-13 16:34:36.210497 | localhost | skipping: Conditional result was False
2026-04-13 16:34:36.222791 | 
2026-04-13 16:34:36.222886 | LOOP [upload-logs : Upload compressed console log and json output]
2026-04-13 16:34:36.269356 | localhost | skipping: Conditional result was False
2026-04-13 16:34:36.269687 | 
2026-04-13 16:34:36.274246 | localhost | skipping: Conditional result was False
2026-04-13 16:34:36.286203 | 
2026-04-13 16:34:36.286386 | LOOP [upload-logs : Upload console log and json output]