2026-04-28 07:17:45.120597 | Job console starting 2026-04-28 07:17:45.133433 | Updating git repos 2026-04-28 07:17:45.195772 | Cloning repos into workspace 2026-04-28 07:17:45.600234 | Restoring repo states 2026-04-28 07:17:45.625876 | Merging changes 2026-04-28 07:17:46.706455 | Checking out repos 2026-04-28 07:17:47.303704 | Preparing playbooks 2026-04-28 07:17:50.235521 | Running Ansible setup 2026-04-28 07:17:53.615494 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-28 07:17:54.259171 | 2026-04-28 07:17:54.259304 | PLAY [localhost] 2026-04-28 07:17:54.268019 | 2026-04-28 07:17:54.268101 | TASK [Gathering Facts] 2026-04-28 07:17:55.128656 | localhost | ok 2026-04-28 07:17:55.141103 | 2026-04-28 07:17:55.141188 | TASK [Setup log path fact] 2026-04-28 07:17:55.160176 | localhost | ok 2026-04-28 07:17:55.176446 | 2026-04-28 07:17:55.176555 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-28 07:17:55.221474 | localhost | ok 2026-04-28 07:17:55.234023 | 2026-04-28 07:17:55.234139 | TASK [emit-job-header : Print job information] 2026-04-28 07:17:55.276302 | # Job Information 2026-04-28 07:17:55.276507 | Ansible Version: 2.16.16 2026-04-28 07:17:55.276553 | Job: atmosphere-molecule-keycloak 2026-04-28 07:17:55.276585 | Pipeline: check 2026-04-28 07:17:55.276613 | Executor: 0a8996d2b663 2026-04-28 07:17:55.276641 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3885 2026-04-28 07:17:55.276673 | Event ID: 3ea96410-42d2-11f1-859a-5c7d95783aeb 2026-04-28 07:17:55.280673 | 2026-04-28 07:17:55.280772 | LOOP [emit-job-header : Print node information] 2026-04-28 07:17:55.382317 | localhost | ok: 2026-04-28 07:17:55.383038 | localhost | # Node Information 2026-04-28 07:17:55.383104 | localhost | Inventory Hostname: instance 2026-04-28 07:17:55.383147 | localhost | Hostname: np0000171074 2026-04-28 07:17:55.383182 | localhost | Username: zuul 2026-04-28 07:17:55.383236 | localhost | Distro: Ubuntu 22.04 2026-04-28 07:17:55.383277 | localhost | Provider: yul1 2026-04-28 07:17:55.383313 | localhost | Region: ca-ymq-1 2026-04-28 07:17:55.383348 | localhost | Label: ubuntu-jammy 2026-04-28 07:17:55.383382 | localhost | Product Name: OpenStack Nova 2026-04-28 07:17:55.383415 | localhost | Interface IP: 199.19.213.141 2026-04-28 07:17:55.395338 | 2026-04-28 07:17:55.395511 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-28 07:17:55.816440 | localhost -> localhost | changed 2026-04-28 07:17:55.828949 | 2026-04-28 07:17:55.829123 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-28 07:17:56.665671 | localhost -> localhost | changed 2026-04-28 07:17:56.676221 | 2026-04-28 07:17:56.676314 | PLAY [all] 2026-04-28 07:17:56.684423 | 2026-04-28 07:17:56.684700 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-28 07:17:56.901187 | instance -> localhost | ok 2026-04-28 07:17:56.912869 | 2026-04-28 07:17:56.913052 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-28 07:17:56.946663 | instance | ok 2026-04-28 07:17:56.962344 | instance | included: /var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-28 07:17:56.968489 | 2026-04-28 07:17:56.968552 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-28 07:17:57.659265 | instance -> localhost | Generating public/private rsa key pair. 2026-04-28 07:17:57.659471 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/beb1327dd2134c388027c4555f88876c_id_rsa 2026-04-28 07:17:57.659516 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/beb1327dd2134c388027c4555f88876c_id_rsa.pub 2026-04-28 07:17:57.659551 | instance -> localhost | The key fingerprint is: 2026-04-28 07:17:57.659584 | instance -> localhost | SHA256:erI3lmoejtr4IM/+Vko7wlU4dNv71cmQWjzz301CCUQ zuul-build-sshkey 2026-04-28 07:17:57.659631 | instance -> localhost | The key's randomart image is: 2026-04-28 07:17:57.659664 | instance -> localhost | +---[RSA 3072]----+ 2026-04-28 07:17:57.659702 | instance -> localhost | | oE | 2026-04-28 07:17:57.659735 | instance -> localhost | | . . . | 2026-04-28 07:17:57.659765 | instance -> localhost | | . o o . o . | 2026-04-28 07:17:57.659795 | instance -> localhost | | o o . B o | 2026-04-28 07:17:57.659825 | instance -> localhost | | o S. o O . | 2026-04-28 07:17:57.659854 | instance -> localhost | | o ... . . * .| 2026-04-28 07:17:57.659883 | instance -> localhost | |...o ++ .o . +o| 2026-04-28 07:17:57.659912 | instance -> localhost | | +o+=o.== . +| 2026-04-28 07:17:57.659945 | instance -> localhost | | .**=+=+ . | 2026-04-28 07:17:57.659978 | instance -> localhost | +----[SHA256]-----+ 2026-04-28 07:17:57.660049 | instance -> localhost | ok: Runtime: 0:00:00.292625 2026-04-28 07:17:57.667496 | 2026-04-28 07:17:57.667617 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-28 07:17:57.698331 | instance | ok 2026-04-28 07:17:57.710030 | instance | included: /var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-28 07:17:57.721294 | 2026-04-28 07:17:57.721411 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-28 07:17:57.745990 | instance | skipping: Conditional result was False 2026-04-28 07:17:57.755644 | 2026-04-28 07:17:57.755727 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-28 07:17:58.205560 | instance | changed 2026-04-28 07:17:58.211076 | 2026-04-28 07:17:58.211148 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-28 07:17:58.395424 | instance | ok 2026-04-28 07:17:58.402230 | 2026-04-28 07:17:58.402318 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-28 07:17:58.868615 | instance | changed 2026-04-28 07:17:58.876507 | 2026-04-28 07:17:58.876613 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-28 07:17:59.342204 | instance | changed 2026-04-28 07:17:59.349695 | 2026-04-28 07:17:59.349792 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-28 07:17:59.374665 | instance | skipping: Conditional result was False 2026-04-28 07:17:59.382797 | 2026-04-28 07:17:59.382866 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-28 07:17:59.740623 | instance -> localhost | changed 2026-04-28 07:17:59.755940 | 2026-04-28 07:17:59.756017 | TASK [add-build-sshkey : Add back temp key] 2026-04-28 07:18:00.032527 | instance -> localhost | Identity added: /var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/beb1327dd2134c388027c4555f88876c_id_rsa (zuul-build-sshkey) 2026-04-28 07:18:00.032755 | instance -> localhost | ok: Runtime: 0:00:00.012494 2026-04-28 07:18:00.039938 | 2026-04-28 07:18:00.040063 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-28 07:18:00.365173 | instance | ok 2026-04-28 07:18:00.379176 | 2026-04-28 07:18:00.379418 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-28 07:18:00.406212 | instance | skipping: Conditional result was False 2026-04-28 07:18:00.421815 | 2026-04-28 07:18:00.421919 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-28 07:18:00.749092 | instance | ok 2026-04-28 07:18:00.754342 | 2026-04-28 07:18:00.754403 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-28 07:18:02.386342 | instance | Output suppressed because no_log was given 2026-04-28 07:18:02.398200 | 2026-04-28 07:18:02.398305 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-28 07:18:02.591288 | instance | ok: "logs" 2026-04-28 07:18:02.591575 | instance | ok: All items complete 2026-04-28 07:18:02.591624 | 2026-04-28 07:18:02.746324 | instance | ok: "artifacts" 2026-04-28 07:18:02.897874 | instance | ok: "docs" 2026-04-28 07:18:02.917990 | 2026-04-28 07:18:02.918492 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-28 07:18:03.115226 | instance | changed: "logs" 2026-04-28 07:18:03.273949 | instance | changed: "artifacts" 2026-04-28 07:18:03.423832 | instance | changed: "docs" 2026-04-28 07:18:03.435152 | 2026-04-28 07:18:03.435218 | PLAY RECAP 2026-04-28 07:18:03.435274 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-28 07:18:03.435312 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-28 07:18:03.435342 | 2026-04-28 07:18:03.534533 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-28 07:18:03.539667 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-28 07:18:04.084087 | 2026-04-28 07:18:04.084212 | PLAY [all] 2026-04-28 07:18:04.096610 | 2026-04-28 07:18:04.096739 | TASK [setup-uv : Extract archive] 2026-04-28 07:18:06.394989 | instance | changed 2026-04-28 07:18:06.400872 | 2026-04-28 07:18:06.400995 | TASK [setup-uv : Print version] 2026-04-28 07:18:06.270834 | instance | uv 0.8.13 2026-04-28 07:18:06.938774 | instance | ok: Runtime: 0:00:00.011785 2026-04-28 07:18:06.945573 | 2026-04-28 07:18:06.945656 | PLAY RECAP 2026-04-28 07:18:06.945712 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-28 07:18:06.945737 | 2026-04-28 07:18:07.046281 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-28 07:18:07.051760 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/zed] 2026-04-28 07:18:07.628350 | 2026-04-28 07:18:07.628463 | PLAY [all] 2026-04-28 07:18:07.639574 | 2026-04-28 07:18:07.639659 | TASK [Install "jq" for log collection] 2026-04-28 07:47:57.153018 | PRE-RUN END RESULT_TIMED_OUT: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/zed] 2026-04-28 07:47:57.156388 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/zed] 2026-04-28 07:47:57.756558 | 2026-04-28 07:47:57.756712 | PLAY [all] 2026-04-28 07:47:57.779399 | 2026-04-28 07:47:57.779596 | TASK [gather-host-logs : creating directory for system status] 2026-04-28 07:47:58.138374 | instance | changed 2026-04-28 07:47:58.143501 | 2026-04-28 07:47:58.143576 | TASK [gather-host-logs : Get logs for each host] 2026-04-28 07:47:58.473203 | instance | + systemd-cgls --full --all --no-pager 2026-04-28 07:47:58.496136 | instance | + ip addr 2026-04-28 07:47:58.498120 | instance | + ip route 2026-04-28 07:47:58.500971 | instance | + lsblk 2026-04-28 07:47:58.503452 | instance | + mount 2026-04-28 07:47:58.504915 | instance | + docker images 2026-04-28 07:47:58.505368 | instance | /bin/bash: line 7: docker: command not found 2026-04-28 07:47:58.505595 | instance | + brctl show 2026-04-28 07:47:58.506304 | instance | /bin/bash: line 8: brctl: command not found 2026-04-28 07:47:58.506643 | instance | + ps aux --sort=-%mem 2026-04-28 07:47:58.537662 | instance | + dpkg -l 2026-04-28 07:47:58.549740 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-28 07:47:58.550071 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-28 07:47:58.550121 | instance | /bin/bash: line 11: docker: command not found 2026-04-28 07:47:58.550327 | instance | + '[' '!' -z '' ']' 2026-04-28 07:47:58.691429 | instance | ok: Runtime: 0:00:00.081025 2026-04-28 07:47:58.701110 | 2026-04-28 07:47:58.701191 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-28 07:47:59.345566 | instance | changed: 2026-04-28 07:47:59.345717 | instance | created directory /var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/logs/instance 2026-04-28 07:47:59.345748 | instance | cd+++++++++ system/ 2026-04-28 07:47:59.345770 | instance | >f+++++++++ system/brctl-show.txt 2026-04-28 07:47:59.345805 | instance | >f+++++++++ system/docker-images.txt 2026-04-28 07:47:59.345827 | instance | >f+++++++++ system/ip-addr.txt 2026-04-28 07:47:59.345850 | instance | >f+++++++++ system/ip-route.txt 2026-04-28 07:47:59.345872 | instance | >f+++++++++ system/lsblk.txt 2026-04-28 07:47:59.345894 | instance | >f+++++++++ system/mount.txt 2026-04-28 07:47:59.345916 | instance | >f+++++++++ system/packages.txt 2026-04-28 07:47:59.345937 | instance | >f+++++++++ system/ps.txt 2026-04-28 07:47:59.345957 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-28 07:47:59.355469 | 2026-04-28 07:47:59.355537 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-28 07:47:59.550344 | instance | changed: "values" 2026-04-28 07:47:59.736317 | instance | changed: "releases" 2026-04-28 07:47:59.752671 | 2026-04-28 07:47:59.752780 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-28 07:47:59.943808 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-28 07:48:00.292011 | instance | ok: Runtime: 0:00:00.005011 2026-04-28 07:48:00.298416 | 2026-04-28 07:48:00.298487 | TASK [helm-release-status : Downloads logs to executor] 2026-04-28 07:48:00.776040 | instance | changed: 2026-04-28 07:48:00.776262 | instance | cd+++++++++ helm/ 2026-04-28 07:48:00.776306 | instance | cd+++++++++ helm/releases/ 2026-04-28 07:48:00.776336 | instance | cd+++++++++ helm/values/ 2026-04-28 07:48:00.787591 | 2026-04-28 07:48:00.787714 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-28 07:48:00.986586 | instance | changed 2026-04-28 07:48:00.991657 | 2026-04-28 07:48:00.991728 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-28 07:48:01.196155 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 07:48:01.196537 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 07:48:01.200598 | instance | environment: line 1: kubectl: command not found 2026-04-28 07:48:01.202034 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 07:48:01.202158 | instance | environment: line 1: kubectl: command not found 2026-04-28 07:48:01.203438 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 07:48:01.205139 | instance | environment: line 1: kubectl: command not found 2026-04-28 07:48:01.205734 | instance | environment: line 1: kubectl: command not found 2026-04-28 07:48:01.206672 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 07:48:01.206783 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 07:48:01.209446 | instance | environment: line 1: kubectl: command not found 2026-04-28 07:48:01.210969 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 07:48:01.527882 | instance | ok: Runtime: 0:00:00.023127 2026-04-28 07:48:01.536684 | 2026-04-28 07:48:01.536796 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-28 07:48:01.738766 | instance | changed 2026-04-28 07:48:01.744116 | 2026-04-28 07:48:01.744209 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-28 07:48:01.981340 | instance | environment: line 5: kubectl: command not found 2026-04-28 07:48:01.982095 | 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-28 07:48:01.982126 | instance | 2026-04-28 07:48:01.982353 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 07:48:02.320003 | instance | ok: Runtime: 0:00:00.007736 2026-04-28 07:48:02.326191 | 2026-04-28 07:48:02.326277 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-28 07:48:02.792437 | instance | changed: 2026-04-28 07:48:02.792632 | instance | cd+++++++++ objects/ 2026-04-28 07:48:02.792673 | instance | cd+++++++++ objects/cluster/ 2026-04-28 07:48:02.792708 | instance | cd+++++++++ objects/namespaced/ 2026-04-28 07:48:02.804980 | 2026-04-28 07:48:02.805099 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-28 07:48:02.997694 | instance | changed 2026-04-28 07:48:03.004388 | 2026-04-28 07:48:03.004493 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-28 07:48:03.201795 | instance | changed 2026-04-28 07:48:03.209736 | 2026-04-28 07:48:03.209830 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-28 07:48:03.410992 | instance | environment: line 3: kubectl: command not found 2026-04-28 07:48:03.746900 | instance | ok: Runtime: 0:00:00.007386 2026-04-28 07:48:03.754127 | 2026-04-28 07:48:03.754220 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-28 07:48:04.253720 | instance | changed: 2026-04-28 07:48:04.253991 | instance | cd+++++++++ pod-logs/ 2026-04-28 07:48:04.254066 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-28 07:48:04.267044 | 2026-04-28 07:48:04.267210 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-28 07:48:04.474166 | instance | changed 2026-04-28 07:48:04.481746 | 2026-04-28 07:48:04.481949 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-28 07:48:04.684586 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-28 07:48:04.684891 | instance | /bin/bash: line 2: jq: command not found 2026-04-28 07:48:05.583749 | instance | ERROR 2026-04-28 07:48:05.584054 | instance | { 2026-04-28 07:48:05.584100 | instance | "delta": "0:00:00.006855", 2026-04-28 07:48:05.584130 | instance | "end": "2026-04-28 07:48:04.686108", 2026-04-28 07:48:05.584156 | instance | "msg": "non-zero return code", 2026-04-28 07:48:05.584180 | instance | "rc": 127, 2026-04-28 07:48:05.584205 | instance | "start": "2026-04-28 07:48:04.679253" 2026-04-28 07:48:05.584229 | instance | } 2026-04-28 07:48:05.584262 | instance | ERROR: Ignoring Errors 2026-04-28 07:48:05.591015 | 2026-04-28 07:48:05.591125 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-28 07:48:05.808111 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-28 07:48:05.808191 | instance | /bin/bash: line 2: jq: command not found 2026-04-28 07:48:06.134323 | instance | ERROR 2026-04-28 07:48:06.134610 | instance | { 2026-04-28 07:48:06.134663 | instance | "delta": "0:00:00.006540", 2026-04-28 07:48:06.134695 | instance | "end": "2026-04-28 07:48:05.809114", 2026-04-28 07:48:06.134729 | instance | "msg": "non-zero return code", 2026-04-28 07:48:06.134759 | instance | "rc": 127, 2026-04-28 07:48:06.134787 | instance | "start": "2026-04-28 07:48:05.802574" 2026-04-28 07:48:06.134814 | instance | } 2026-04-28 07:48:06.134852 | instance | ERROR: Ignoring Errors 2026-04-28 07:48:06.142017 | 2026-04-28 07:48:06.142093 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-28 07:48:06.339440 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-28 07:48:06.339542 | instance | /bin/bash: line 4: jq: command not found 2026-04-28 07:48:06.679298 | instance | ERROR 2026-04-28 07:48:06.679632 | instance | { 2026-04-28 07:48:06.679696 | instance | "delta": "0:00:00.005881", 2026-04-28 07:48:06.679740 | instance | "end": "2026-04-28 07:48:06.340595", 2026-04-28 07:48:06.679782 | instance | "msg": "non-zero return code", 2026-04-28 07:48:06.679821 | instance | "rc": 127, 2026-04-28 07:48:06.679883 | instance | "start": "2026-04-28 07:48:06.334714" 2026-04-28 07:48:06.679923 | instance | } 2026-04-28 07:48:06.679976 | instance | ERROR: Ignoring Errors 2026-04-28 07:48:06.685904 | 2026-04-28 07:48:06.685981 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-28 07:48:07.191180 | instance | changed: cd+++++++++ prometheus/ 2026-04-28 07:48:07.201614 | 2026-04-28 07:48:07.201763 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-28 07:48:07.411198 | instance | changed 2026-04-28 07:48:07.416263 | 2026-04-28 07:48:07.416334 | TASK [gather-selenium-data : Get selenium data] 2026-04-28 07:48:07.617699 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-28 07:48:07.619335 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-28 07:48:07.953474 | instance | ERROR 2026-04-28 07:48:07.953768 | instance | { 2026-04-28 07:48:07.953813 | instance | "delta": "0:00:00.007235", 2026-04-28 07:48:07.953859 | instance | "end": "2026-04-28 07:48:07.619718", 2026-04-28 07:48:07.953910 | instance | "msg": "non-zero return code", 2026-04-28 07:48:07.953938 | instance | "rc": 1, 2026-04-28 07:48:07.953964 | instance | "start": "2026-04-28 07:48:07.612483" 2026-04-28 07:48:07.953988 | instance | } 2026-04-28 07:48:07.954022 | instance | ERROR: Ignoring Errors 2026-04-28 07:48:07.961299 | 2026-04-28 07:48:07.961397 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-28 07:48:08.453024 | instance | changed: cd+++++++++ selenium/ 2026-04-28 07:48:08.462381 | 2026-04-28 07:48:08.462482 | PLAY RECAP 2026-04-28 07:48:08.462537 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 4 2026-04-28 07:48:08.462562 | 2026-04-28 07:48:08.656558 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/zed] 2026-04-28 07:48:08.661615 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-28 07:48:09.309358 | 2026-04-28 07:48:09.309543 | PLAY [all] 2026-04-28 07:48:09.323336 | 2026-04-28 07:48:09.323507 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-28 07:48:09.389318 | instance | skipping: Conditional result was False 2026-04-28 07:48:09.400254 | 2026-04-28 07:48:09.400403 | TASK [fetch-output : Set log path for single node] 2026-04-28 07:48:09.445651 | instance | ok 2026-04-28 07:48:09.451004 | 2026-04-28 07:48:09.451128 | LOOP [fetch-output : Ensure local output dirs] 2026-04-28 07:48:11.751211 | instance -> localhost | ok: "/var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/logs" 2026-04-28 07:48:11.951513 | instance -> localhost | changed: "/var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/artifacts" 2026-04-28 07:48:12.156528 | instance -> localhost | changed: "/var/lib/zuul/builds/beb1327dd2134c388027c4555f88876c/work/docs" 2026-04-28 07:48:12.172720 | 2026-04-28 07:48:12.172835 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-28 07:48:12.835427 | instance | changed: .d..t...... ./ 2026-04-28 07:48:12.835764 | instance | changed: All items complete 2026-04-28 07:48:12.835808 | 2026-04-28 07:48:13.292661 | instance | changed: .d..t...... ./ 2026-04-28 07:48:13.753619 | instance | changed: .d..t...... ./ 2026-04-28 07:48:13.770773 | 2026-04-28 07:48:13.770931 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-28 07:48:15.676141 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007097 2026-04-28 07:48:15.902661 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007609 2026-04-28 07:48:15.922241 | 2026-04-28 07:48:15.922332 | PLAY [all] 2026-04-28 07:48:15.930008 | 2026-04-28 07:48:15.930072 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-28 07:48:16.377772 | instance | changed 2026-04-28 07:48:16.387580 | 2026-04-28 07:48:16.387737 | PLAY RECAP 2026-04-28 07:48:16.387810 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-28 07:48:16.387870 | 2026-04-28 07:48:16.591456 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-28 07:48:16.596543 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-28 07:48:17.268334 | 2026-04-28 07:48:17.268529 | PLAY [localhost] 2026-04-28 07:48:17.280650 | 2026-04-28 07:48:17.280769 | TASK [Generate Zuul manifest] 2026-04-28 07:48:17.304709 | localhost | ok 2026-04-28 07:48:17.322238 | 2026-04-28 07:48:17.322366 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-28 07:48:17.709134 | localhost | changed 2026-04-28 07:48:17.726072 | 2026-04-28 07:48:17.726335 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-28 07:48:18.297563 | localhost | ok 2026-04-28 07:48:18.306318 | 2026-04-28 07:48:18.306381 | TASK [Upload logs] 2026-04-28 07:48:18.327237 | localhost | ok 2026-04-28 07:48:18.383734 | 2026-04-28 07:48:18.383834 | TASK [Set zuul-log-path fact] 2026-04-28 07:48:18.405370 | localhost | ok 2026-04-28 07:48:18.418046 | 2026-04-28 07:48:18.418114 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-28 07:48:18.449713 | localhost | ok 2026-04-28 07:48:18.459631 | 2026-04-28 07:48:18.459724 | TASK [upload-logs : Create log directories] 2026-04-28 07:48:18.858300 | localhost | changed 2026-04-28 07:48:18.863073 | 2026-04-28 07:48:18.863142 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-28 07:48:19.296343 | localhost -> localhost | ok: Runtime: 0:00:00.006437 2026-04-28 07:48:19.301157 | 2026-04-28 07:48:19.301224 | TASK [upload-logs : Upload logs to log server] 2026-04-28 07:48:19.755140 | localhost | Output suppressed because no_log was given 2026-04-28 07:48:19.759421 | 2026-04-28 07:48:19.759492 | LOOP [upload-logs : Compress console log and json output] 2026-04-28 07:48:19.807045 | localhost | skipping: Conditional result was False 2026-04-28 07:48:19.814026 | localhost | skipping: Conditional result was False 2026-04-28 07:48:19.823748 | 2026-04-28 07:48:19.823897 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-28 07:48:19.873922 | localhost | skipping: Conditional result was False 2026-04-28 07:48:19.874484 | 2026-04-28 07:48:19.878075 | localhost | skipping: Conditional result was False 2026-04-28 07:48:19.886767 | 2026-04-28 07:48:19.886914 | LOOP [upload-logs : Upload console log and json output]