2026-04-17 05:42:05.160479 | Job console starting 2026-04-17 05:42:05.170583 | Updating git repos 2026-04-17 05:42:05.231494 | Cloning repos into workspace 2026-04-17 05:42:05.324755 | Restoring repo states 2026-04-17 05:42:05.343138 | Merging changes 2026-04-17 05:42:06.352192 | Checking out repos 2026-04-17 05:42:06.442892 | Preparing playbooks 2026-04-17 05:42:08.639676 | Running Ansible setup 2026-04-17 05:42:12.459314 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 05:42:13.076481 | 2026-04-17 05:42:13.076598 | PLAY [localhost] 2026-04-17 05:42:13.084994 | 2026-04-17 05:42:13.085069 | TASK [Gathering Facts] 2026-04-17 05:42:14.227407 | localhost | ok 2026-04-17 05:42:14.240623 | 2026-04-17 05:42:14.240710 | TASK [Setup log path fact] 2026-04-17 05:42:14.261530 | localhost | ok 2026-04-17 05:42:14.276463 | 2026-04-17 05:42:14.276537 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 05:42:14.307147 | localhost | ok 2026-04-17 05:42:14.314216 | 2026-04-17 05:42:14.314283 | TASK [emit-job-header : Print job information] 2026-04-17 05:42:14.355353 | # Job Information 2026-04-17 05:42:14.355634 | Ansible Version: 2.16.16 2026-04-17 05:42:14.355701 | Job: atmosphere-molecule-csi-rbd 2026-04-17 05:42:14.355751 | Pipeline: check 2026-04-17 05:42:14.355798 | Executor: 0a8996d2b663 2026-04-17 05:42:14.355838 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501 2026-04-17 05:42:14.355878 | Event ID: 15debf40-3a20-11f1-98ff-82a4cf4a86b2 2026-04-17 05:42:14.361683 | 2026-04-17 05:42:14.361799 | LOOP [emit-job-header : Print node information] 2026-04-17 05:42:14.456721 | localhost | ok: 2026-04-17 05:42:14.457045 | localhost | # Node Information 2026-04-17 05:42:14.457114 | localhost | Inventory Hostname: instance 2026-04-17 05:42:14.457164 | localhost | Hostname: np0000166987 2026-04-17 05:42:14.457210 | localhost | Username: zuul 2026-04-17 05:42:14.457261 | localhost | Distro: Ubuntu 22.04 2026-04-17 05:42:14.457305 | localhost | Provider: yul1 2026-04-17 05:42:14.457348 | localhost | Region: ca-ymq-1 2026-04-17 05:42:14.457391 | localhost | Label: ubuntu-jammy 2026-04-17 05:42:14.457433 | localhost | Product Name: OpenStack Nova 2026-04-17 05:42:14.457475 | localhost | Interface IP: 199.204.45.35 2026-04-17 05:42:14.476229 | 2026-04-17 05:42:14.476433 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-17 05:42:15.214415 | localhost -> localhost | changed 2026-04-17 05:42:15.224941 | 2026-04-17 05:42:15.225131 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-17 05:42:16.117264 | localhost -> localhost | changed 2026-04-17 05:42:16.130374 | 2026-04-17 05:42:16.130868 | PLAY [all] 2026-04-17 05:42:16.143014 | 2026-04-17 05:42:16.143083 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-17 05:42:16.372490 | instance -> localhost | ok 2026-04-17 05:42:16.385637 | 2026-04-17 05:42:16.385723 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-17 05:42:16.420281 | instance | ok 2026-04-17 05:42:16.444541 | instance | included: /var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-17 05:42:16.451406 | 2026-04-17 05:42:16.451478 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-17 05:42:17.317427 | instance -> localhost | Generating public/private rsa key pair. 2026-04-17 05:42:17.318198 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/c580490c7ef14226b83837bb230ac1a9_id_rsa 2026-04-17 05:42:17.318291 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/c580490c7ef14226b83837bb230ac1a9_id_rsa.pub 2026-04-17 05:42:17.318336 | instance -> localhost | The key fingerprint is: 2026-04-17 05:42:17.318369 | instance -> localhost | SHA256:GTIiE2TGyZmTj8CwmOqNEr2I5fpDRq8Fv090yt1sU5c zuul-build-sshkey 2026-04-17 05:42:17.318437 | instance -> localhost | The key's randomart image is: 2026-04-17 05:42:17.318479 | instance -> localhost | +---[RSA 3072]----+ 2026-04-17 05:42:17.318516 | instance -> localhost | |++== | 2026-04-17 05:42:17.318547 | instance -> localhost | |o*O. | 2026-04-17 05:42:17.318615 | instance -> localhost | |+.o+. o . | 2026-04-17 05:42:17.318655 | instance -> localhost | |..+o.. o o . | 2026-04-17 05:42:17.318684 | instance -> localhost | |o.o+ . S . E | 2026-04-17 05:42:17.318712 | instance -> localhost | |o==.+o + o . . | 2026-04-17 05:42:17.318741 | instance -> localhost | |+=o+ .+ . = | 2026-04-17 05:42:17.318768 | instance -> localhost | |..o .. . . | 2026-04-17 05:42:17.319144 | instance -> localhost | |.... .. | 2026-04-17 05:42:17.319187 | instance -> localhost | +----[SHA256]-----+ 2026-04-17 05:42:17.319715 | instance -> localhost | ok: Runtime: 0:00:00.422751 2026-04-17 05:42:17.330885 | 2026-04-17 05:42:17.330968 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-17 05:42:17.363584 | instance | ok 2026-04-17 05:42:17.373536 | instance | included: /var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-17 05:42:17.381227 | 2026-04-17 05:42:17.381288 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-17 05:42:17.405496 | instance | skipping: Conditional result was False 2026-04-17 05:42:17.413589 | 2026-04-17 05:42:17.413681 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-17 05:42:17.855621 | instance | changed 2026-04-17 05:42:17.860450 | 2026-04-17 05:42:17.860517 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-17 05:42:18.035747 | instance | ok 2026-04-17 05:42:18.042547 | 2026-04-17 05:42:18.042638 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-17 05:42:18.542703 | instance | changed 2026-04-17 05:42:18.737587 | 2026-04-17 05:42:18.737751 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-17 05:42:19.189401 | instance | changed 2026-04-17 05:42:19.198239 | 2026-04-17 05:42:19.198383 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-17 05:42:19.222899 | instance | skipping: Conditional result was False 2026-04-17 05:42:19.232231 | 2026-04-17 05:42:19.232371 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-17 05:42:19.596831 | instance -> localhost | changed 2026-04-17 05:42:19.636397 | 2026-04-17 05:42:19.636549 | TASK [add-build-sshkey : Add back temp key] 2026-04-17 05:42:19.931911 | instance -> localhost | Identity added: /var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/c580490c7ef14226b83837bb230ac1a9_id_rsa (zuul-build-sshkey) 2026-04-17 05:42:19.932203 | instance -> localhost | ok: Runtime: 0:00:00.013532 2026-04-17 05:42:19.946916 | 2026-04-17 05:42:19.947104 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-17 05:42:20.243891 | instance | ok 2026-04-17 05:42:20.248822 | 2026-04-17 05:42:20.248889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-17 05:42:20.274172 | instance | skipping: Conditional result was False 2026-04-17 05:42:20.286670 | 2026-04-17 05:42:20.286741 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-17 05:42:20.606010 | instance | ok 2026-04-17 05:42:20.616523 | 2026-04-17 05:42:20.616651 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-17 05:42:22.567813 | instance | Output suppressed because no_log was given 2026-04-17 05:42:22.577822 | 2026-04-17 05:42:22.577884 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-17 05:42:22.783917 | instance | ok: "logs" 2026-04-17 05:42:22.784200 | instance | ok: All items complete 2026-04-17 05:42:22.784240 | 2026-04-17 05:42:22.935905 | instance | ok: "artifacts" 2026-04-17 05:42:23.089769 | instance | ok: "docs" 2026-04-17 05:42:23.099904 | 2026-04-17 05:42:23.100021 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-17 05:42:23.300294 | instance | changed: "logs" 2026-04-17 05:42:23.443859 | instance | changed: "artifacts" 2026-04-17 05:42:23.611673 | instance | changed: "docs" 2026-04-17 05:42:23.631688 | 2026-04-17 05:42:23.631790 | PLAY RECAP 2026-04-17 05:42:23.631838 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-17 05:42:23.631866 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 05:42:23.631886 | 2026-04-17 05:42:23.749837 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 05:42:23.754930 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 05:42:24.361707 | 2026-04-17 05:42:24.361835 | PLAY [all] 2026-04-17 05:42:24.373031 | 2026-04-17 05:42:24.373114 | TASK [setup-uv : Extract archive] 2026-04-17 05:42:26.642851 | instance | changed 2026-04-17 05:42:26.802596 | 2026-04-17 05:42:26.802766 | TASK [setup-uv : Print version] 2026-04-17 05:42:26.817230 | instance | uv 0.8.13 2026-04-17 05:42:27.342822 | instance | ok: Runtime: 0:00:00.013201 2026-04-17 05:42:27.350744 | 2026-04-17 05:42:27.350795 | PLAY RECAP 2026-04-17 05:42:27.350842 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 05:42:27.350869 | 2026-04-17 05:42:27.474571 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 05:42:27.478389 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-17 05:42:28.054463 | 2026-04-17 05:42:28.054576 | PLAY [all] 2026-04-17 05:42:28.064993 | 2026-04-17 05:42:28.065068 | TASK [Install "jq" for log collection] 2026-04-17 06:12:17.529550 | PRE-RUN END RESULT_TIMED_OUT: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-17 06:12:17.533373 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-17 06:12:18.139735 | 2026-04-17 06:12:18.139877 | PLAY [all] 2026-04-17 06:12:18.154744 | 2026-04-17 06:12:18.154841 | TASK [gather-host-logs : creating directory for system status] 2026-04-17 06:12:18.532762 | instance | changed 2026-04-17 06:12:18.540188 | 2026-04-17 06:12:18.540292 | TASK [gather-host-logs : Get logs for each host] 2026-04-17 06:12:18.902349 | instance | + systemd-cgls --full --all --no-pager 2026-04-17 06:12:18.914604 | instance | + ip addr 2026-04-17 06:12:18.917106 | instance | + ip route 2026-04-17 06:12:18.920013 | instance | + lsblk 2026-04-17 06:12:18.923517 | instance | + mount 2026-04-17 06:12:18.925908 | instance | + docker images 2026-04-17 06:12:18.926391 | instance | /bin/bash: line 7: docker: command not found 2026-04-17 06:12:18.926652 | instance | + brctl show 2026-04-17 06:12:18.927136 | instance | /bin/bash: line 8: brctl: command not found 2026-04-17 06:12:18.927397 | instance | + ps aux --sort=-%mem 2026-04-17 06:12:18.939127 | instance | + dpkg -l 2026-04-17 06:12:18.946697 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-17 06:12:18.947134 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-17 06:12:18.947156 | instance | /bin/bash: line 11: docker: command not found 2026-04-17 06:12:18.947472 | instance | + '[' '!' -z '' ']' 2026-04-17 06:12:19.077205 | instance | ok: Runtime: 0:00:00.050981 2026-04-17 06:12:19.083840 | 2026-04-17 06:12:19.083906 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-17 06:12:20.386866 | instance | changed: 2026-04-17 06:12:20.387146 | instance | created directory /var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/logs/instance 2026-04-17 06:12:20.387210 | instance | cd+++++++++ system/ 2026-04-17 06:12:20.387261 | instance | >f+++++++++ system/brctl-show.txt 2026-04-17 06:12:20.387358 | instance | >f+++++++++ system/docker-images.txt 2026-04-17 06:12:20.387429 | instance | >f+++++++++ system/ip-addr.txt 2026-04-17 06:12:20.387503 | instance | >f+++++++++ system/ip-route.txt 2026-04-17 06:12:20.387570 | instance | >f+++++++++ system/lsblk.txt 2026-04-17 06:12:20.387633 | instance | >f+++++++++ system/mount.txt 2026-04-17 06:12:20.387702 | instance | >f+++++++++ system/packages.txt 2026-04-17 06:12:20.387767 | instance | >f+++++++++ system/ps.txt 2026-04-17 06:12:20.387831 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-17 06:12:20.398234 | 2026-04-17 06:12:20.398369 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-17 06:12:20.608658 | instance | changed: "values" 2026-04-17 06:12:20.771128 | instance | changed: "releases" 2026-04-17 06:12:20.784907 | 2026-04-17 06:12:20.785143 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-17 06:12:21.021919 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-17 06:12:21.341103 | instance | ok: Runtime: 0:00:00.006350 2026-04-17 06:12:21.347913 | 2026-04-17 06:12:21.347986 | TASK [helm-release-status : Downloads logs to executor] 2026-04-17 06:12:21.838970 | instance | changed: 2026-04-17 06:12:21.839201 | instance | cd+++++++++ helm/ 2026-04-17 06:12:21.839229 | instance | cd+++++++++ helm/releases/ 2026-04-17 06:12:21.839250 | instance | cd+++++++++ helm/values/ 2026-04-17 06:12:21.848247 | 2026-04-17 06:12:21.848323 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-17 06:12:22.047103 | instance | changed 2026-04-17 06:12:22.053798 | 2026-04-17 06:12:22.053878 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-17 06:12:22.287609 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 06:12:22.287696 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 06:12:22.292401 | instance | environment: line 1: kubectl: command not found 2026-04-17 06:12:22.293667 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 06:12:22.293893 | instance | environment: line 1: kubectl: command not found 2026-04-17 06:12:22.295231 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 06:12:22.296834 | instance | environment: line 1: kubectl: command not found 2026-04-17 06:12:22.297771 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 06:12:22.299069 | instance | environment: line 1: kubectl: command not found 2026-04-17 06:12:22.299974 | instance | environment: line 1: kubectl: command not found 2026-04-17 06:12:22.300210 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 06:12:22.300958 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 06:12:22.594408 | instance | ok: Runtime: 0:00:00.021991 2026-04-17 06:12:22.600890 | 2026-04-17 06:12:22.600978 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-17 06:12:22.818385 | instance | changed 2026-04-17 06:12:22.823804 | 2026-04-17 06:12:22.823886 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-17 06:12:23.094758 | instance | environment: line 5: kubectl: command not found 2026-04-17 06:12:23.095634 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 06:12:23.095782 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 06:12:23.095800 | instance | 2026-04-17 06:12:23.395979 | instance | ok: Runtime: 0:00:00.010646 2026-04-17 06:12:23.403565 | 2026-04-17 06:12:23.403663 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-17 06:12:23.891650 | instance | changed: 2026-04-17 06:12:23.891860 | instance | cd+++++++++ objects/ 2026-04-17 06:12:23.891899 | instance | cd+++++++++ objects/cluster/ 2026-04-17 06:12:23.891929 | instance | cd+++++++++ objects/namespaced/ 2026-04-17 06:12:23.903570 | 2026-04-17 06:12:23.903648 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-17 06:12:24.110620 | instance | changed 2026-04-17 06:12:24.115879 | 2026-04-17 06:12:24.392609 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-17 06:12:24.600691 | instance | changed 2026-04-17 06:12:24.607218 | 2026-04-17 06:12:24.607306 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-17 06:12:24.843228 | instance | environment: line 3: kubectl: command not found 2026-04-17 06:12:25.143430 | instance | ok: Runtime: 0:00:00.009692 2026-04-17 06:12:25.151016 | 2026-04-17 06:12:25.151108 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-17 06:12:25.652067 | instance | changed: 2026-04-17 06:12:25.652393 | instance | cd+++++++++ pod-logs/ 2026-04-17 06:12:25.652436 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-17 06:12:25.665092 | 2026-04-17 06:12:25.665164 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-17 06:12:25.877281 | instance | changed 2026-04-17 06:12:25.884408 | 2026-04-17 06:12:25.884470 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-17 06:12:26.117112 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-17 06:12:26.117359 | instance | /bin/bash: line 2: jq: command not found 2026-04-17 06:12:26.418916 | instance | ERROR 2026-04-17 06:12:26.419150 | instance | { 2026-04-17 06:12:26.419192 | instance | "delta": "0:00:00.016126", 2026-04-17 06:12:26.419221 | instance | "end": "2026-04-17 06:12:26.118885", 2026-04-17 06:12:26.419246 | instance | "msg": "non-zero return code", 2026-04-17 06:12:26.419271 | instance | "rc": 127, 2026-04-17 06:12:26.419296 | instance | "start": "2026-04-17 06:12:26.102759" 2026-04-17 06:12:26.419320 | instance | } 2026-04-17 06:12:26.419353 | instance | ERROR: Ignoring Errors 2026-04-17 06:12:26.426029 | 2026-04-17 06:12:26.426118 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-17 06:12:26.660051 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-17 06:12:26.660207 | instance | /bin/bash: line 2: jq: command not found 2026-04-17 06:12:26.961743 | instance | ERROR 2026-04-17 06:12:26.961994 | instance | { 2026-04-17 06:12:26.962035 | instance | "delta": "0:00:00.007676", 2026-04-17 06:12:26.962064 | instance | "end": "2026-04-17 06:12:26.661538", 2026-04-17 06:12:26.962090 | instance | "msg": "non-zero return code", 2026-04-17 06:12:26.962120 | instance | "rc": 127, 2026-04-17 06:12:26.962148 | instance | "start": "2026-04-17 06:12:26.653862" 2026-04-17 06:12:26.962175 | instance | } 2026-04-17 06:12:26.962215 | instance | ERROR: Ignoring Errors 2026-04-17 06:12:26.969305 | 2026-04-17 06:12:26.969396 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-17 06:12:27.202583 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-17 06:12:27.202687 | instance | /bin/bash: line 4: jq: command not found 2026-04-17 06:12:27.508603 | instance | ERROR 2026-04-17 06:12:27.508895 | instance | { 2026-04-17 06:12:27.508991 | instance | "delta": "0:00:00.008263", 2026-04-17 06:12:27.509044 | instance | "end": "2026-04-17 06:12:27.204140", 2026-04-17 06:12:27.509085 | instance | "msg": "non-zero return code", 2026-04-17 06:12:27.509125 | instance | "rc": 127, 2026-04-17 06:12:27.509164 | instance | "start": "2026-04-17 06:12:27.195877" 2026-04-17 06:12:27.509232 | instance | } 2026-04-17 06:12:27.509286 | instance | ERROR: Ignoring Errors 2026-04-17 06:12:27.519815 | 2026-04-17 06:12:27.519880 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-17 06:12:28.026817 | instance | changed: cd+++++++++ prometheus/ 2026-04-17 06:12:28.039008 | 2026-04-17 06:12:28.039070 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-17 06:12:28.248152 | instance | changed 2026-04-17 06:12:28.253881 | 2026-04-17 06:12:28.253948 | TASK [gather-selenium-data : Get selenium data] 2026-04-17 06:12:28.480226 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-17 06:12:28.481974 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-17 06:12:28.788224 | instance | ERROR 2026-04-17 06:12:28.788446 | instance | { 2026-04-17 06:12:28.788485 | instance | "delta": "0:00:00.007242", 2026-04-17 06:12:28.788513 | instance | "end": "2026-04-17 06:12:28.482400", 2026-04-17 06:12:28.788538 | instance | "msg": "non-zero return code", 2026-04-17 06:12:28.788563 | instance | "rc": 1, 2026-04-17 06:12:28.788587 | instance | "start": "2026-04-17 06:12:28.475158" 2026-04-17 06:12:28.788624 | instance | } 2026-04-17 06:12:28.788658 | instance | ERROR: Ignoring Errors 2026-04-17 06:12:28.795479 | 2026-04-17 06:12:28.795564 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-17 06:12:29.304496 | instance | changed: cd+++++++++ selenium/ 2026-04-17 06:12:29.312370 | 2026-04-17 06:12:29.312438 | PLAY RECAP 2026-04-17 06:12:29.312497 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 4 2026-04-17 06:12:29.312528 | 2026-04-17 06:12:29.427254 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-17 06:12:29.431374 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 06:12:29.991782 | 2026-04-17 06:12:29.991912 | PLAY [all] 2026-04-17 06:12:30.003779 | 2026-04-17 06:12:30.003863 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-17 06:12:30.049163 | instance | skipping: Conditional result was False 2026-04-17 06:12:30.059754 | 2026-04-17 06:12:30.059870 | TASK [fetch-output : Set log path for single node] 2026-04-17 06:12:30.103368 | instance | ok 2026-04-17 06:12:30.110246 | 2026-04-17 06:12:30.110376 | LOOP [fetch-output : Ensure local output dirs] 2026-04-17 06:12:30.497838 | instance -> localhost | ok: "/var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/logs" 2026-04-17 06:12:30.710842 | instance -> localhost | changed: "/var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/artifacts" 2026-04-17 06:12:30.925684 | instance -> localhost | changed: "/var/lib/zuul/builds/c580490c7ef14226b83837bb230ac1a9/work/docs" 2026-04-17 06:12:30.950199 | 2026-04-17 06:12:30.950350 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-17 06:12:31.572692 | instance | changed: .d..t...... ./ 2026-04-17 06:12:31.572989 | instance | changed: All items complete 2026-04-17 06:12:31.573030 | 2026-04-17 06:12:32.028530 | instance | changed: .d..t...... ./ 2026-04-17 06:12:32.482311 | instance | changed: .d..t...... ./ 2026-04-17 06:12:32.506703 | 2026-04-17 06:12:32.507372 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-17 06:12:32.935104 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008841 2026-04-17 06:12:33.155566 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007585 2026-04-17 06:12:33.176416 | 2026-04-17 06:12:33.176580 | PLAY [all] 2026-04-17 06:12:33.184730 | 2026-04-17 06:12:33.184817 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-17 06:12:33.601922 | instance | changed 2026-04-17 06:12:33.609549 | 2026-04-17 06:12:33.609619 | PLAY RECAP 2026-04-17 06:12:33.609680 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-17 06:12:33.609746 | 2026-04-17 06:12:33.750422 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 06:12:33.754835 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-17 06:12:34.306034 | 2026-04-17 06:12:34.306155 | PLAY [localhost] 2026-04-17 06:12:34.322309 | 2026-04-17 06:12:34.322458 | TASK [Generate Zuul manifest] 2026-04-17 06:12:34.346789 | localhost | ok 2026-04-17 06:12:34.361627 | 2026-04-17 06:12:34.361738 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-17 06:12:34.685726 | localhost | changed 2026-04-17 06:12:34.698890 | 2026-04-17 06:12:34.698973 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-17 06:12:34.730185 | localhost | ok 2026-04-17 06:12:34.737831 | 2026-04-17 06:12:34.737895 | TASK [Upload logs] 2026-04-17 06:12:34.760516 | localhost | ok 2026-04-17 06:12:34.817283 | 2026-04-17 06:12:34.817423 | TASK [Set zuul-log-path fact] 2026-04-17 06:12:34.837009 | localhost | ok 2026-04-17 06:12:34.851842 | 2026-04-17 06:12:34.851911 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 06:12:34.883153 | localhost | ok 2026-04-17 06:12:34.892758 | 2026-04-17 06:12:34.892852 | TASK [upload-logs : Create log directories] 2026-04-17 06:12:35.300734 | localhost | changed 2026-04-17 06:12:35.305900 | 2026-04-17 06:12:35.305968 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-17 06:12:35.692940 | localhost -> localhost | ok: Runtime: 0:00:00.006318 2026-04-17 06:12:35.702787 | 2026-04-17 06:12:35.702859 | TASK [upload-logs : Upload logs to log server] 2026-04-17 06:12:36.153985 | localhost | Output suppressed because no_log was given 2026-04-17 06:12:36.157728 | 2026-04-17 06:12:36.157796 | LOOP [upload-logs : Compress console log and json output] 2026-04-17 06:12:36.209666 | localhost | skipping: Conditional result was False 2026-04-17 06:12:36.217703 | localhost | skipping: Conditional result was False 2026-04-17 06:12:36.232011 | 2026-04-17 06:12:36.232114 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-17 06:12:36.283144 | localhost | skipping: Conditional result was False 2026-04-17 06:12:36.283524 | 2026-04-17 06:12:36.287416 | localhost | skipping: Conditional result was False 2026-04-17 06:12:36.297834 | 2026-04-17 06:12:36.297992 | LOOP [upload-logs : Upload console log and json output]