2026-03-26 17:46:16.331667 | Job console starting 2026-03-26 17:46:16.378881 | Updating git repos 2026-03-26 17:46:16.442611 | Cloning repos into workspace 2026-03-26 17:46:16.539930 | Restoring repo states 2026-03-26 17:46:16.559584 | Merging changes 2026-03-26 17:46:17.602349 | Checking out repos 2026-03-26 17:46:17.965220 | Preparing playbooks 2026-03-26 17:46:21.245854 | Running Ansible setup 2026-03-26 17:46:24.918363 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 17:46:25.489732 | 2026-03-26 17:46:25.489853 | PLAY [localhost] 2026-03-26 17:46:25.498046 | 2026-03-26 17:46:25.498116 | TASK [Gathering Facts] 2026-03-26 17:46:26.401797 | localhost | ok 2026-03-26 17:46:26.413311 | 2026-03-26 17:46:26.413411 | TASK [Setup log path fact] 2026-03-26 17:46:26.443390 | localhost | ok 2026-03-26 17:46:26.455873 | 2026-03-26 17:46:26.463159 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 17:46:26.493198 | localhost | ok 2026-03-26 17:46:26.500523 | 2026-03-26 17:46:26.500590 | TASK [emit-job-header : Print job information] 2026-03-26 17:46:26.552565 | # Job Information 2026-03-26 17:46:26.552680 | Ansible Version: 2.16.16 2026-03-26 17:46:26.552711 | Job: atmosphere-molecule-csi-rbd 2026-03-26 17:46:26.552733 | Pipeline: check 2026-03-26 17:46:26.552752 | Executor: 0a8996d2b663 2026-03-26 17:46:26.552771 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3739 2026-03-26 17:46:26.552793 | Event ID: 9065dc80-293b-11f1-96c3-07e9cd5ab091 2026-03-26 17:46:26.555478 | 2026-03-26 17:46:26.555552 | LOOP [emit-job-header : Print node information] 2026-03-26 17:46:26.658147 | localhost | ok: 2026-03-26 17:46:26.658866 | localhost | # Node Information 2026-03-26 17:46:26.658931 | localhost | Inventory Hostname: instance 2026-03-26 17:46:26.658978 | localhost | Hostname: np0000161100 2026-03-26 17:46:26.659020 | localhost | Username: zuul 2026-03-26 17:46:26.659068 | localhost | Distro: Ubuntu 22.04 2026-03-26 17:46:26.659109 | localhost | Provider: yul1 2026-03-26 17:46:26.659150 | localhost | Region: ca-ymq-1 2026-03-26 17:46:26.659191 | localhost | Label: ubuntu-jammy 2026-03-26 17:46:26.659230 | localhost | Product Name: OpenStack Nova 2026-03-26 17:46:26.659270 | localhost | Interface IP: 199.19.213.117 2026-03-26 17:46:26.671015 | 2026-03-26 17:46:26.671090 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-26 17:46:27.088510 | localhost -> localhost | changed 2026-03-26 17:46:27.098358 | 2026-03-26 17:46:27.098428 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-26 17:46:27.986541 | localhost -> localhost | changed 2026-03-26 17:46:27.994600 | 2026-03-26 17:46:27.994679 | PLAY [all] 2026-03-26 17:46:28.004851 | 2026-03-26 17:46:28.004934 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-26 17:46:28.261018 | instance -> localhost | ok 2026-03-26 17:46:28.270376 | 2026-03-26 17:46:28.274293 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-26 17:46:28.305328 | instance | ok 2026-03-26 17:46:28.319870 | instance | included: /var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-26 17:46:28.325206 | 2026-03-26 17:46:28.325264 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-26 17:46:29.564121 | instance -> localhost | Generating public/private rsa key pair. 2026-03-26 17:46:29.564292 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/b5b2699032954aa495a18061d3605883_id_rsa 2026-03-26 17:46:29.564323 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/b5b2699032954aa495a18061d3605883_id_rsa.pub 2026-03-26 17:46:29.564348 | instance -> localhost | The key fingerprint is: 2026-03-26 17:46:29.564371 | instance -> localhost | SHA256:NVIN6Y+x6LLPm1llhO44QLqhGjAwb6Xhn+DUWZ6htHw zuul-build-sshkey 2026-03-26 17:46:29.564411 | instance -> localhost | The key's randomart image is: 2026-03-26 17:46:29.564763 | instance -> localhost | +---[RSA 3072]----+ 2026-03-26 17:46:29.564808 | instance -> localhost | | o+ | 2026-03-26 17:46:29.564834 | instance -> localhost | | .... | 2026-03-26 17:46:29.564855 | instance -> localhost | |o . o + ..+ . | 2026-03-26 17:46:29.564877 | instance -> localhost | |.+ B O o +oo | 2026-03-26 17:46:29.564898 | instance -> localhost | |o B O E S..=o | 2026-03-26 17:46:29.564918 | instance -> localhost | |.= + = ..ooo. | 2026-03-26 17:46:29.564939 | instance -> localhost | |. o + .o o | 2026-03-26 17:46:29.564978 | instance -> localhost | | o ...= | 2026-03-26 17:46:29.565004 | instance -> localhost | |. .+*. | 2026-03-26 17:46:29.565025 | instance -> localhost | +----[SHA256]-----+ 2026-03-26 17:46:29.565077 | instance -> localhost | ok: Runtime: 0:00:00.801795 2026-03-26 17:46:29.570282 | 2026-03-26 17:46:29.570348 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-26 17:46:29.600010 | instance | ok 2026-03-26 17:46:29.612092 | instance | included: /var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-26 17:46:29.623540 | 2026-03-26 17:46:29.623640 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-26 17:46:29.648738 | instance | skipping: Conditional result was False 2026-03-26 17:46:29.655763 | 2026-03-26 17:46:29.655852 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-26 17:46:30.087140 | instance | changed 2026-03-26 17:46:30.094191 | 2026-03-26 17:46:30.094257 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-26 17:46:30.293923 | instance | ok 2026-03-26 17:46:30.300108 | 2026-03-26 17:46:30.300180 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-26 17:46:30.770755 | instance | changed 2026-03-26 17:46:30.776482 | 2026-03-26 17:46:30.776590 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-26 17:46:31.260506 | instance | changed 2026-03-26 17:46:31.266481 | 2026-03-26 17:46:31.266558 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-26 17:46:31.290163 | instance | skipping: Conditional result was False 2026-03-26 17:46:31.302729 | 2026-03-26 17:46:31.302906 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-26 17:46:31.692080 | instance -> localhost | changed 2026-03-26 17:46:31.707373 | 2026-03-26 17:46:31.707493 | TASK [add-build-sshkey : Add back temp key] 2026-03-26 17:46:31.995867 | instance -> localhost | Identity added: /var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/b5b2699032954aa495a18061d3605883_id_rsa (zuul-build-sshkey) 2026-03-26 17:46:31.996103 | instance -> localhost | ok: Runtime: 0:00:00.014230 2026-03-26 17:46:32.004291 | 2026-03-26 17:46:32.004355 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-26 17:46:32.351133 | instance | ok 2026-03-26 17:46:32.357405 | 2026-03-26 17:46:32.357674 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-26 17:46:32.382071 | instance | skipping: Conditional result was False 2026-03-26 17:46:32.399540 | 2026-03-26 17:46:32.399688 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-26 17:46:32.737487 | instance | ok 2026-03-26 17:46:32.746327 | 2026-03-26 17:46:32.746391 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-26 17:46:34.374314 | instance | Output suppressed because no_log was given 2026-03-26 17:46:34.384080 | 2026-03-26 17:46:34.384161 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-26 17:46:34.567262 | instance | ok: "logs" 2026-03-26 17:46:34.567513 | instance | ok: All items complete 2026-03-26 17:46:34.567542 | 2026-03-26 17:46:34.724421 | instance | ok: "artifacts" 2026-03-26 17:46:34.889949 | instance | ok: "docs" 2026-03-26 17:46:34.906014 | 2026-03-26 17:46:34.906162 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-26 17:46:35.082437 | instance | changed: "logs" 2026-03-26 17:46:35.242826 | instance | changed: "artifacts" 2026-03-26 17:46:35.389767 | instance | changed: "docs" 2026-03-26 17:46:35.403927 | 2026-03-26 17:46:35.404063 | PLAY RECAP 2026-03-26 17:46:35.404124 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-26 17:46:35.404164 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 17:46:35.404195 | 2026-03-26 17:46:35.542113 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 17:46:35.546247 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 17:46:36.190827 | 2026-03-26 17:46:36.190976 | PLAY [all] 2026-03-26 17:46:36.202758 | 2026-03-26 17:46:36.202838 | TASK [setup-uv : Extract archive] 2026-03-26 17:46:38.374635 | instance | changed 2026-03-26 17:46:38.383544 | 2026-03-26 17:46:38.383638 | TASK [setup-uv : Print version] 2026-03-26 17:46:37.558464 | instance | uv 0.8.13 2026-03-26 17:46:38.918053 | instance | ok: Runtime: 0:00:00.010706 2026-03-26 17:46:38.925515 | 2026-03-26 17:46:38.925566 | PLAY RECAP 2026-03-26 17:46:38.925615 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 17:46:38.925640 | 2026-03-26 17:46:39.040229 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 17:46:39.044576 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/2025.2] 2026-03-26 17:46:39.591504 | 2026-03-26 17:46:39.591641 | PLAY [all] 2026-03-26 17:46:39.602817 | 2026-03-26 17:46:39.602898 | TASK [Install "jq" for log collection] 2026-03-26 18:16:29.106181 | PRE-RUN END RESULT_TIMED_OUT: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/2025.2] 2026-03-26 18:16:29.108834 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/2025.2] 2026-03-26 18:16:29.723659 | 2026-03-26 18:16:29.723803 | PLAY [all] 2026-03-26 18:16:29.739713 | 2026-03-26 18:16:29.739818 | TASK [gather-host-logs : creating directory for system status] 2026-03-26 18:16:30.097725 | instance | changed 2026-03-26 18:16:30.383684 | 2026-03-26 18:16:30.383875 | TASK [gather-host-logs : Get logs for each host] 2026-03-26 18:16:30.785612 | instance | + systemd-cgls --full --all --no-pager 2026-03-26 18:16:30.797964 | instance | + ip addr 2026-03-26 18:16:30.801141 | instance | + ip route 2026-03-26 18:16:30.803488 | instance | + lsblk 2026-03-26 18:16:30.806857 | instance | + mount 2026-03-26 18:16:30.808320 | instance | + docker images 2026-03-26 18:16:30.808872 | instance | /bin/bash: line 7: docker: command not found 2026-03-26 18:16:30.808962 | instance | + brctl show 2026-03-26 18:16:30.809374 | instance | /bin/bash: line 8: brctl: command not found 2026-03-26 18:16:30.809587 | instance | + ps aux --sort=-%mem 2026-03-26 18:16:30.822740 | instance | + dpkg -l 2026-03-26 18:16:30.831918 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-03-26 18:16:30.832340 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-03-26 18:16:30.832385 | instance | /bin/bash: line 11: docker: command not found 2026-03-26 18:16:30.832732 | instance | + '[' '!' -z '' ']' 2026-03-26 18:16:30.937152 | instance | ok: Runtime: 0:00:00.052366 2026-03-26 18:16:30.943866 | 2026-03-26 18:16:30.943937 | TASK [gather-host-logs : Downloads logs to executor] 2026-03-26 18:16:31.617022 | instance | changed: 2026-03-26 18:16:31.645184 | instance | created directory /var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/logs/instance 2026-03-26 18:16:31.645411 | instance | cd+++++++++ system/ 2026-03-26 18:16:31.645478 | instance | >f+++++++++ system/brctl-show.txt 2026-03-26 18:16:31.645572 | instance | >f+++++++++ system/docker-images.txt 2026-03-26 18:16:31.645628 | instance | >f+++++++++ system/ip-addr.txt 2026-03-26 18:16:31.645688 | instance | >f+++++++++ system/ip-route.txt 2026-03-26 18:16:31.645743 | instance | >f+++++++++ system/lsblk.txt 2026-03-26 18:16:31.645798 | instance | >f+++++++++ system/mount.txt 2026-03-26 18:16:31.645857 | instance | >f+++++++++ system/packages.txt 2026-03-26 18:16:31.645925 | instance | >f+++++++++ system/ps.txt 2026-03-26 18:16:31.646006 | instance | >f+++++++++ system/systemd-cgls.txt 2026-03-26 18:16:31.661942 | 2026-03-26 18:16:31.662039 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-26 18:16:31.876441 | instance | changed: "values" 2026-03-26 18:16:32.056115 | instance | changed: "releases" 2026-03-26 18:16:32.073850 | 2026-03-26 18:16:32.074045 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-26 18:16:32.301875 | instance | /bin/bash: line 3: kubectl: command not found 2026-03-26 18:16:32.624371 | instance | ok: Runtime: 0:00:00.006868 2026-03-26 18:16:32.629358 | 2026-03-26 18:16:32.629427 | TASK [helm-release-status : Downloads logs to executor] 2026-03-26 18:16:33.172858 | instance | changed: 2026-03-26 18:16:33.187332 | instance | cd+++++++++ helm/ 2026-03-26 18:16:33.187985 | instance | cd+++++++++ helm/releases/ 2026-03-26 18:16:33.188087 | instance | cd+++++++++ helm/values/ 2026-03-26 18:16:33.205511 | 2026-03-26 18:16:33.205653 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-26 18:16:33.423350 | instance | changed 2026-03-26 18:16:33.430183 | 2026-03-26 18:16:33.430353 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-26 18:16:33.634685 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 18:16:33.634787 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 18:16:33.638014 | instance | environment: line 1: kubectl: command not found 2026-03-26 18:16:33.639577 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 18:16:33.641646 | instance | environment: line 1: kubectl: command not found 2026-03-26 18:16:33.642650 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 18:16:33.644403 | instance | environment: line 1: kubectl: command not found 2026-03-26 18:16:33.645245 | instance | environment: line 1: kubectl: command not found 2026-03-26 18:16:33.645468 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 18:16:33.646631 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 18:16:33.647527 | instance | environment: line 1: kubectl: command not found 2026-03-26 18:16:33.648265 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 18:16:34.148490 | instance | ok: Runtime: 0:00:00.020994 2026-03-26 18:16:34.153631 | 2026-03-26 18:16:34.153718 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-26 18:16:34.358761 | instance | changed 2026-03-26 18:16:34.365427 | 2026-03-26 18:16:34.365518 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-26 18:16:34.615004 | instance | environment: line 5: kubectl: command not found 2026-03-26 18:16:34.615943 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 18:16:34.616033 | 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-03-26 18:16:34.616046 | instance | 2026-03-26 18:16:34.941021 | instance | ok: Runtime: 0:00:00.006475 2026-03-26 18:16:34.949059 | 2026-03-26 18:16:34.949160 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-26 18:16:35.456466 | instance | changed: 2026-03-26 18:16:35.456681 | instance | cd+++++++++ objects/ 2026-03-26 18:16:35.456727 | instance | cd+++++++++ objects/cluster/ 2026-03-26 18:16:35.456758 | instance | cd+++++++++ objects/namespaced/ 2026-03-26 18:16:35.466844 | 2026-03-26 18:16:35.466914 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-26 18:16:35.662527 | instance | changed 2026-03-26 18:16:35.669828 | 2026-03-26 18:16:35.669919 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-26 18:16:35.894853 | instance | changed 2026-03-26 18:16:35.900280 | 2026-03-26 18:16:35.900375 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-26 18:16:36.099363 | instance | environment: line 3: kubectl: command not found 2026-03-26 18:16:36.432445 | instance | ok: Runtime: 0:00:00.006696 2026-03-26 18:16:36.438438 | 2026-03-26 18:16:36.438501 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-26 18:16:36.937415 | instance | changed: 2026-03-26 18:16:36.937642 | instance | cd+++++++++ pod-logs/ 2026-03-26 18:16:36.937683 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-03-26 18:16:36.949646 | 2026-03-26 18:16:36.949744 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-03-26 18:16:37.163784 | instance | changed 2026-03-26 18:16:37.220687 | 2026-03-26 18:16:37.220793 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-03-26 18:16:37.428620 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-26 18:16:37.428713 | instance | /bin/bash: line 2: jq: command not found 2026-03-26 18:16:37.760927 | instance | ERROR 2026-03-26 18:16:37.761249 | instance | { 2026-03-26 18:16:37.761296 | instance | "delta": "0:00:00.005434", 2026-03-26 18:16:37.761326 | instance | "end": "2026-03-26 18:16:37.429972", 2026-03-26 18:16:37.761353 | instance | "msg": "non-zero return code", 2026-03-26 18:16:37.761379 | instance | "rc": 127, 2026-03-26 18:16:37.761405 | instance | "start": "2026-03-26 18:16:37.424538" 2026-03-26 18:16:37.761432 | instance | } 2026-03-26 18:16:37.761466 | instance | ERROR: Ignoring Errors 2026-03-26 18:16:37.768891 | 2026-03-26 18:16:37.768987 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-03-26 18:16:37.975257 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-26 18:16:37.975428 | instance | /bin/bash: line 2: jq: command not found 2026-03-26 18:16:38.307909 | instance | ERROR 2026-03-26 18:16:38.308298 | instance | { 2026-03-26 18:16:38.308369 | instance | "delta": "0:00:00.006303", 2026-03-26 18:16:38.308415 | instance | "end": "2026-03-26 18:16:37.976437", 2026-03-26 18:16:38.308456 | instance | "msg": "non-zero return code", 2026-03-26 18:16:38.308496 | instance | "rc": 127, 2026-03-26 18:16:38.308538 | instance | "start": "2026-03-26 18:16:37.970134" 2026-03-26 18:16:38.308578 | instance | } 2026-03-26 18:16:38.308636 | instance | ERROR: Ignoring Errors 2026-03-26 18:16:38.316678 | 2026-03-26 18:16:38.317228 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-03-26 18:16:38.591344 | instance | /bin/bash: line 4: kubectl: command not found 2026-03-26 18:16:38.591448 | instance | /bin/bash: line 4: jq: command not found 2026-03-26 18:16:38.862181 | instance | ERROR 2026-03-26 18:16:38.862437 | instance | { 2026-03-26 18:16:38.862477 | instance | "delta": "0:00:00.007615", 2026-03-26 18:16:38.862506 | instance | "end": "2026-03-26 18:16:38.592639", 2026-03-26 18:16:38.862532 | instance | "msg": "non-zero return code", 2026-03-26 18:16:38.862556 | instance | "rc": 127, 2026-03-26 18:16:38.862596 | instance | "start": "2026-03-26 18:16:38.585024" 2026-03-26 18:16:38.862621 | instance | } 2026-03-26 18:16:38.862654 | instance | ERROR: Ignoring Errors 2026-03-26 18:16:38.869704 | 2026-03-26 18:16:38.869781 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-03-26 18:16:39.364385 | instance | changed: cd+++++++++ prometheus/ 2026-03-26 18:16:39.410115 | 2026-03-26 18:16:39.410276 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-03-26 18:16:39.606358 | instance | changed 2026-03-26 18:16:39.612581 | 2026-03-26 18:16:39.612708 | TASK [gather-selenium-data : Get selenium data] 2026-03-26 18:16:39.825575 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-03-26 18:16:39.826616 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-03-26 18:16:40.146478 | instance | ERROR 2026-03-26 18:16:40.146706 | instance | { 2026-03-26 18:16:40.146736 | instance | "delta": "0:00:00.004969", 2026-03-26 18:16:40.146756 | instance | "end": "2026-03-26 18:16:39.827004", 2026-03-26 18:16:40.146776 | instance | "msg": "non-zero return code", 2026-03-26 18:16:40.146794 | instance | "rc": 1, 2026-03-26 18:16:40.146812 | instance | "start": "2026-03-26 18:16:39.822035" 2026-03-26 18:16:40.146829 | instance | } 2026-03-26 18:16:40.146851 | instance | ERROR: Ignoring Errors 2026-03-26 18:16:40.151946 | 2026-03-26 18:16:40.152032 | TASK [gather-selenium-data : Downloads logs to executor] 2026-03-26 18:16:40.690345 | instance | changed: cd+++++++++ selenium/ 2026-03-26 18:16:40.698141 | 2026-03-26 18:16:40.698194 | PLAY RECAP 2026-03-26 18:16:40.698245 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 4 2026-03-26 18:16:40.698266 | 2026-03-26 18:16:40.847698 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/2025.2] 2026-03-26 18:16:40.851868 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 18:16:41.455581 | 2026-03-26 18:16:41.455718 | PLAY [all] 2026-03-26 18:16:41.467843 | 2026-03-26 18:16:41.467932 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-26 18:16:41.512212 | instance | skipping: Conditional result was False 2026-03-26 18:16:41.522798 | 2026-03-26 18:16:41.522929 | TASK [fetch-output : Set log path for single node] 2026-03-26 18:16:41.566950 | instance | ok 2026-03-26 18:16:41.573433 | 2026-03-26 18:16:41.573526 | LOOP [fetch-output : Ensure local output dirs] 2026-03-26 18:16:42.240647 | instance -> localhost | ok: "/var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/logs" 2026-03-26 18:16:42.454036 | instance -> localhost | changed: "/var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/artifacts" 2026-03-26 18:16:42.678364 | instance -> localhost | changed: "/var/lib/zuul/builds/b5b2699032954aa495a18061d3605883/work/docs" 2026-03-26 18:16:42.695932 | 2026-03-26 18:16:42.696109 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-26 18:16:43.360628 | instance | changed: .d..t...... ./ 2026-03-26 18:16:43.469018 | instance | changed: All items complete 2026-03-26 18:16:43.469273 | 2026-03-26 18:16:43.867633 | instance | changed: .d..t...... ./ 2026-03-26 18:16:44.335090 | instance | changed: .d..t...... ./ 2026-03-26 18:16:44.364771 | 2026-03-26 18:16:44.364947 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-26 18:16:45.560676 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007857 2026-03-26 18:16:45.959801 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.166862 2026-03-26 18:16:45.979724 | 2026-03-26 18:16:45.980041 | PLAY [all] 2026-03-26 18:16:45.989331 | 2026-03-26 18:16:45.989524 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-26 18:16:46.412041 | instance | changed 2026-03-26 18:16:46.418142 | 2026-03-26 18:16:46.418203 | PLAY RECAP 2026-03-26 18:16:46.418251 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-26 18:16:46.418295 | 2026-03-26 18:16:46.608386 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 18:16:46.611238 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-26 18:16:47.269911 | 2026-03-26 18:16:47.270135 | PLAY [localhost] 2026-03-26 18:16:47.282170 | 2026-03-26 18:16:47.282356 | TASK [Generate Zuul manifest] 2026-03-26 18:16:47.305428 | localhost | ok 2026-03-26 18:16:47.323724 | 2026-03-26 18:16:47.323908 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-26 18:16:47.751866 | localhost | changed 2026-03-26 18:16:47.764544 | 2026-03-26 18:16:47.764672 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-26 18:16:47.946366 | localhost | ok 2026-03-26 18:16:47.958093 | 2026-03-26 18:16:47.958253 | TASK [Upload logs] 2026-03-26 18:16:47.978811 | localhost | ok 2026-03-26 18:16:48.043111 | 2026-03-26 18:16:48.043261 | TASK [Set zuul-log-path fact] 2026-03-26 18:16:48.063373 | localhost | ok 2026-03-26 18:16:48.077480 | 2026-03-26 18:16:48.077624 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 18:16:48.109193 | localhost | ok 2026-03-26 18:16:48.118889 | 2026-03-26 18:16:48.118994 | TASK [upload-logs : Create log directories] 2026-03-26 18:16:48.730802 | localhost | changed 2026-03-26 18:16:48.737873 | 2026-03-26 18:16:48.738068 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-26 18:16:49.199646 | localhost -> localhost | ok: Runtime: 0:00:00.059529 2026-03-26 18:16:49.206723 | 2026-03-26 18:16:49.206827 | TASK [upload-logs : Upload logs to log server] 2026-03-26 18:16:50.187776 | localhost | Output suppressed because no_log was given 2026-03-26 18:16:50.193079 | 2026-03-26 18:16:50.193182 | LOOP [upload-logs : Compress console log and json output] 2026-03-26 18:16:50.232079 | localhost | skipping: Conditional result was False 2026-03-26 18:16:50.239320 | localhost | skipping: Conditional result was False 2026-03-26 18:16:50.255294 | 2026-03-26 18:16:50.255481 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-26 18:16:50.296102 | localhost | skipping: Conditional result was False 2026-03-26 18:16:50.296445 | 2026-03-26 18:16:50.300368 | localhost | skipping: Conditional result was False 2026-03-26 18:16:50.315809 | 2026-03-26 18:16:50.315987 | LOOP [upload-logs : Upload console log and json output]