2026-03-26 08:27:55.744844 | Job console starting 2026-03-26 08:27:55.761755 | Updating git repos 2026-03-26 08:27:55.831832 | Cloning repos into workspace 2026-03-26 08:27:56.021291 | Restoring repo states 2026-03-26 08:27:56.063483 | Merging changes 2026-03-26 08:27:57.241932 | Checking out repos 2026-03-26 08:27:57.343996 | Preparing playbooks 2026-03-26 08:28:06.060345 | Running Ansible setup 2026-03-26 08:28:09.374665 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 08:28:10.032557 | 2026-03-26 08:28:10.033194 | PLAY [localhost] 2026-03-26 08:28:10.041887 | 2026-03-26 08:28:10.041999 | TASK [Gathering Facts] 2026-03-26 08:28:10.924787 | localhost | ok 2026-03-26 08:28:10.936877 | 2026-03-26 08:28:10.936986 | TASK [Setup log path fact] 2026-03-26 08:28:10.954325 | localhost | ok 2026-03-26 08:28:10.967764 | 2026-03-26 08:28:10.967855 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 08:28:10.995283 | localhost | ok 2026-03-26 08:28:11.003605 | 2026-03-26 08:28:11.003696 | TASK [emit-job-header : Print job information] 2026-03-26 08:28:11.041552 | # Job Information 2026-03-26 08:28:11.041685 | Ansible Version: 2.16.16 2026-03-26 08:28:11.041717 | Job: atmosphere-molecule-aio-ovn 2026-03-26 08:28:11.041739 | Pipeline: check 2026-03-26 08:28:11.041759 | Executor: 0a8996d2b663 2026-03-26 08:28:11.041778 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3772 2026-03-26 08:28:11.041800 | Event ID: 88c77810-28ed-11f1-9f90-c688cc9e4091 2026-03-26 08:28:11.044478 | 2026-03-26 08:28:11.044537 | LOOP [emit-job-header : Print node information] 2026-03-26 08:28:11.139886 | localhost | ok: 2026-03-26 08:28:11.140103 | localhost | # Node Information 2026-03-26 08:28:11.140151 | localhost | Inventory Hostname: instance 2026-03-26 08:28:11.140191 | localhost | Hostname: np0000161034 2026-03-26 08:28:11.140225 | localhost | Username: zuul 2026-03-26 08:28:11.140264 | localhost | Distro: Ubuntu 22.04 2026-03-26 08:28:11.140298 | localhost | Provider: yul1 2026-03-26 08:28:11.140333 | localhost | Region: ca-ymq-1 2026-03-26 08:28:11.140365 | localhost | Label: ubuntu-jammy-16 2026-03-26 08:28:11.140398 | localhost | Product Name: OpenStack Nova 2026-03-26 08:28:11.140429 | localhost | Interface IP: 199.204.45.235 2026-03-26 08:28:11.151096 | 2026-03-26 08:28:11.151237 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-26 08:28:11.530745 | localhost -> localhost | changed 2026-03-26 08:28:11.540494 | 2026-03-26 08:28:11.540567 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-26 08:28:12.407884 | localhost -> localhost | changed 2026-03-26 08:28:12.418248 | 2026-03-26 08:28:12.418325 | PLAY [all] 2026-03-26 08:28:12.427088 | 2026-03-26 08:28:12.427153 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-26 08:28:12.675475 | instance -> localhost | ok 2026-03-26 08:28:12.687265 | 2026-03-26 08:28:12.687358 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-26 08:28:12.722455 | instance | ok 2026-03-26 08:28:12.735990 | instance | included: /var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-26 08:28:12.741649 | 2026-03-26 08:28:12.741707 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-26 08:28:13.591725 | instance -> localhost | Generating public/private rsa key pair. 2026-03-26 08:28:13.592035 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/1251c477d7de4676bb2121693e377f1e_id_rsa 2026-03-26 08:28:13.592104 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/1251c477d7de4676bb2121693e377f1e_id_rsa.pub 2026-03-26 08:28:13.592157 | instance -> localhost | The key fingerprint is: 2026-03-26 08:28:13.592209 | instance -> localhost | SHA256:db0LBhc+9Ubz8QOqTWMJ+VA89mYmszHAUsuskYLOCZE zuul-build-sshkey 2026-03-26 08:28:13.592279 | instance -> localhost | The key's randomart image is: 2026-03-26 08:28:13.592330 | instance -> localhost | +---[RSA 3072]----+ 2026-03-26 08:28:13.592386 | instance -> localhost | | .. oo+....o.| 2026-03-26 08:28:13.592441 | instance -> localhost | | E. . .+=o=o+.o=| 2026-03-26 08:28:13.592493 | instance -> localhost | | . . . o.+B*B ..=| 2026-03-26 08:28:13.592543 | instance -> localhost | | + . . o.=X.* o.| 2026-03-26 08:28:13.592593 | instance -> localhost | | + .S. .% . | 2026-03-26 08:28:13.592644 | instance -> localhost | | o . . | 2026-03-26 08:28:13.592693 | instance -> localhost | | . | 2026-03-26 08:28:13.592742 | instance -> localhost | | | 2026-03-26 08:28:13.592797 | instance -> localhost | | | 2026-03-26 08:28:13.592848 | instance -> localhost | +----[SHA256]-----+ 2026-03-26 08:28:13.593013 | instance -> localhost | ok: Runtime: 0:00:00.435624 2026-03-26 08:28:13.600801 | 2026-03-26 08:28:13.600889 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-26 08:28:13.636523 | instance | ok 2026-03-26 08:28:13.647650 | instance | included: /var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-26 08:28:13.655042 | 2026-03-26 08:28:13.655109 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-26 08:28:13.678775 | instance | skipping: Conditional result was False 2026-03-26 08:28:13.687895 | 2026-03-26 08:28:13.687981 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-26 08:28:14.138160 | instance | changed 2026-03-26 08:28:14.143287 | 2026-03-26 08:28:14.143353 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-26 08:28:14.324883 | instance | ok 2026-03-26 08:28:14.331266 | 2026-03-26 08:28:14.331351 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-26 08:28:14.779534 | instance | changed 2026-03-26 08:28:14.786543 | 2026-03-26 08:28:14.786618 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-26 08:28:15.251991 | instance | changed 2026-03-26 08:28:15.259258 | 2026-03-26 08:28:15.259369 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-26 08:28:15.283544 | instance | skipping: Conditional result was False 2026-03-26 08:28:15.294744 | 2026-03-26 08:28:15.294867 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-26 08:28:15.663935 | instance -> localhost | changed 2026-03-26 08:28:15.713942 | 2026-03-26 08:28:15.714079 | TASK [add-build-sshkey : Add back temp key] 2026-03-26 08:28:16.001507 | instance -> localhost | Identity added: /var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/1251c477d7de4676bb2121693e377f1e_id_rsa (zuul-build-sshkey) 2026-03-26 08:28:16.001809 | instance -> localhost | ok: Runtime: 0:00:00.014084 2026-03-26 08:28:16.007589 | 2026-03-26 08:28:16.007665 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-26 08:28:16.284663 | instance | ok 2026-03-26 08:28:16.291571 | 2026-03-26 08:28:16.291676 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-26 08:28:16.316073 | instance | skipping: Conditional result was False 2026-03-26 08:28:16.333338 | 2026-03-26 08:28:16.333442 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-26 08:28:16.604237 | instance | ok 2026-03-26 08:28:16.612837 | 2026-03-26 08:28:16.612947 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-26 08:28:18.111042 | instance | Output suppressed because no_log was given 2026-03-26 08:28:18.120093 | 2026-03-26 08:28:18.120186 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-26 08:28:18.300559 | instance | ok: "logs" 2026-03-26 08:28:18.300808 | instance | ok: All items complete 2026-03-26 08:28:18.300837 | 2026-03-26 08:28:18.452546 | instance | ok: "artifacts" 2026-03-26 08:28:18.598728 | instance | ok: "docs" 2026-03-26 08:28:18.616940 | 2026-03-26 08:28:18.617124 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-26 08:28:18.795432 | instance | changed: "logs" 2026-03-26 08:28:18.951376 | instance | changed: "artifacts" 2026-03-26 08:28:19.106656 | instance | changed: "docs" 2026-03-26 08:28:19.120233 | 2026-03-26 08:28:19.120380 | PLAY RECAP 2026-03-26 08:28:19.120457 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-26 08:28:19.120498 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:28:19.120526 | 2026-03-26 08:28:19.265349 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-26 08:28:19.277104 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 08:28:19.879307 | 2026-03-26 08:28:19.920774 | PLAY [all] 2026-03-26 08:28:19.941532 | 2026-03-26 08:28:19.941645 | TASK [setup-uv : Extract archive] 2026-03-26 08:28:22.454222 | instance | changed 2026-03-26 08:28:22.462553 | 2026-03-26 08:28:22.462642 | TASK [setup-uv : Print version] 2026-03-26 08:28:22.814943 | instance | uv 0.8.13 2026-03-26 08:28:22.998162 | instance | ok: Runtime: 0:00:00.011259 2026-03-26 08:28:23.011301 | 2026-03-26 08:28:23.011379 | PLAY RECAP 2026-03-26 08:28:23.011441 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:28:23.011477 | 2026-03-26 08:28:23.128738 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-26 08:28:23.301845 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-03-26 08:28:23.940056 | 2026-03-26 08:28:23.940221 | PLAY [all] 2026-03-26 08:28:23.954549 | 2026-03-26 08:28:23.954701 | TASK [Install "jq" for log collection] 2026-03-26 08:28:33.824938 | instance | changed 2026-03-26 08:28:33.828116 | 2026-03-26 08:28:33.828217 | PLAY RECAP 2026-03-26 08:28:33.828310 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:28:33.828403 | 2026-03-26 08:28:33.983478 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-03-26 08:28:33.995307 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-26 08:28:34.639456 | 2026-03-26 08:28:34.639626 | PLAY [all] 2026-03-26 08:28:34.657604 | 2026-03-26 08:28:34.657774 | TASK [Copy inventory file for Zuul] 2026-03-26 08:28:35.531812 | instance | changed 2026-03-26 08:28:35.538668 | 2026-03-26 08:28:35.538774 | TASK [Switch "ansible_host" to private IP] 2026-03-26 08:28:35.857155 | instance | changed: 1 replacements made 2026-03-26 08:28:35.864515 | 2026-03-26 08:28:35.864606 | TASK [Run Molecule scenario] 2026-03-26 08:28:36.276065 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-03-26 08:28:36.276220 | instance | Creating virtual environment at: .venv 2026-03-26 08:28:36.298653 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-03-26 08:28:36.327488 | instance | Downloading cryptography (4.2MiB) 2026-03-26 08:28:36.327654 | instance | Downloading rjsonnet (1.2MiB) 2026-03-26 08:28:36.328097 | instance | Downloading ansible-core (2.1MiB) 2026-03-26 08:28:36.328325 | instance | Downloading openstacksdk (1.7MiB) 2026-03-26 08:28:36.328510 | instance | Downloading kubernetes (1.9MiB) 2026-03-26 08:28:36.329021 | instance | Downloading pydantic-core (2.0MiB) 2026-03-26 08:28:36.329250 | instance | Downloading netaddr (2.2MiB) 2026-03-26 08:28:36.329598 | instance | Downloading pygments (1.2MiB) 2026-03-26 08:28:36.330856 | instance | Downloading setuptools (1.1MiB) 2026-03-26 08:28:36.691083 | instance | Building pyperclip==1.9.0 2026-03-26 08:28:36.711088 | instance | Downloading rjsonnet 2026-03-26 08:28:36.802078 | instance | Downloading pydantic-core 2026-03-26 08:28:36.849352 | instance | Downloading netaddr 2026-03-26 08:28:36.868247 | instance | Downloading pygments 2026-03-26 08:28:36.881761 | instance | Downloading cryptography 2026-03-26 08:28:36.914939 | instance | Downloading setuptools 2026-03-26 08:28:36.961168 | instance | Downloading kubernetes 2026-03-26 08:28:36.990599 | instance | Downloading ansible-core 2026-03-26 08:28:37.013731 | instance | Downloading openstacksdk 2026-03-26 08:28:37.372066 | instance | Built pyperclip==1.9.0 2026-03-26 08:28:37.568878 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-03-26 08:28:37.634082 | instance | Installed 83 packages in 63ms 2026-03-26 08:28:38.231926 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-03-26 08:28:38.857229 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-26 08:28:38.857296 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-03-26 08:29:21.272608 | instance | INFO [aio > dependency] Executing 2026-03-26 08:29:21.272812 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-03-26 08:29:21.273010 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-03-26 08:29:21.273172 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-26 08:29:21.280643 | instance | INFO [aio > cleanup] Executing 2026-03-26 08:29:21.280960 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-26 08:29:21.288429 | instance | INFO [aio > destroy] Executing 2026-03-26 08:29:21.288463 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-03-26 08:29:21.288556 | instance | INFO [aio > destroy] Executed: Successful 2026-03-26 08:29:21.295877 | instance | INFO [aio > syntax] Executing 2026-03-26 08:29:23.046887 | instance | ERROR! We were unable to read either as JSON nor YAML, these are the errors we got from each: 2026-03-26 08:29:23.047191 | instance | JSON: Expecting value: line 1 column 1 (char 0) 2026-03-26 08:29:23.047425 | instance | 2026-03-26 08:29:23.047711 | instance | Syntax Error while loading YAML. 2026-03-26 08:29:23.048080 | instance | found character that cannot start any token. while scanning for the next token 2026-03-26 08:29:23.048386 | instance | found character that cannot start any token 2026-03-26 08:29:23.048785 | instance | in "", line 30, column 2 2026-03-26 08:29:23.049056 | instance | 2026-03-26 08:29:23.049365 | 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:29:23.049654 | instance | be elsewhere in the file depending on the exact syntax problem. 2026-03-26 08:29:23.049870 | instance | 2026-03-26 08:29:23.050174 | instance | The offending line appears to be: 2026-03-26 08:29:23.050467 | instance | 2026-03-26 08:29:23.050758 | instance | - --smartctl.interval=60s 2026-03-26 08:29:23.051096 | instance | ^ here 2026-03-26 08:29:23.051364 | instance | 2026-03-26 08:29:23.051656 | 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:29:23.111260 | 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:29:23.111324 | instance | ERROR [aio > syntax] Executed: Failed 2026-03-26 08:29:23.111428 | 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:29:23.464017 | instance | ERROR 2026-03-26 08:29:23.464198 | instance | { 2026-03-26 08:29:23.464230 | instance | "delta": "0:00:46.964932", 2026-03-26 08:29:23.464255 | instance | "end": "2026-03-26 08:29:23.181328", 2026-03-26 08:29:23.464277 | instance | "msg": "non-zero return code", 2026-03-26 08:29:23.464297 | instance | "rc": 4, 2026-03-26 08:29:23.464318 | instance | "start": "2026-03-26 08:28:36.216396" 2026-03-26 08:29:23.464338 | instance | } failure 2026-03-26 08:29:23.466501 | 2026-03-26 08:29:23.466548 | PLAY RECAP 2026-03-26 08:29:23.466594 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-03-26 08:29:23.466618 | 2026-03-26 08:29:23.602612 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-26 08:29:23.614042 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-03-26 08:29:24.257680 | 2026-03-26 08:29:24.257836 | PLAY [all] 2026-03-26 08:29:24.273185 | 2026-03-26 08:29:24.273298 | TASK [gather-host-logs : creating directory for system status] 2026-03-26 08:29:24.604310 | instance | changed 2026-03-26 08:29:24.627204 | 2026-03-26 08:29:24.627335 | TASK [gather-host-logs : Get logs for each host] 2026-03-26 08:29:24.972045 | instance | + systemd-cgls --full --all --no-pager 2026-03-26 08:29:24.984551 | instance | + ip addr 2026-03-26 08:29:24.987150 | instance | + ip route 2026-03-26 08:29:24.988834 | instance | + lsblk 2026-03-26 08:29:24.991712 | instance | + mount 2026-03-26 08:29:24.993388 | instance | + docker images 2026-03-26 08:29:24.993783 | instance | /bin/bash: line 7: docker: command not found 2026-03-26 08:29:24.993992 | instance | + brctl show 2026-03-26 08:29:24.994387 | instance | /bin/bash: line 8: brctl: command not found 2026-03-26 08:29:24.994606 | instance | + ps aux --sort=-%mem 2026-03-26 08:29:25.008367 | instance | + dpkg -l 2026-03-26 08:29:25.013879 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-03-26 08:29:25.014239 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-03-26 08:29:25.014272 | instance | /bin/bash: line 11: docker: command not found 2026-03-26 08:29:25.014536 | instance | + '[' '!' -z '' ']' 2026-03-26 08:29:25.199924 | instance | ok: Runtime: 0:00:00.048280 2026-03-26 08:29:25.208896 | 2026-03-26 08:29:25.209044 | TASK [gather-host-logs : Downloads logs to executor] 2026-03-26 08:29:25.829038 | instance | changed: 2026-03-26 08:29:25.829236 | instance | created directory /var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/logs/instance 2026-03-26 08:29:25.829278 | instance | cd+++++++++ system/ 2026-03-26 08:29:25.829311 | instance | >f+++++++++ system/brctl-show.txt 2026-03-26 08:29:25.829342 | instance | >f+++++++++ system/docker-images.txt 2026-03-26 08:29:25.829372 | instance | >f+++++++++ system/ip-addr.txt 2026-03-26 08:29:25.829404 | instance | >f+++++++++ system/ip-route.txt 2026-03-26 08:29:25.829435 | instance | >f+++++++++ system/lsblk.txt 2026-03-26 08:29:25.829465 | instance | >f+++++++++ system/mount.txt 2026-03-26 08:29:25.829498 | instance | >f+++++++++ system/packages.txt 2026-03-26 08:29:25.829528 | instance | >f+++++++++ system/ps.txt 2026-03-26 08:29:25.829557 | instance | >f+++++++++ system/systemd-cgls.txt 2026-03-26 08:29:25.842716 | 2026-03-26 08:29:25.843256 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-26 08:29:26.030503 | instance | changed: "values" 2026-03-26 08:29:26.194000 | instance | changed: "releases" 2026-03-26 08:29:26.213278 | 2026-03-26 08:29:26.213421 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-26 08:29:26.410081 | instance | /bin/bash: line 3: kubectl: command not found 2026-03-26 08:29:26.744690 | instance | ok: Runtime: 0:00:00.005685 2026-03-26 08:29:26.751007 | 2026-03-26 08:29:26.751102 | TASK [helm-release-status : Downloads logs to executor] 2026-03-26 08:29:27.256036 | instance | changed: 2026-03-26 08:29:27.256307 | instance | cd+++++++++ helm/ 2026-03-26 08:29:27.256352 | instance | cd+++++++++ helm/releases/ 2026-03-26 08:29:27.256384 | instance | cd+++++++++ helm/values/ 2026-03-26 08:29:27.267273 | 2026-03-26 08:29:27.267399 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-26 08:29:27.455124 | instance | changed 2026-03-26 08:29:27.496861 | 2026-03-26 08:29:27.497022 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-26 08:29:27.703697 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:29:27.703961 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:29:27.709274 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:29:27.710589 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:29:27.711092 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:29:27.712365 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:29:27.714080 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:29:27.715394 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:29:27.716729 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:29:27.718030 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:29:27.718986 | instance | environment: line 1: kubectl: command not found 2026-03-26 08:29:27.720428 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-26 08:29:28.038467 | instance | ok: Runtime: 0:00:00.026751 2026-03-26 08:29:28.044070 | 2026-03-26 08:29:28.044134 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-26 08:29:28.240353 | instance | changed 2026-03-26 08:29:28.247451 | 2026-03-26 08:29:28.247610 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-26 08:29:28.443658 | instance | environment: line 5: kubectl: command not found 2026-03-26 08:29:28.444342 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:29:28.445164 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:29:28.445253 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-26 08:29:28.790736 | instance | ok: Runtime: 0:00:00.008418 2026-03-26 08:29:28.796790 | 2026-03-26 08:29:28.796864 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-26 08:29:29.281224 | instance | changed: 2026-03-26 08:29:29.281437 | instance | cd+++++++++ objects/ 2026-03-26 08:29:29.281487 | instance | cd+++++++++ objects/cluster/ 2026-03-26 08:29:29.281522 | instance | cd+++++++++ objects/namespaced/ 2026-03-26 08:29:29.294396 | 2026-03-26 08:29:29.294552 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-26 08:29:29.480452 | instance | changed 2026-03-26 08:29:29.486988 | 2026-03-26 08:29:29.487102 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-26 08:29:29.662470 | instance | changed 2026-03-26 08:29:29.669579 | 2026-03-26 08:29:29.669673 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-26 08:29:29.884797 | instance | environment: line 3: kubectl: command not found 2026-03-26 08:29:30.216014 | instance | ok: Runtime: 0:00:00.009048 2026-03-26 08:29:30.224391 | 2026-03-26 08:29:30.224575 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-26 08:29:30.691207 | instance | changed: 2026-03-26 08:29:30.691399 | instance | cd+++++++++ pod-logs/ 2026-03-26 08:29:30.691442 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-03-26 08:29:30.703561 | 2026-03-26 08:29:30.703637 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-03-26 08:29:30.930812 | instance | changed 2026-03-26 08:29:30.935680 | 2026-03-26 08:29:30.935749 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-03-26 08:29:31.132096 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-26 08:29:31.474866 | instance | ok: Runtime: 0:00:00.036921 2026-03-26 08:29:31.480179 | 2026-03-26 08:29:31.480255 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-03-26 08:29:31.679724 | instance | /bin/bash: line 2: kubectl: command not found 2026-03-26 08:29:31.708654 | instance | ceph-mgr endpoints: 2026-03-26 08:29:32.017235 | instance | ok: Runtime: 0:00:00.034957 2026-03-26 08:29:32.024483 | 2026-03-26 08:29:32.024574 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-03-26 08:29:32.228198 | instance | /bin/bash: line 4: kubectl: command not found 2026-03-26 08:29:32.565095 | instance | ok: Runtime: 0:00:00.032565 2026-03-26 08:29:32.570981 | 2026-03-26 08:29:32.571052 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-03-26 08:29:33.052937 | instance | changed: cd+++++++++ prometheus/ 2026-03-26 08:29:33.062441 | 2026-03-26 08:29:33.062536 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-03-26 08:29:33.311560 | instance | changed 2026-03-26 08:29:33.317364 | 2026-03-26 08:29:33.317460 | TASK [gather-selenium-data : Get selenium data] 2026-03-26 08:29:33.524370 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-03-26 08:29:33.525900 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-03-26 08:29:33.854367 | instance | ERROR 2026-03-26 08:29:33.854627 | instance | { 2026-03-26 08:29:33.854677 | instance | "delta": "0:00:00.006681", 2026-03-26 08:29:33.854710 | instance | "end": "2026-03-26 08:29:33.526282", 2026-03-26 08:29:33.854740 | instance | "msg": "non-zero return code", 2026-03-26 08:29:33.854769 | instance | "rc": 1, 2026-03-26 08:29:33.854798 | instance | "start": "2026-03-26 08:29:33.519601" 2026-03-26 08:29:33.854825 | instance | } 2026-03-26 08:29:33.854863 | instance | ERROR: Ignoring Errors 2026-03-26 08:29:33.862497 | 2026-03-26 08:29:33.862586 | TASK [gather-selenium-data : Downloads logs to executor] 2026-03-26 08:29:34.344593 | instance | changed: cd+++++++++ selenium/ 2026-03-26 08:29:34.353025 | 2026-03-26 08:29:34.353133 | PLAY RECAP 2026-03-26 08:29:34.353180 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-03-26 08:29:34.353203 | 2026-03-26 08:29:34.489314 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-03-26 08:29:34.500824 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 08:29:35.149397 | 2026-03-26 08:29:35.149898 | PLAY [all] 2026-03-26 08:29:35.162604 | 2026-03-26 08:29:35.162759 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-26 08:29:35.207677 | instance | skipping: Conditional result was False 2026-03-26 08:29:35.217602 | 2026-03-26 08:29:35.217791 | TASK [fetch-output : Set log path for single node] 2026-03-26 08:29:35.262067 | instance | ok 2026-03-26 08:29:35.267423 | 2026-03-26 08:29:35.267541 | LOOP [fetch-output : Ensure local output dirs] 2026-03-26 08:29:35.688427 | instance -> localhost | ok: "/var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/logs" 2026-03-26 08:29:35.893253 | instance -> localhost | changed: "/var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/artifacts" 2026-03-26 08:29:36.118503 | instance -> localhost | changed: "/var/lib/zuul/builds/1251c477d7de4676bb2121693e377f1e/work/docs" 2026-03-26 08:29:36.142329 | 2026-03-26 08:29:36.142501 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-26 08:29:36.749589 | instance | changed: .d..t...... ./ 2026-03-26 08:29:36.749881 | instance | changed: All items complete 2026-03-26 08:29:36.749956 | 2026-03-26 08:29:37.230086 | instance | changed: .d..t...... ./ 2026-03-26 08:29:37.662560 | instance | changed: .d..t...... ./ 2026-03-26 08:29:37.686807 | 2026-03-26 08:29:37.686998 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-26 08:29:38.080467 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006442 2026-03-26 08:29:38.288765 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.004684 2026-03-26 08:29:38.300904 | 2026-03-26 08:29:38.301064 | PLAY [all] 2026-03-26 08:29:38.308565 | 2026-03-26 08:29:38.308633 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-26 08:29:38.719562 | instance | changed 2026-03-26 08:29:38.725665 | 2026-03-26 08:29:38.725718 | PLAY RECAP 2026-03-26 08:29:38.725771 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-26 08:29:38.725794 | 2026-03-26 08:29:38.860428 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-26 08:29:38.869106 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-26 08:29:39.483188 | 2026-03-26 08:29:39.483358 | PLAY [localhost] 2026-03-26 08:29:39.493473 | 2026-03-26 08:29:39.493561 | TASK [Generate Zuul manifest] 2026-03-26 08:29:39.515084 | localhost | ok 2026-03-26 08:29:39.530690 | 2026-03-26 08:29:39.530803 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-26 08:29:39.949656 | localhost | changed 2026-03-26 08:29:39.961663 | 2026-03-26 08:29:39.961778 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-26 08:29:39.992791 | localhost | ok 2026-03-26 08:29:40.000797 | 2026-03-26 08:29:40.000871 | TASK [Upload logs] 2026-03-26 08:29:40.022382 | localhost | ok 2026-03-26 08:29:40.127225 | 2026-03-26 08:29:40.127361 | TASK [Set zuul-log-path fact] 2026-03-26 08:29:40.147636 | localhost | ok 2026-03-26 08:29:40.158879 | 2026-03-26 08:29:40.158946 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-26 08:29:40.189321 | localhost | ok 2026-03-26 08:29:40.198802 | 2026-03-26 08:29:40.198876 | TASK [upload-logs : Create log directories] 2026-03-26 08:29:40.564080 | localhost | changed 2026-03-26 08:29:40.570439 | 2026-03-26 08:29:40.570512 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-26 08:29:40.926060 | localhost -> localhost | ok: Runtime: 0:00:00.004936 2026-03-26 08:29:40.931315 | 2026-03-26 08:29:40.931383 | TASK [upload-logs : Upload logs to log server] 2026-03-26 08:29:41.356868 | localhost | Output suppressed because no_log was given 2026-03-26 08:29:41.361837 | 2026-03-26 08:29:41.361920 | LOOP [upload-logs : Compress console log and json output] 2026-03-26 08:29:41.406319 | localhost | skipping: Conditional result was False 2026-03-26 08:29:41.413689 | localhost | skipping: Conditional result was False 2026-03-26 08:29:41.425201 | 2026-03-26 08:29:41.425360 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-26 08:29:41.467729 | localhost | skipping: Conditional result was False 2026-03-26 08:29:41.468156 | 2026-03-26 08:29:41.472214 | localhost | skipping: Conditional result was False 2026-03-26 08:29:41.486882 | 2026-03-26 08:29:41.487043 | LOOP [upload-logs : Upload console log and json output]