2026-03-26 08:27:34.320132 | Job console starting
2026-03-26 08:27:34.416553 | Updating git repos
2026-03-26 08:27:34.469768 | Cloning repos into workspace
2026-03-26 08:27:34.549518 | Restoring repo states
2026-03-26 08:27:34.568988 | Merging changes
2026-03-26 08:27:35.395854 | Checking out repos
2026-03-26 08:27:35.651368 | Preparing playbooks
2026-03-26 08:27:39.436922 | Running Ansible setup
2026-03-26 08:27:42.762270 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-26 08:27:43.366348 | 
2026-03-26 08:27:43.366486 | PLAY [localhost]
2026-03-26 08:27:43.373743 | 
2026-03-26 08:27:43.373823 | TASK [Gathering Facts]
2026-03-26 08:27:44.569541 | localhost | ok
2026-03-26 08:27:44.581622 | 
2026-03-26 08:27:44.581740 | TASK [Setup log path fact]
2026-03-26 08:27:44.600942 | localhost | ok
2026-03-26 08:27:44.614742 | 
2026-03-26 08:27:44.614823 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-26 08:27:44.643097 | localhost | ok
2026-03-26 08:27:44.651005 | 
2026-03-26 08:27:44.651094 | TASK [emit-job-header : Print job information]
2026-03-26 08:27:44.690917 | # Job Information
2026-03-26 08:27:44.691129 | Ansible Version: 2.16.16
2026-03-26 08:27:44.691203 | Job: atmosphere-molecule-aio-openvswitch
2026-03-26 08:27:44.691252 | Pipeline: check
2026-03-26 08:27:44.691298 | Executor: 0a8996d2b663
2026-03-26 08:27:44.691342 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3772
2026-03-26 08:27:44.691393 | Event ID: 88c77810-28ed-11f1-9f90-c688cc9e4091
2026-03-26 08:27:44.695995 | 
2026-03-26 08:27:44.696085 | LOOP [emit-job-header : Print node information]
2026-03-26 08:27:44.783010 | localhost | ok:
2026-03-26 08:27:44.783204 | localhost | # Node Information
2026-03-26 08:27:44.783243 | localhost | Inventory Hostname: instance
2026-03-26 08:27:44.783273 | localhost | Hostname: np0000161033
2026-03-26 08:27:44.783301 | localhost | Username: zuul
2026-03-26 08:27:44.783332 | localhost | Distro: Ubuntu 22.04
2026-03-26 08:27:44.783359 | localhost | Provider: yul1
2026-03-26 08:27:44.783386 | localhost | Region: ca-ymq-1
2026-03-26 08:27:44.783411 | localhost | Label: ubuntu-jammy-16
2026-03-26 08:27:44.783437 | localhost | Product Name: OpenStack Nova
2026-03-26 08:27:44.783463 | localhost | Interface IP: 199.204.45.169
2026-03-26 08:27:44.803277 | 
2026-03-26 08:27:44.803416 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-26 08:27:45.182885 | localhost -> localhost | changed
2026-03-26 08:27:45.190065 | 
2026-03-26 08:27:45.190162 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-26 08:27:46.440074 | localhost -> localhost | changed
2026-03-26 08:27:46.448914 | 
2026-03-26 08:27:46.462442 | PLAY [all]
2026-03-26 08:27:46.476328 | 
2026-03-26 08:27:46.476410 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-26 08:27:46.723027 | instance -> localhost | ok
2026-03-26 08:27:46.733172 | 
2026-03-26 08:27:46.733266 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-26 08:27:46.767429 | instance | ok
2026-03-26 08:27:46.780057 | instance | included: /var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-26 08:27:46.785461 | 
2026-03-26 08:27:46.785522 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-26 08:27:48.517419 | instance -> localhost | Generating public/private rsa key pair.
2026-03-26 08:27:48.517668 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/c224786fb4734f56b48ce970551312f9_id_rsa
2026-03-26 08:27:48.517733 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/c224786fb4734f56b48ce970551312f9_id_rsa.pub
2026-03-26 08:27:48.517770 | instance -> localhost | The key fingerprint is:
2026-03-26 08:27:48.517801 | instance -> localhost | SHA256:TJTWvq+q/EcyfSjn6zk8Xph9KT5SSry4YmsMOHqANjk zuul-build-sshkey
2026-03-26 08:27:48.517847 | instance -> localhost | The key's randomart image is:
2026-03-26 08:27:48.517878 | instance -> localhost | +---[RSA 3072]----+
2026-03-26 08:27:48.517911 | instance -> localhost | |        .o       |
2026-03-26 08:27:48.517942 | instance -> localhost | |       .o .      |
2026-03-26 08:27:48.517971 | instance -> localhost | |       ...       |
2026-03-26 08:27:48.517999 | instance -> localhost | |       o  .      |
2026-03-26 08:27:48.518026 | instance -> localhost | |. ..    So o     |
2026-03-26 08:27:48.518054 | instance -> localhost | |oEo .   + O+o  . |
2026-03-26 08:27:48.518081 | instance -> localhost | |.oo. o   @o*+ o  |
2026-03-26 08:27:48.518108 | instance -> localhost | |. .  .= . X+oo   |
2026-03-26 08:27:48.518139 | instance -> localhost | | .   o+=+***..   |
2026-03-26 08:27:48.518167 | instance -> localhost | +----[SHA256]-----+
2026-03-26 08:27:48.518244 | instance -> localhost | ok: Runtime: 0:00:01.302419
2026-03-26 08:27:48.525184 | 
2026-03-26 08:27:48.525268 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-26 08:27:48.558118 | instance | ok
2026-03-26 08:27:48.568699 | instance | included: /var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-26 08:27:48.575761 | 
2026-03-26 08:27:48.575822 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-26 08:27:48.599365 | instance | skipping: Conditional result was False
2026-03-26 08:27:48.607701 | 
2026-03-26 08:27:48.607791 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-26 08:27:49.030562 | instance | changed
2026-03-26 08:27:49.038033 | 
2026-03-26 08:27:49.038122 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-26 08:27:49.220193 | instance | ok
2026-03-26 08:27:49.225694 | 
2026-03-26 08:27:49.225778 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-26 08:27:49.662838 | instance | changed
2026-03-26 08:27:49.669374 | 
2026-03-26 08:27:49.669445 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-26 08:27:50.095762 | instance | changed
2026-03-26 08:27:50.101972 | 
2026-03-26 08:27:50.102053 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-26 08:27:50.126514 | instance | skipping: Conditional result was False
2026-03-26 08:27:50.136409 | 
2026-03-26 08:27:50.136505 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-26 08:27:50.494790 | instance -> localhost | changed
2026-03-26 08:27:50.549118 | 
2026-03-26 08:27:50.549239 | TASK [add-build-sshkey : Add back temp key]
2026-03-26 08:27:50.858664 | instance -> localhost | Identity added: /var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/c224786fb4734f56b48ce970551312f9_id_rsa (zuul-build-sshkey)
2026-03-26 08:27:50.858917 | instance -> localhost | ok: Runtime: 0:00:00.014963
2026-03-26 08:27:50.866350 | 
2026-03-26 08:27:50.866461 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-26 08:27:51.132453 | instance | ok
2026-03-26 08:27:51.139518 | 
2026-03-26 08:27:51.139622 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-26 08:27:51.163787 | instance | skipping: Conditional result was False
2026-03-26 08:27:51.180086 | 
2026-03-26 08:27:51.180178 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-26 08:27:51.446286 | instance | ok
2026-03-26 08:27:51.453950 | 
2026-03-26 08:27:51.454072 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-26 08:27:52.973625 | instance | Output suppressed because no_log was given
2026-03-26 08:27:52.986862 | 
2026-03-26 08:27:52.986946 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-26 08:27:53.164980 | instance | ok: "logs"
2026-03-26 08:27:53.165229 | instance | ok: All items complete
2026-03-26 08:27:53.165258 | 
2026-03-26 08:27:53.311283 | instance | ok: "artifacts"
2026-03-26 08:27:53.463433 | instance | ok: "docs"
2026-03-26 08:27:53.483427 | 
2026-03-26 08:27:53.483592 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-26 08:27:53.666663 | instance | changed: "logs"
2026-03-26 08:27:53.828231 | instance | changed: "artifacts"
2026-03-26 08:27:53.982619 | instance | changed: "docs"
2026-03-26 08:27:54.001590 | 
2026-03-26 08:27:54.001722 | PLAY RECAP
2026-03-26 08:27:54.001787 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-03-26 08:27:54.001827 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 08:27:54.001858 | 
2026-03-26 08:27:54.146506 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-03-26 08:27:54.158132 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-26 08:27:54.753470 | 
2026-03-26 08:27:54.753596 | PLAY [all]
2026-03-26 08:27:54.765462 | 
2026-03-26 08:27:54.765543 | TASK [setup-uv : Extract archive]
2026-03-26 08:27:56.943957 | instance | changed
2026-03-26 08:27:56.952427 | 
2026-03-26 08:27:56.952567 | TASK [setup-uv : Print version]
2026-03-26 08:27:56.690132 | instance | uv 0.8.13
2026-03-26 08:27:57.490600 | instance | ok: Runtime: 0:00:00.012391
2026-03-26 08:27:57.498925 | 
2026-03-26 08:27:57.498994 | PLAY RECAP
2026-03-26 08:27:57.499057 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 08:27:57.499092 | 
2026-03-26 08:27:57.610603 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-03-26 08:27:57.621621 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-03-26 08:27:58.238665 | 
2026-03-26 08:27:58.399002 | PLAY [all]
2026-03-26 08:27:58.420932 | 
2026-03-26 08:27:58.421138 | TASK [Install "jq" for log collection]
2026-03-26 08:28:08.738365 | instance | changed
2026-03-26 08:28:08.740292 | 
2026-03-26 08:28:08.740352 | PLAY RECAP
2026-03-26 08:28:08.740402 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-26 08:28:08.740452 | 
2026-03-26 08:28:08.861956 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-03-26 08:28:08.872647 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-26 08:28:09.521477 | 
2026-03-26 08:28:09.521969 | PLAY [all]
2026-03-26 08:28:09.534237 | 
2026-03-26 08:28:09.534329 | TASK [Copy inventory file for Zuul]
2026-03-26 08:28:10.360219 | instance | changed
2026-03-26 08:28:10.367693 | 
2026-03-26 08:28:10.367798 | TASK [Switch "ansible_host" to private IP]
2026-03-26 08:28:10.694552 | instance | changed: 1 replacements made
2026-03-26 08:28:10.702416 | 
2026-03-26 08:28:10.702522 | TASK [Run Molecule scenario]
2026-03-26 08:28:11.130286 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-03-26 08:28:11.130427 | instance | Creating virtual environment at: .venv
2026-03-26 08:28:11.155945 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-03-26 08:28:11.177247 | instance | Downloading netaddr (2.2MiB)
2026-03-26 08:28:11.177427 | instance | Downloading openstacksdk (1.7MiB)
2026-03-26 08:28:11.178482 | instance | Downloading pygments (1.2MiB)
2026-03-26 08:28:11.181968 | instance | Downloading ansible-core (2.1MiB)
2026-03-26 08:28:11.182209 | instance | Downloading rjsonnet (1.2MiB)
2026-03-26 08:28:11.182677 | instance | Downloading pydantic-core (2.0MiB)
2026-03-26 08:28:11.183160 | instance | Downloading kubernetes (1.9MiB)
2026-03-26 08:28:11.183609 | instance | Downloading setuptools (1.1MiB)
2026-03-26 08:28:11.193503 | instance | Downloading cryptography (4.2MiB)
2026-03-26 08:28:11.492065 | instance |    Building pyperclip==1.9.0
2026-03-26 08:28:11.495407 | instance |  Downloading rjsonnet
2026-03-26 08:28:11.607867 | instance |  Downloading pydantic-core
2026-03-26 08:28:11.657062 | instance |  Downloading netaddr
2026-03-26 08:28:11.669596 | instance |  Downloading pygments
2026-03-26 08:28:11.679769 | instance |  Downloading cryptography
2026-03-26 08:28:11.716457 | instance |  Downloading setuptools
2026-03-26 08:28:11.778878 | instance |  Downloading kubernetes
2026-03-26 08:28:11.813807 | instance |  Downloading ansible-core
2026-03-26 08:28:11.847722 | instance |  Downloading openstacksdk
2026-03-26 08:28:12.225999 | instance |       Built pyperclip==1.9.0
2026-03-26 08:28:12.411503 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-03-26 08:28:12.458065 | instance | Installed 83 packages in 44ms
2026-03-26 08:28:13.067579 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-03-26 08:28:13.696383 | 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:13.696492 | instance | INFO     [aio > prerun] Performing prerun with role_name_check=0...
2026-03-26 08:28:58.970771 | instance | INFO     [aio > dependency] Executing
2026-03-26 08:28:58.970959 | instance | WARNING  [aio > dependency] Missing roles requirements file: requirements.yml
2026-03-26 08:28:58.971167 | instance | WARNING  [aio > dependency] Missing collections requirements file: collections.yml
2026-03-26 08:28:58.971289 | instance | WARNING  [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-03-26 08:28:58.978878 | instance | INFO     [aio > cleanup] Executing
2026-03-26 08:28:58.979197 | instance | WARNING  [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-03-26 08:28:58.986881 | instance | INFO     [aio > destroy] Executing
2026-03-26 08:28:58.986975 | instance | WARNING  [aio > destroy] Skipping, '--destroy=never' requested.
2026-03-26 08:28:58.987060 | instance | INFO     [aio > destroy] Executed: Successful
2026-03-26 08:28:58.994758 | instance | INFO     [aio > syntax] Executing
2026-03-26 08:29:00.771648 | 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:00.771919 | instance | JSON: Expecting value: line 1 column 1 (char 0)
2026-03-26 08:29:00.772204 | instance |
2026-03-26 08:29:00.772505 | instance | Syntax Error while loading YAML.
2026-03-26 08:29:00.772804 | instance |   found character that cannot start any token. while scanning for the next token
2026-03-26 08:29:00.773096 | instance | found character that cannot start any token
2026-03-26 08:29:00.773428 | instance |   in "<unicode string>", line 30, column 2
2026-03-26 08:29:00.773657 | instance |
2026-03-26 08:29:00.773972 | 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:00.774269 | instance | be elsewhere in the file depending on the exact syntax problem.
2026-03-26 08:29:00.776464 | instance |
2026-03-26 08:29:00.777013 | instance | The offending line appears to be:
2026-03-26 08:29:00.777026 | instance |
2026-03-26 08:29:00.777546 | instance |                     - --smartctl.interval=60s
2026-03-26 08:29:00.777578 | instance |                                          ^ here
2026-03-26 08:29:00.777872 | instance |
2026-03-26 08:29:00.778178 | 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:00.839841 | 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:00.839960 | instance | ERROR    [aio > syntax] Executed: Failed
2026-03-26 08:29:00.840101 | 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:01.309194 | instance | ERROR
2026-03-26 08:29:01.309424 | instance | {
2026-03-26 08:29:01.309468 | instance |   "delta": "0:00:49.851008",
2026-03-26 08:29:01.309500 | instance |   "end": "2026-03-26 08:29:00.918710",
2026-03-26 08:29:01.309528 | instance |   "msg": "non-zero return code",
2026-03-26 08:29:01.309556 | instance |   "rc": 4,
2026-03-26 08:29:01.309588 | instance |   "start": "2026-03-26 08:28:11.067702"
2026-03-26 08:29:01.309616 | instance | }
failure
2026-03-26 08:29:01.312198 | 
2026-03-26 08:29:01.312267 | PLAY RECAP
2026-03-26 08:29:01.312328 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-03-26 08:29:01.312362 | 
2026-03-26 08:29:01.443569 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-03-26 08:29:01.454348 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-03-26 08:29:02.091341 | 
2026-03-26 08:29:02.091537 | PLAY [all]
2026-03-26 08:29:02.107204 | 
2026-03-26 08:29:02.107308 | TASK [gather-host-logs : creating directory for system status]
2026-03-26 08:29:02.698583 | instance | changed
2026-03-26 08:29:02.704209 | 
2026-03-26 08:29:02.704311 | TASK [gather-host-logs : Get logs for each host]
2026-03-26 08:29:03.040835 | instance | + systemd-cgls --full --all --no-pager
2026-03-26 08:29:03.054528 | instance | + ip addr
2026-03-26 08:29:03.056980 | instance | + ip route
2026-03-26 08:29:03.058719 | instance | + lsblk
2026-03-26 08:29:03.061475 | instance | + mount
2026-03-26 08:29:03.063066 | instance | + docker images
2026-03-26 08:29:03.063448 | instance | /bin/bash: line 7: docker: command not found
2026-03-26 08:29:03.063647 | instance | + brctl show
2026-03-26 08:29:03.064019 | instance | /bin/bash: line 8: brctl: command not found
2026-03-26 08:29:03.064199 | instance | + ps aux --sort=-%mem
2026-03-26 08:29:03.077485 | instance | + dpkg -l
2026-03-26 08:29:03.084735 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-03-26 08:29:03.085146 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-03-26 08:29:03.085240 | instance | /bin/bash: line 11: docker: command not found
2026-03-26 08:29:03.085485 | instance | + '[' '!' -z '' ']'
2026-03-26 08:29:03.247032 | instance | ok: Runtime: 0:00:00.049770
2026-03-26 08:29:03.254229 | 
2026-03-26 08:29:03.254315 | TASK [gather-host-logs : Downloads logs to executor]
2026-03-26 08:29:03.913352 | instance | changed:
2026-03-26 08:29:03.913629 | instance | created directory /var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/logs/instance
2026-03-26 08:29:03.913675 | instance | cd+++++++++ system/
2026-03-26 08:29:03.913708 | instance | >f+++++++++ system/brctl-show.txt
2026-03-26 08:29:03.913738 | instance | >f+++++++++ system/docker-images.txt
2026-03-26 08:29:03.913766 | instance | >f+++++++++ system/ip-addr.txt
2026-03-26 08:29:03.913801 | instance | >f+++++++++ system/ip-route.txt
2026-03-26 08:29:03.913832 | instance | >f+++++++++ system/lsblk.txt
2026-03-26 08:29:03.913861 | instance | >f+++++++++ system/mount.txt
2026-03-26 08:29:03.913892 | instance | >f+++++++++ system/packages.txt
2026-03-26 08:29:03.913920 | instance | >f+++++++++ system/ps.txt
2026-03-26 08:29:03.913949 | instance | >f+++++++++ system/systemd-cgls.txt
2026-03-26 08:29:03.927529 | 
2026-03-26 08:29:03.927698 | LOOP [helm-release-status : creating directory for helm release status]
2026-03-26 08:29:04.128289 | instance | changed: "values"
2026-03-26 08:29:04.298000 | instance | changed: "releases"
2026-03-26 08:29:04.309246 | 
2026-03-26 08:29:04.309438 | TASK [helm-release-status : Gather get release status for helm charts]
2026-03-26 08:29:04.522312 | instance | /bin/bash: line 3: kubectl: command not found
2026-03-26 08:29:04.854097 | instance | ok: Runtime: 0:00:00.008001
2026-03-26 08:29:04.859477 | 
2026-03-26 08:29:04.859572 | TASK [helm-release-status : Downloads logs to executor]
2026-03-26 08:29:05.351792 | instance | changed:
2026-03-26 08:29:05.352040 | instance | cd+++++++++ helm/
2026-03-26 08:29:05.352085 | instance | cd+++++++++ helm/releases/
2026-03-26 08:29:05.352118 | instance | cd+++++++++ helm/values/
2026-03-26 08:29:05.369738 | 
2026-03-26 08:29:05.369882 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-03-26 08:29:05.574821 | instance | changed
2026-03-26 08:29:05.632813 | 
2026-03-26 08:29:05.633014 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-03-26 08:29:05.869877 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 08:29:05.870212 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 08:29:05.876226 | instance | environment: line 1: kubectl: command not found
2026-03-26 08:29:05.877664 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 08:29:05.878236 | instance | environment: line 1: kubectl: command not found
2026-03-26 08:29:05.879439 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 08:29:05.882316 | instance | environment: line 1: kubectl: command not found
2026-03-26 08:29:05.883280 | instance | environment: line 1: kubectl: command not found
2026-03-26 08:29:05.884006 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 08:29:05.884589 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 08:29:05.886794 | instance | environment: line 1: kubectl: command not found
2026-03-26 08:29:05.888107 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-03-26 08:29:06.170293 | instance | ok: Runtime: 0:00:00.027747
2026-03-26 08:29:06.176064 | 
2026-03-26 08:29:06.176135 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-03-26 08:29:06.357065 | instance | changed
2026-03-26 08:29:06.361816 | 
2026-03-26 08:29:06.361884 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-03-26 08:29:06.564791 | instance | environment: line 5: kubectl: command not found
2026-03-26 08:29:06.565138 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-03-26 08:29:06.565260 | 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 08:29:06.565278 | instance |
2026-03-26 08:29:06.895586 | instance | ok: Runtime: 0:00:00.008671
2026-03-26 08:29:06.903467 | 
2026-03-26 08:29:06.903563 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-03-26 08:29:07.402940 | instance | changed:
2026-03-26 08:29:07.403161 | instance | cd+++++++++ objects/
2026-03-26 08:29:07.403271 | instance | cd+++++++++ objects/cluster/
2026-03-26 08:29:07.403310 | instance | cd+++++++++ objects/namespaced/
2026-03-26 08:29:07.415120 | 
2026-03-26 08:29:07.415186 | TASK [gather-pod-logs : creating directory for pod logs]
2026-03-26 08:29:07.609679 | instance | changed
2026-03-26 08:29:07.616671 | 
2026-03-26 08:29:07.616761 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-03-26 08:29:07.844486 | instance | changed
2026-03-26 08:29:07.849738 | 
2026-03-26 08:29:07.849812 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-03-26 08:29:08.057186 | instance | environment: line 3: kubectl: command not found
2026-03-26 08:29:08.386781 | instance | ok: Runtime: 0:00:00.011197
2026-03-26 08:29:08.394105 | 
2026-03-26 08:29:08.394202 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-03-26 08:29:08.874000 | instance | changed:
2026-03-26 08:29:08.874330 | instance | cd+++++++++ pod-logs/
2026-03-26 08:29:08.874392 | instance | cd+++++++++ pod-logs/failed-pods/
2026-03-26 08:29:08.883994 | 
2026-03-26 08:29:08.884056 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-03-26 08:29:09.082123 | instance | changed
2026-03-26 08:29:09.087439 | 
2026-03-26 08:29:09.087547 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-03-26 08:29:09.291360 | instance | /bin/bash: line 2: kubectl: command not found
2026-03-26 08:29:09.624845 | instance | ok: Runtime: 0:00:00.035099
2026-03-26 08:29:09.630201 | 
2026-03-26 08:29:09.630268 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-03-26 08:29:09.832904 | instance | /bin/bash: line 2: kubectl: command not found
2026-03-26 08:29:09.860918 | instance | ceph-mgr endpoints:
2026-03-26 08:29:10.164498 | instance | ok: Runtime: 0:00:00.035628
2026-03-26 08:29:10.172226 | 
2026-03-26 08:29:10.172343 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-03-26 08:29:10.389439 | instance | /bin/bash: line 4: kubectl: command not found
2026-03-26 08:29:10.710381 | instance | ok: Runtime: 0:00:00.037244
2026-03-26 08:29:10.716364 | 
2026-03-26 08:29:10.716434 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-03-26 08:29:11.223778 | instance | changed: cd+++++++++ prometheus/
2026-03-26 08:29:11.233565 | 
2026-03-26 08:29:11.233698 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-03-26 08:29:11.485937 | instance | changed
2026-03-26 08:29:11.491745 | 
2026-03-26 08:29:11.491860 | TASK [gather-selenium-data : Get selenium data]
2026-03-26 08:29:11.690741 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-03-26 08:29:11.692425 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-03-26 08:29:12.030044 | instance | ERROR
2026-03-26 08:29:12.030306 | instance | {
2026-03-26 08:29:12.030356 | instance |   "delta": "0:00:00.008259",
2026-03-26 08:29:12.030387 | instance |   "end": "2026-03-26 08:29:11.692810",
2026-03-26 08:29:12.030414 | instance |   "msg": "non-zero return code",
2026-03-26 08:29:12.030439 | instance |   "rc": 1,
2026-03-26 08:29:12.030465 | instance |   "start": "2026-03-26 08:29:11.684551"
2026-03-26 08:29:12.030490 | instance | }
2026-03-26 08:29:12.030522 | instance | ERROR: Ignoring Errors
2026-03-26 08:29:12.037770 | 
2026-03-26 08:29:12.037860 | TASK [gather-selenium-data : Downloads logs to executor]
2026-03-26 08:29:12.532522 | instance | changed: cd+++++++++ selenium/
2026-03-26 08:29:12.540444 | 
2026-03-26 08:29:12.540515 | PLAY RECAP
2026-03-26 08:29:12.540577 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-03-26 08:29:12.540608 | 
2026-03-26 08:29:12.684472 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-03-26 08:29:12.697636 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-26 08:29:13.334811 | 
2026-03-26 08:29:13.335081 | PLAY [all]
2026-03-26 08:29:13.349145 | 
2026-03-26 08:29:13.349329 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-26 08:29:13.394940 | instance | skipping: Conditional result was False
2026-03-26 08:29:13.403817 | 
2026-03-26 08:29:13.404051 | TASK [fetch-output : Set log path for single node]
2026-03-26 08:29:13.445682 | instance | ok
2026-03-26 08:29:13.452281 | 
2026-03-26 08:29:13.452380 | LOOP [fetch-output : Ensure local output dirs]
2026-03-26 08:29:13.832732 | instance -> localhost | ok: "/var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/logs"
2026-03-26 08:29:14.056328 | instance -> localhost | changed: "/var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/artifacts"
2026-03-26 08:29:14.274188 | instance -> localhost | changed: "/var/lib/zuul/builds/c224786fb4734f56b48ce970551312f9/work/docs"
2026-03-26 08:29:14.292437 | 
2026-03-26 08:29:14.292594 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-26 08:29:14.963684 | instance | changed: .d..t...... ./
2026-03-26 08:29:14.964288 | instance | changed: All items complete
2026-03-26 08:29:14.964332 | 
2026-03-26 08:29:15.458509 | instance | changed: .d..t...... ./
2026-03-26 08:29:15.912692 | instance | changed: .d..t...... ./
2026-03-26 08:29:15.933093 | 
2026-03-26 08:29:15.933277 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-26 08:29:16.351193 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007433
2026-03-26 08:29:16.574403 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006727
2026-03-26 08:29:16.590826 | 
2026-03-26 08:29:16.590945 | PLAY [all]
2026-03-26 08:29:16.598056 | 
2026-03-26 08:29:16.598128 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-03-26 08:29:17.005980 | instance | changed
2026-03-26 08:29:17.013940 | 
2026-03-26 08:29:17.014033 | PLAY RECAP
2026-03-26 08:29:17.014085 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-03-26 08:29:17.014107 | 
2026-03-26 08:29:17.162666 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-03-26 08:29:17.175278 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-03-26 08:29:17.768775 | 
2026-03-26 08:29:17.768938 | PLAY [localhost]
2026-03-26 08:29:17.779199 | 
2026-03-26 08:29:17.779280 | TASK [Generate Zuul manifest]
2026-03-26 08:29:17.802502 | localhost | ok
2026-03-26 08:29:17.820256 | 
2026-03-26 08:29:17.820375 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-26 08:29:18.188532 | localhost | changed
2026-03-26 08:29:18.198933 | 
2026-03-26 08:29:18.199013 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-26 08:29:18.231293 | localhost | ok
2026-03-26 08:29:18.241084 | 
2026-03-26 08:29:18.241189 | TASK [Upload logs]
2026-03-26 08:29:18.263095 | localhost | ok
2026-03-26 08:29:18.370771 | 
2026-03-26 08:29:18.370908 | TASK [Set zuul-log-path fact]
2026-03-26 08:29:18.401079 | localhost | ok
2026-03-26 08:29:18.415234 | 
2026-03-26 08:29:18.415310 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-26 08:29:18.447882 | localhost | ok
2026-03-26 08:29:18.458444 | 
2026-03-26 08:29:18.458539 | TASK [upload-logs : Create log directories]
2026-03-26 08:29:18.819329 | localhost | changed
2026-03-26 08:29:18.826234 | 
2026-03-26 08:29:18.826380 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-03-26 08:29:19.197912 | localhost -> localhost | ok: Runtime: 0:00:00.005458
2026-03-26 08:29:19.206036 | 
2026-03-26 08:29:19.206216 | TASK [upload-logs : Upload logs to log server]
2026-03-26 08:29:19.628443 | localhost | Output suppressed because no_log was given
2026-03-26 08:29:19.635152 | 
2026-03-26 08:29:19.635235 | LOOP [upload-logs : Compress console log and json output]
2026-03-26 08:29:19.691469 | localhost | skipping: Conditional result was False
2026-03-26 08:29:19.699857 | localhost | skipping: Conditional result was False
2026-03-26 08:29:19.712331 | 
2026-03-26 08:29:19.712589 | LOOP [upload-logs : Upload compressed console log and json output]
2026-03-26 08:29:19.759797 | localhost | skipping: Conditional result was False
2026-03-26 08:29:19.760264 | 
2026-03-26 08:29:19.764093 | localhost | skipping: Conditional result was False
2026-03-26 08:29:19.780568 | 
2026-03-26 08:29:19.780808 | LOOP [upload-logs : Upload console log and json output]