2026-03-26 08:40:11.803188 | Job console starting 2026-03-26 08:40:11.833685 | Updating git repos 2026-03-26 08:40:11.890323 | Cloning repos into workspace 2026-03-26 08:40:11.994470 | Restoring repo states 2026-03-26 08:40:12.032630 | Merging changes 2026-03-26 08:40:13.587023 | Checking out repos 2026-03-26 08:40:13.805558 | Preparing playbooks 2026-03-26 08:40:18.161558 | Running Ansible setup 2026-03-26 08:40:21.530390 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 08:40:22.119569 | 2026-03-26 08:40:22.119696 | PLAY [localhost] 2026-03-26 08:40:22.127014 | 2026-03-26 08:40:22.127084 | TASK [Gathering Facts] 2026-03-26 08:40:23.007642 | localhost | ok 2026-03-26 08:40:23.020880 | 2026-03-26 08:40:23.021148 | TASK [Setup log path fact] 2026-03-26 08:40:23.044406 | localhost | ok 2026-03-26 08:40:23.057962 | 2026-03-26 08:40:23.058042 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 08:40:23.090161 | localhost | ok 2026-03-26 08:40:23.098687 | 2026-03-26 08:40:23.098784 | TASK [emit-job-header : Print job information] 2026-03-26 08:40:23.140334 | # Job Information 2026-03-26 08:40:23.140560 | Ansible Version: 2.16.16 2026-03-26 08:40:23.140606 | Job: atmosphere-molecule-aio-openvswitch 2026-03-26 08:40:23.140636 | Pipeline: check 2026-03-26 08:40:23.140664 | Executor: 0a8996d2b663 2026-03-26 08:40:23.140692 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3772 2026-03-26 08:40:23.140724 | Event ID: 3f310cf0-28ef-11f1-84ff-e0e0c6971770 2026-03-26 08:40:23.144704 | 2026-03-26 08:40:23.144802 | LOOP [emit-job-header : Print node information] 2026-03-26 08:40:23.245586 | localhost | ok: 2026-03-26 08:40:23.245815 | localhost | # Node Information 2026-03-26 08:40:23.245857 | localhost | Inventory Hostname: instance 2026-03-26 08:40:23.245919 | localhost | Hostname: np0000161036 2026-03-26 08:40:23.245949 | localhost | Username: zuul 2026-03-26 08:40:23.245981 | localhost | Distro: Ubuntu 22.04 2026-03-26 08:40:23.246009 | localhost | Provider: yul1 2026-03-26 08:40:23.246036 | localhost | Region: ca-ymq-1 2026-03-26 08:40:23.246062 | localhost | Label: ubuntu-jammy-16 2026-03-26 08:40:23.246088 | localhost | Product Name: OpenStack Nova 2026-03-26 08:40:23.246114 | localhost | Interface IP: 199.204.45.227 2026-03-26 08:40:23.265917 | 2026-03-26 08:40:23.267223 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-26 08:40:23.697886 | localhost -> localhost | changed 2026-03-26 08:40:23.703603 | 2026-03-26 08:40:23.703681 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-26 08:40:24.559791 | localhost -> localhost | changed 2026-03-26 08:40:24.565659 | 2026-03-26 08:40:24.565751 | PLAY [all] 2026-03-26 08:40:24.574024 | 2026-03-26 08:40:24.574157 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-26 08:40:24.832463 | instance -> localhost | ok 2026-03-26 08:40:24.844492 | 2026-03-26 08:40:24.844628 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-26 08:40:24.878703 | instance | ok 2026-03-26 08:40:24.894341 | instance | included: /var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-26 08:40:24.899841 | 2026-03-26 08:40:24.899903 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-26 08:40:26.077337 | instance -> localhost | Generating public/private rsa key pair. 2026-03-26 08:40:26.077557 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/2b6a6350517a468989620cfcc26d16af_id_rsa 2026-03-26 08:40:26.077600 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/2b6a6350517a468989620cfcc26d16af_id_rsa.pub 2026-03-26 08:40:26.077632 | instance -> localhost | The key fingerprint is: 2026-03-26 08:40:26.077662 | instance -> localhost | SHA256:rm/EJqa5POskwDfvDgtHLqCy4OtfFfzPpIRS4IO/e7o zuul-build-sshkey 2026-03-26 08:40:26.077707 | instance -> localhost | The key's randomart image is: 2026-03-26 08:40:26.077738 | instance -> localhost | +---[RSA 3072]----+ 2026-03-26 08:40:26.077775 | instance -> localhost | | . | 2026-03-26 08:40:26.077822 | instance -> localhost | | o o | 2026-03-26 08:40:26.077853 | instance -> localhost | | . o + | 2026-03-26 08:40:26.077882 | instance -> localhost | |. . o + | 2026-03-26 08:40:26.077911 | instance -> localhost | |o. + o +So . | 2026-03-26 08:40:26.077938 | instance -> localhost | |o.+ o *.= = | 2026-03-26 08:40:26.077966 | instance -> localhost | |+o.+.B +.. o | 2026-03-26 08:40:26.077994 | instance -> localhost | |+.++O .o. | 2026-03-26 08:40:26.078027 | instance -> localhost | |o+o+*E=o. | 2026-03-26 08:40:26.078056 | instance -> localhost | +----[SHA256]-----+ 2026-03-26 08:40:26.078119 | instance -> localhost | ok: Runtime: 0:00:00.766016 2026-03-26 08:40:26.084416 | 2026-03-26 08:40:26.084483 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-26 08:40:26.119569 | instance | ok 2026-03-26 08:40:26.128211 | instance | included: /var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-26 08:40:26.135454 | 2026-03-26 08:40:26.135516 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-26 08:40:26.159587 | instance | skipping: Conditional result was False 2026-03-26 08:40:26.165139 | 2026-03-26 08:40:26.165206 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-26 08:40:26.619024 | instance | changed 2026-03-26 08:40:26.624102 | 2026-03-26 08:40:26.624170 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-26 08:40:26.808533 | instance | ok 2026-03-26 08:40:26.815232 | 2026-03-26 08:40:26.815297 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-26 08:40:27.276983 | instance | changed 2026-03-26 08:40:27.283041 | 2026-03-26 08:40:27.283107 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-26 08:40:27.740100 | instance | changed 2026-03-26 08:40:27.747240 | 2026-03-26 08:40:27.747333 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-26 08:40:27.772305 | instance | skipping: Conditional result was False 2026-03-26 08:40:27.786922 | 2026-03-26 08:40:27.787095 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-26 08:40:28.138055 | instance -> localhost | changed 2026-03-26 08:40:28.190756 | 2026-03-26 08:40:28.191311 | TASK [add-build-sshkey : Add back temp key] 2026-03-26 08:40:28.459463 | instance -> localhost | Identity added: /var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/2b6a6350517a468989620cfcc26d16af_id_rsa (zuul-build-sshkey) 2026-03-26 08:40:28.459690 | instance -> localhost | ok: Runtime: 0:00:00.010965 2026-03-26 08:40:28.464853 | 2026-03-26 08:40:28.464927 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-26 08:40:28.725441 | instance | ok 2026-03-26 08:40:28.730823 | 2026-03-26 08:40:28.730890 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-26 08:40:28.755533 | instance | skipping: Conditional result was False 2026-03-26 08:40:28.772529 | 2026-03-26 08:40:28.772631 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-26 08:40:29.060884 | instance | ok 2026-03-26 08:40:29.070568 | 2026-03-26 08:40:29.070686 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-26 08:40:30.603507 | instance | Output suppressed because no_log was given 2026-03-26 08:40:30.612999 | 2026-03-26 08:40:30.613113 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-26 08:40:30.797599 | instance | ok: "logs" 2026-03-26 08:40:30.797910 | instance | ok: All items complete 2026-03-26 08:40:30.797940 | 2026-03-26 08:40:30.955325 | instance | ok: "artifacts" 2026-03-26 08:40:31.103719 | instance | ok: "docs" 2026-03-26 08:40:31.163230 | 2026-03-26 08:40:31.163343 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-26 08:40:31.345146 | instance | changed: "logs" 2026-03-26 08:40:31.501454 | instance | changed: "artifacts" 2026-03-26 08:40:31.650152 | instance | changed: "docs" 2026-03-26 08:40:31.664715 | 2026-03-26 08:40:31.664826 | PLAY RECAP 2026-03-26 08:40:31.664916 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-26 08:40:31.665010 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:40:31.665035 | 2026-03-26 08:40:31.803359 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 08:40:31.812363 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 08:40:32.467206 | 2026-03-26 08:40:32.467724 | PLAY [all] 2026-03-26 08:40:32.481080 | 2026-03-26 08:40:32.481267 | TASK [setup-uv : Extract archive] 2026-03-26 08:40:34.668670 | instance | changed 2026-03-26 08:40:34.906933 | 2026-03-26 08:40:34.907077 | TASK [setup-uv : Print version] 2026-03-26 08:40:35.256748 | instance | uv 0.8.13 2026-03-26 08:40:35.447620 | instance | ok: Runtime: 0:00:00.011977 2026-03-26 08:40:35.453848 | 2026-03-26 08:40:35.453901 | PLAY RECAP 2026-03-26 08:40:35.453952 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:40:35.453977 | 2026-03-26 08:40:35.576752 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 08:40:35.583465 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-03-26 08:40:36.240877 | 2026-03-26 08:40:36.241074 | PLAY [all] 2026-03-26 08:40:36.252812 | 2026-03-26 08:40:36.252887 | TASK [Install "jq" for log collection] 2026-03-26 08:40:47.759467 | instance | changed 2026-03-26 08:40:47.762974 | 2026-03-26 08:40:47.763055 | PLAY RECAP 2026-03-26 08:40:47.763129 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:40:47.763202 | 2026-03-26 08:40:47.892381 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-03-26 08:40:47.907317 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-26 08:40:48.539135 | 2026-03-26 08:40:48.539291 | PLAY [all] 2026-03-26 08:40:48.552362 | 2026-03-26 08:40:48.552459 | TASK [Copy inventory file for Zuul] 2026-03-26 08:40:49.399611 | instance | changed 2026-03-26 08:40:49.406113 | 2026-03-26 08:40:49.406190 | TASK [Switch "ansible_host" to private IP] 2026-03-26 08:40:49.714308 | instance | changed: 1 replacements made 2026-03-26 08:40:49.719723 | 2026-03-26 08:40:49.719786 | TASK [Run Molecule scenario] 2026-03-26 08:40:50.119913 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-03-26 08:40:50.119991 | instance | Creating virtual environment at: .venv 2026-03-26 08:40:50.147742 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-03-26 08:40:50.168769 | instance | Downloading cryptography (4.2MiB) 2026-03-26 08:40:50.168914 | instance | Downloading pydantic-core (2.0MiB) 2026-03-26 08:40:50.169130 | instance | Downloading netaddr (2.2MiB) 2026-03-26 08:40:50.169458 | instance | Downloading openstacksdk (1.7MiB) 2026-03-26 08:40:50.169691 | instance | Downloading rjsonnet (1.2MiB) 2026-03-26 08:40:50.170242 | instance | Downloading kubernetes (1.9MiB) 2026-03-26 08:40:50.172106 | instance | Downloading pygments (1.2MiB) 2026-03-26 08:40:50.172316 | instance | Downloading ansible-core (2.1MiB) 2026-03-26 08:40:50.172541 | instance | Downloading setuptools (1.1MiB) 2026-03-26 08:40:50.462868 | instance | Building pyperclip==1.9.0 2026-03-26 08:40:50.476891 | instance | Downloading rjsonnet 2026-03-26 08:40:50.577099 | instance | Downloading pydantic-core 2026-03-26 08:40:50.628322 | instance | Downloading netaddr 2026-03-26 08:40:50.640791 | instance | Downloading pygments 2026-03-26 08:40:50.654675 | instance | Downloading cryptography 2026-03-26 08:40:50.692203 | instance | Downloading setuptools 2026-03-26 08:40:50.748658 | instance | Downloading kubernetes 2026-03-26 08:40:50.782826 | instance | Downloading ansible-core 2026-03-26 08:40:50.815138 | instance | Downloading openstacksdk 2026-03-26 08:40:51.164952 | instance | Built pyperclip==1.9.0 2026-03-26 08:40:51.329172 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-03-26 08:40:51.371433 | instance | Installed 83 packages in 40ms 2026-03-26 08:40:52.008700 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-03-26 08:40:52.622775 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-26 08:40:52.622836 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-03-26 08:41:27.377095 | instance | INFO [aio > dependency] Executing 2026-03-26 08:41:27.377352 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-03-26 08:41:27.377607 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-03-26 08:41:27.377758 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-26 08:41:27.386723 | instance | INFO [aio > cleanup] Executing 2026-03-26 08:41:27.387020 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-26 08:41:27.394410 | instance | INFO [aio > destroy] Executing 2026-03-26 08:41:27.394447 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-03-26 08:41:27.394562 | instance | INFO [aio > destroy] Executed: Successful 2026-03-26 08:41:27.402048 | instance | INFO [aio > syntax] Executing 2026-03-26 08:41:29.233500 | instance | ERROR! We were unable to read either as JSON nor YAML, these are the errors we got from each: 2026-03-26 08:41:29.233773 | instance | JSON: Expecting value: line 1 column 1 (char 0) 2026-03-26 08:41:29.234091 | instance | 2026-03-26 08:41:29.234483 | instance | Syntax Error while loading YAML. 2026-03-26 08:41:29.234881 | instance | found character that cannot start any token. while scanning for the next token 2026-03-26 08:41:29.235299 | instance | found character that cannot start any token 2026-03-26 08:41:29.235779 | instance | in "", line 30, column 2 2026-03-26 08:41:29.236217 | instance | 2026-03-26 08:41:29.236542 | instance | The error appears to be in '/home/zuul/.ansible/collections/ansible_collections/vexxhost/atmosphere/roles/smartctl_exporter/tasks/main.yml': line 29, column 42, but may 2026-03-26 08:41:29.236844 | instance | be elsewhere in the file depending on the exact syntax problem. 2026-03-26 08:41:29.237135 | instance | 2026-03-26 08:41:29.237416 | instance | The offending line appears to be: 2026-03-26 08:41:29.237669 | instance | 2026-03-26 08:41:29.237943 | instance | - --smartctl.interval=60s 2026-03-26 08:41:29.238237 | instance | ^ here 2026-03-26 08:41:29.238499 | instance | 2026-03-26 08:41:29.238786 | instance | There appears to be both 'k=v' shorthand syntax and YAML in this task. Only one syntax may be used. 2026-03-26 08:41:29.301992 | instance | CRITICAL Ansible return code was 4, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.aio/inventory --skip-tags molecule-notest,notest --syntax-check --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-03-26 08:41:29.302152 | instance | ERROR [aio > syntax] Executed: Failed 2026-03-26 08:41:29.302342 | instance | ERROR Ansible return code was 4, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.aio/inventory --skip-tags molecule-notest,notest --syntax-check --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-03-26 08:41:29.808073 | instance | ERROR 2026-03-26 08:41:29.808810 | instance | { 2026-03-26 08:41:29.808879 | instance | "delta": "0:00:39.328353", 2026-03-26 08:41:29.808927 | instance | "end": "2026-03-26 08:41:29.382942", 2026-03-26 08:41:29.809000 | instance | "msg": "non-zero return code", 2026-03-26 08:41:29.809047 | instance | "rc": 4, 2026-03-26 08:41:29.809095 | instance | "start": "2026-03-26 08:40:50.054589" 2026-03-26 08:41:29.809137 | instance | } failure 2026-03-26 08:41:29.811857 | 2026-03-26 08:41:29.811899 | PLAY RECAP 2026-03-26 08:41:29.811939 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:41:29.811960 | 2026-03-26 08:41:29.924160 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-26 08:41:29.936100 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-03-26 08:41:30.592035 | 2026-03-26 08:41:30.592223 | PLAY [all] 2026-03-26 08:41:30.608205 | 2026-03-26 08:41:30.608320 | TASK [gather-host-logs : creating directory for system status] 2026-03-26 08:41:30.939192 | instance | changed 2026-03-26 08:41:30.946384 | 2026-03-26 08:41:30.946513 | TASK [gather-host-logs : Get logs for each host] 2026-03-26 08:41:31.284059 | instance | + systemd-cgls --full --all --no-pager 2026-03-26 08:41:31.292364 | instance | + ip addr 2026-03-26 08:41:31.295312 | instance | + ip route 2026-03-26 08:41:31.297495 | instance | + lsblk 2026-03-26 08:41:31.300313 | instance | + mount 2026-03-26 08:41:31.301983 | instance | + docker images 2026-03-26 08:41:31.302385 | instance | /bin/bash: line 7: docker: command not found 2026-03-26 08:41:31.302606 | instance | + brctl show 2026-03-26 08:41:31.302972 | instance | /bin/bash: line 8: brctl: command not found 2026-03-26 08:41:31.303188 | instance | + ps aux --sort=-%mem 2026-03-26 08:41:31.315733 | instance | + dpkg -l 2026-03-26 08:41:31.322969 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-03-26 08:41:31.323555 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-03-26 08:41:31.323698 | instance | /bin/bash: line 11: docker: command not found 2026-03-26 08:41:31.324061 | instance | + '[' '!' -z '' ']' 2026-03-26 08:41:31.491444 | instance | ok: Runtime: 0:00:00.045755 2026-03-26 08:41:31.500450 | 2026-03-26 08:41:31.500544 | TASK [gather-host-logs : Downloads logs to executor] 2026-03-26 08:41:32.132628 | instance | changed: 2026-03-26 08:41:32.132865 | instance | created directory /var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/logs/instance 2026-03-26 08:41:32.133023 | instance | cd+++++++++ system/ 2026-03-26 08:41:32.133058 | instance | >f+++++++++ system/brctl-show.txt 2026-03-26 08:41:32.133086 | instance | >f+++++++++ system/docker-images.txt 2026-03-26 08:41:32.133113 | instance | >f+++++++++ system/ip-addr.txt 2026-03-26 08:41:32.133146 | instance | >f+++++++++ system/ip-route.txt 2026-03-26 08:41:32.133174 | instance | >f+++++++++ system/lsblk.txt 2026-03-26 08:41:32.133201 | instance | >f+++++++++ system/mount.txt 2026-03-26 08:41:32.133232 | instance | >f+++++++++ system/packages.txt 2026-03-26 08:41:32.133263 | instance | >f+++++++++ system/ps.txt 2026-03-26 08:41:32.133294 | instance | >f+++++++++ system/systemd-cgls.txt 2026-03-26 08:41:32.154044 | 2026-03-26 08:41:32.154244 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-26 08:41:32.342015 | instance | changed: "values" 2026-03-26 08:41:32.510282 | instance | changed: "releases" 2026-03-26 08:41:32.529672 | 2026-03-26 08:41:32.529902 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-26 08:41:32.750669 | instance | /bin/bash: line 3: kubectl: command not found 2026-03-26 08:41:33.079135 | instance | ok: Runtime: 0:00:00.006753 2026-03-26 08:41:33.084259 | 2026-03-26 08:41:33.084325 | TASK [helm-release-status : Downloads logs to executor] 2026-03-26 08:41:33.553992 | instance | changed: 2026-03-26 08:41:33.554199 | instance | cd+++++++++ helm/ 2026-03-26 08:41:33.554237 | instance | cd+++++++++ helm/releases/ 2026-03-26 08:41:33.554267 | instance | cd+++++++++ helm/values/ 2026-03-26 08:41:33.564396 | 2026-03-26 08:41:33.564465 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-26 08:41:33.763862 | instance | changed 2026-03-26 08:41:33.802826 | 2026-03-26 08:41:33.802991 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-26 08:41:33.999266 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:41:33.999432 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:41:34.003335 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:41:34.004768 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:41:34.006883 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:41:34.007964 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:41:34.009706 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:41:34.010912 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:41:34.011104 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:41:34.012398 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:41:34.013708 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:41:34.014556 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:41:34.341068 | instance | ok: Runtime: 0:00:00.025476 2026-03-26 08:41:34.347668 | 2026-03-26 08:41:34.347735 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-26 08:41:34.556943 | instance | changed 2026-03-26 08:41:34.565401 | 2026-03-26 08:41:34.565475 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-26 08:41:34.769753 | instance | environment: line 5: kubectl: command not found 2026-03-26 08:41:34.770670 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:41:34.770786 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:41:34.771581 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:41:35.105301 | instance | ok: Runtime: 0:00:00.007906 2026-03-26 08:41:35.113506 | 2026-03-26 08:41:35.113597 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-26 08:41:35.619941 | instance | changed: 2026-03-26 08:41:35.620246 | instance | cd+++++++++ objects/ 2026-03-26 08:41:35.620371 | instance | cd+++++++++ objects/cluster/ 2026-03-26 08:41:35.620439 | instance | cd+++++++++ objects/namespaced/ 2026-03-26 08:41:35.631819 | 2026-03-26 08:41:35.631911 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-26 08:41:35.827914 | instance | changed 2026-03-26 08:41:35.834832 | 2026-03-26 08:41:35.834931 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-26 08:41:36.022585 | instance | changed 2026-03-26 08:41:36.029193 | 2026-03-26 08:41:36.029285 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-26 08:41:36.231770 | instance | environment: line 3: kubectl: command not found 2026-03-26 08:41:36.565282 | instance | ok: Runtime: 0:00:00.009551 2026-03-26 08:41:36.573029 | 2026-03-26 08:41:36.573125 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-26 08:41:37.386121 | instance | changed: 2026-03-26 08:41:37.386338 | instance | cd+++++++++ pod-logs/ 2026-03-26 08:41:37.386375 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-03-26 08:41:37.396030 | 2026-03-26 08:41:37.396098 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-03-26 08:41:37.601195 | instance | changed 2026-03-26 08:41:37.607075 | 2026-03-26 08:41:37.607137 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-03-26 08:41:37.817346 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-26 08:41:38.143555 | instance | ok: Runtime: 0:00:00.033240 2026-03-26 08:41:38.151702 | 2026-03-26 08:41:38.191653 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-03-26 08:41:38.406039 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-26 08:41:38.433924 | instance | ceph-mgr endpoints: 2026-03-26 08:41:38.740222 | instance | ok: Runtime: 0:00:00.036929 2026-03-26 08:41:38.747554 | 2026-03-26 08:41:38.747642 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-03-26 08:41:38.944946 | instance | /bin/bash: line 4: kubectl: command not found 2026-03-26 08:41:39.286007 | instance | ok: Runtime: 0:00:00.038747 2026-03-26 08:41:39.293871 | 2026-03-26 08:41:39.293992 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-03-26 08:41:39.783553 | instance | changed: cd+++++++++ prometheus/ 2026-03-26 08:41:39.798371 | 2026-03-26 08:41:39.798542 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-03-26 08:41:40.040680 | instance | changed 2026-03-26 08:41:40.046807 | 2026-03-26 08:41:40.046957 | TASK [gather-selenium-data : Get selenium data] 2026-03-26 08:41:40.252452 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-03-26 08:41:40.253218 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-03-26 08:41:40.584197 | instance | ERROR 2026-03-26 08:41:40.584485 | instance | { 2026-03-26 08:41:40.584535 | instance | "delta": "0:00:00.004857", 2026-03-26 08:41:40.584565 | instance | "end": "2026-03-26 08:41:40.253448", 2026-03-26 08:41:40.584591 | instance | "msg": "non-zero return code", 2026-03-26 08:41:40.584617 | instance | "rc": 1, 2026-03-26 08:41:40.584642 | instance | "start": "2026-03-26 08:41:40.248591" 2026-03-26 08:41:40.584666 | instance | } 2026-03-26 08:41:40.584697 | instance | ERROR: Ignoring Errors 2026-03-26 08:41:40.593204 | 2026-03-26 08:41:40.593345 | TASK [gather-selenium-data : Downloads logs to executor] 2026-03-26 08:41:41.086367 | instance | changed: cd+++++++++ selenium/ 2026-03-26 08:41:41.092553 | 2026-03-26 08:41:41.092605 | PLAY RECAP 2026-03-26 08:41:41.092653 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-03-26 08:41:41.092673 | 2026-03-26 08:41:41.221729 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-03-26 08:41:41.232692 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 08:41:41.884730 | 2026-03-26 08:41:41.885379 | PLAY [all] 2026-03-26 08:41:41.896466 | 2026-03-26 08:41:41.896538 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-26 08:41:41.942356 | instance | skipping: Conditional result was False 2026-03-26 08:41:41.952353 | 2026-03-26 08:41:41.952435 | TASK [fetch-output : Set log path for single node] 2026-03-26 08:41:41.996065 | instance | ok 2026-03-26 08:41:42.002318 | 2026-03-26 08:41:42.002409 | LOOP [fetch-output : Ensure local output dirs] 2026-03-26 08:41:42.390638 | instance -> localhost | ok: "/var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/logs" 2026-03-26 08:41:42.604831 | instance -> localhost | changed: "/var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/artifacts" 2026-03-26 08:41:42.808331 | instance -> localhost | changed: "/var/lib/zuul/builds/2b6a6350517a468989620cfcc26d16af/work/docs" 2026-03-26 08:41:42.822599 | 2026-03-26 08:41:42.822753 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-26 08:41:43.448146 | instance | changed: .d..t...... ./ 2026-03-26 08:41:43.448382 | instance | changed: All items complete 2026-03-26 08:41:43.448409 | 2026-03-26 08:41:43.899856 | instance | changed: .d..t...... ./ 2026-03-26 08:41:44.331366 | instance | changed: .d..t...... ./ 2026-03-26 08:41:44.356487 | 2026-03-26 08:41:44.356577 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-26 08:41:44.793743 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009320 2026-03-26 08:41:45.046284 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008479 2026-03-26 08:41:45.058939 | 2026-03-26 08:41:45.059066 | PLAY [all] 2026-03-26 08:41:45.066155 | 2026-03-26 08:41:45.066236 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-26 08:41:45.505455 | instance | changed 2026-03-26 08:41:45.513565 | 2026-03-26 08:41:45.513636 | PLAY RECAP 2026-03-26 08:41:45.513696 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-26 08:41:45.513726 | 2026-03-26 08:41:45.655403 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 08:41:45.668732 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-26 08:41:46.300187 | 2026-03-26 08:41:46.300357 | PLAY [localhost] 2026-03-26 08:41:46.311138 | 2026-03-26 08:41:46.311210 | TASK [Generate Zuul manifest] 2026-03-26 08:41:46.330906 | localhost | ok 2026-03-26 08:41:46.347042 | 2026-03-26 08:41:46.347125 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-26 08:41:46.775496 | localhost | changed 2026-03-26 08:41:46.786936 | 2026-03-26 08:41:46.787010 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-26 08:41:46.815303 | localhost | ok 2026-03-26 08:41:46.821742 | 2026-03-26 08:41:46.821806 | TASK [Upload logs] 2026-03-26 08:41:46.843307 | localhost | ok 2026-03-26 08:41:46.978358 | 2026-03-26 08:41:46.978510 | TASK [Set zuul-log-path fact] 2026-03-26 08:41:46.998790 | localhost | ok 2026-03-26 08:41:47.011692 | 2026-03-26 08:41:47.011774 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 08:41:47.045318 | localhost | ok 2026-03-26 08:41:47.055615 | 2026-03-26 08:41:47.055689 | TASK [upload-logs : Create log directories] 2026-03-26 08:41:47.429481 | localhost | changed 2026-03-26 08:41:47.434863 | 2026-03-26 08:41:47.434938 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-26 08:41:47.806876 | localhost -> localhost | ok: Runtime: 0:00:00.005931 2026-03-26 08:41:47.811767 | 2026-03-26 08:41:47.811829 | TASK [upload-logs : Upload logs to log server] 2026-03-26 08:41:48.237813 | localhost | Output suppressed because no_log was given 2026-03-26 08:41:48.241700 | 2026-03-26 08:41:48.241770 | LOOP [upload-logs : Compress console log and json output] 2026-03-26 08:41:48.288315 | localhost | skipping: Conditional result was False 2026-03-26 08:41:48.296505 | localhost | skipping: Conditional result was False 2026-03-26 08:41:48.313164 | 2026-03-26 08:41:48.313362 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-26 08:41:48.358740 | localhost | skipping: Conditional result was False 2026-03-26 08:41:48.359174 | 2026-03-26 08:41:48.363256 | localhost | skipping: Conditional result was False 2026-03-26 08:41:48.375288 | 2026-03-26 08:41:48.375427 | LOOP [upload-logs : Upload console log and json output]