2026-04-16 00:16:19.309021 | Job console starting 2026-04-16 00:16:19.316187 | Updating git repos 2026-04-16 00:16:19.364993 | Cloning repos into workspace 2026-04-16 00:16:19.414763 | Restoring repo states 2026-04-16 00:16:19.434827 | Merging changes 2026-04-16 00:16:20.411393 | Checking out repos 2026-04-16 00:16:20.583884 | Preparing playbooks 2026-04-16 00:16:23.006395 | Running Ansible setup 2026-04-16 00:16:26.361524 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-16 00:16:26.978525 | 2026-04-16 00:16:26.978688 | PLAY [localhost] 2026-04-16 00:16:26.986361 | 2026-04-16 00:16:26.986432 | TASK [Gathering Facts] 2026-04-16 00:16:27.823243 | localhost | ok 2026-04-16 00:16:27.831913 | 2026-04-16 00:16:27.831996 | TASK [Setup log path fact] 2026-04-16 00:16:27.853038 | localhost | ok 2026-04-16 00:16:27.865559 | 2026-04-16 00:16:27.865621 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-16 00:16:27.895599 | localhost | ok 2026-04-16 00:16:27.904278 | 2026-04-16 00:16:27.904346 | TASK [emit-job-header : Print job information] 2026-04-16 00:16:27.946878 | # Job Information 2026-04-16 00:16:27.947164 | Ansible Version: 2.16.16 2026-04-16 00:16:27.947252 | Job: atmosphere-molecule-aio-openvswitch 2026-04-16 00:16:27.947305 | Pipeline: check 2026-04-16 00:16:27.947350 | Executor: 0a8996d2b663 2026-04-16 00:16:27.947394 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3835 2026-04-16 00:16:27.947445 | Event ID: 69329484-3929-11f1-806c-0c126485a0af 2026-04-16 00:16:27.950867 | 2026-04-16 00:16:27.950937 | LOOP [emit-job-header : Print node information] 2026-04-16 00:16:28.046432 | localhost | ok: 2026-04-16 00:16:28.047318 | localhost | # Node Information 2026-04-16 00:16:28.047392 | localhost | Inventory Hostname: instance 2026-04-16 00:16:28.047445 | localhost | Hostname: np0000166499 2026-04-16 00:16:28.047491 | localhost | Username: zuul 2026-04-16 00:16:28.047541 | localhost | Distro: Ubuntu 22.04 2026-04-16 00:16:28.047587 | localhost | Provider: yul1 2026-04-16 00:16:28.047630 | localhost | Region: ca-ymq-1 2026-04-16 00:16:28.047673 | localhost | Label: ubuntu-jammy-16 2026-04-16 00:16:28.047715 | localhost | Product Name: OpenStack Nova 2026-04-16 00:16:28.047757 | localhost | Interface IP: 199.204.45.69 2026-04-16 00:16:28.067933 | 2026-04-16 00:16:28.068108 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-16 00:16:28.438126 | localhost -> localhost | changed 2026-04-16 00:16:28.447749 | 2026-04-16 00:16:28.447889 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-16 00:16:29.775635 | localhost -> localhost | changed 2026-04-16 00:16:29.785304 | 2026-04-16 00:16:29.785393 | PLAY [all] 2026-04-16 00:16:29.799198 | 2026-04-16 00:16:29.799327 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-16 00:16:30.027063 | instance -> localhost | ok 2026-04-16 00:16:30.039625 | 2026-04-16 00:16:30.039722 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-16 00:16:30.075271 | instance | ok 2026-04-16 00:16:30.089439 | instance | included: /var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-16 00:16:30.095198 | 2026-04-16 00:16:30.095261 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-16 00:16:31.904065 | instance -> localhost | Generating public/private rsa key pair. 2026-04-16 00:16:31.904281 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/3f91c0408f46437981d2e71b8da0bdd4_id_rsa 2026-04-16 00:16:31.904313 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/3f91c0408f46437981d2e71b8da0bdd4_id_rsa.pub 2026-04-16 00:16:31.904338 | instance -> localhost | The key fingerprint is: 2026-04-16 00:16:31.904360 | instance -> localhost | SHA256:cAUy/nkfAp3ojoat+ypIi+ZN35jpw0zhVsNNrQx61zM zuul-build-sshkey 2026-04-16 00:16:31.904400 | instance -> localhost | The key's randomart image is: 2026-04-16 00:16:31.904422 | instance -> localhost | +---[RSA 3072]----+ 2026-04-16 00:16:31.904449 | instance -> localhost | | o ..o | 2026-04-16 00:16:31.904471 | instance -> localhost | | . + = o | 2026-04-16 00:16:31.904493 | instance -> localhost | | = O = | 2026-04-16 00:16:31.904514 | instance -> localhost | | o X B E | 2026-04-16 00:16:31.904535 | instance -> localhost | | . + S o + | 2026-04-16 00:16:31.904556 | instance -> localhost | | . * o . o . | 2026-04-16 00:16:31.904577 | instance -> localhost | |o...* + . . | 2026-04-16 00:16:31.904597 | instance -> localhost | |oo+ .*= | 2026-04-16 00:16:31.904619 | instance -> localhost | |o. o=Xo. | 2026-04-16 00:16:31.904640 | instance -> localhost | +----[SHA256]-----+ 2026-04-16 00:16:31.904695 | instance -> localhost | ok: Runtime: 0:00:01.386955 2026-04-16 00:16:31.909901 | 2026-04-16 00:16:31.909985 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-16 00:16:31.947273 | instance | ok 2026-04-16 00:16:31.958601 | instance | included: /var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-16 00:16:31.966027 | 2026-04-16 00:16:31.966105 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-16 00:16:31.991234 | instance | skipping: Conditional result was False 2026-04-16 00:16:32.001662 | 2026-04-16 00:16:32.001758 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-16 00:16:32.442376 | instance | changed 2026-04-16 00:16:32.450445 | 2026-04-16 00:16:32.450518 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-16 00:16:32.633651 | instance | ok 2026-04-16 00:16:32.638696 | 2026-04-16 00:16:32.638769 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-16 00:16:33.142534 | instance | changed 2026-04-16 00:16:33.403180 | 2026-04-16 00:16:33.403320 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-16 00:16:33.837360 | instance | changed 2026-04-16 00:16:33.995215 | 2026-04-16 00:16:33.995352 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-16 00:16:34.020592 | instance | skipping: Conditional result was False 2026-04-16 00:16:34.066902 | 2026-04-16 00:16:34.067057 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-16 00:16:34.376659 | instance -> localhost | changed 2026-04-16 00:16:34.392328 | 2026-04-16 00:16:34.392394 | TASK [add-build-sshkey : Add back temp key] 2026-04-16 00:16:34.801226 | instance -> localhost | Identity added: /var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/3f91c0408f46437981d2e71b8da0bdd4_id_rsa (zuul-build-sshkey) 2026-04-16 00:16:34.801458 | instance -> localhost | ok: Runtime: 0:00:00.012866 2026-04-16 00:16:34.808107 | 2026-04-16 00:16:34.808193 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-16 00:16:35.063064 | instance | ok 2026-04-16 00:16:35.070529 | 2026-04-16 00:16:35.070599 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-16 00:16:35.094846 | instance | skipping: Conditional result was False 2026-04-16 00:16:35.110114 | 2026-04-16 00:16:35.110214 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-16 00:16:35.387260 | instance | ok 2026-04-16 00:16:35.394181 | 2026-04-16 00:16:35.394259 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-16 00:16:36.913874 | instance | Output suppressed because no_log was given 2026-04-16 00:16:36.925365 | 2026-04-16 00:16:36.925443 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-16 00:16:37.137859 | instance | ok: "logs" 2026-04-16 00:16:37.138486 | instance | ok: All items complete 2026-04-16 00:16:37.138530 | 2026-04-16 00:16:37.294194 | instance | ok: "artifacts" 2026-04-16 00:16:37.435849 | instance | ok: "docs" 2026-04-16 00:16:37.450176 | 2026-04-16 00:16:37.450313 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-16 00:16:37.625204 | instance | changed: "logs" 2026-04-16 00:16:37.783236 | instance | changed: "artifacts" 2026-04-16 00:16:37.935982 | instance | changed: "docs" 2026-04-16 00:16:37.961555 | 2026-04-16 00:16:37.961660 | PLAY RECAP 2026-04-16 00:16:37.961708 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-16 00:16:37.961737 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:16:37.961760 | 2026-04-16 00:16:38.082961 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-16 00:16:38.092998 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-16 00:16:38.681588 | 2026-04-16 00:16:38.681715 | PLAY [all] 2026-04-16 00:16:38.693548 | 2026-04-16 00:16:38.693627 | TASK [setup-uv : Extract archive] 2026-04-16 00:16:41.035974 | instance | changed 2026-04-16 00:16:41.042114 | 2026-04-16 00:16:41.042195 | TASK [setup-uv : Print version] 2026-04-16 00:16:42.125353 | instance | uv 0.8.13 2026-04-16 00:16:41.578707 | instance | ok: Runtime: 0:00:00.012548 2026-04-16 00:16:41.586267 | 2026-04-16 00:16:41.586316 | PLAY RECAP 2026-04-16 00:16:41.586361 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:16:41.586386 | 2026-04-16 00:16:41.699526 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-16 00:16:41.710188 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre-install-deps.yml@main] 2026-04-16 00:16:42.310802 | 2026-04-16 00:16:42.310979 | PLAY [all] 2026-04-16 00:16:42.327905 | 2026-04-16 00:16:42.328008 | TASK [Install system packages] 2026-04-16 00:17:10.850956 | instance | changed 2026-04-16 00:17:10.859847 | 2026-04-16 00:17:10.859950 | TASK [Enable iscsid service] 2026-04-16 00:17:11.964560 | instance | changed 2026-04-16 00:17:11.973632 | 2026-04-16 00:17:11.973708 | TASK [Enable multipathd service] 2026-04-16 00:17:12.310198 | instance | ok 2026-04-16 00:17:12.319097 | 2026-04-16 00:17:12.319175 | TASK [Install Helm 3.14.4] 2026-04-16 00:17:13.359966 | instance | ok: Runtime: 0:00:00.608312 2026-04-16 00:17:13.367920 | 2026-04-16 00:17:13.367992 | TASK [Install Go 1.24.2] 2026-04-16 00:17:16.408860 | instance | ok: Runtime: 0:00:02.415925 2026-04-16 00:17:16.415375 | 2026-04-16 00:17:16.415462 | TASK [Create Python venv and install openstacksdk] 2026-04-16 00:17:33.110826 | instance | changed 2026-04-16 00:17:33.113499 | 2026-04-16 00:17:33.113544 | PLAY RECAP 2026-04-16 00:17:33.113595 | instance | ok: 6 changed: 5 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:17:33.113618 | 2026-04-16 00:17:33.246054 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre-install-deps.yml@main] 2026-04-16 00:17:33.392717 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-16 00:17:33.959814 | 2026-04-16 00:17:33.959936 | PLAY [all] 2026-04-16 00:17:33.966349 | 2026-04-16 00:17:33.966417 | PLAY RECAP 2026-04-16 00:17:33.966451 | 2026-04-16 00:17:34.063167 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-16 00:17:34.074099 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main] 2026-04-16 00:17:34.643858 | 2026-04-16 00:17:34.643987 | PLAY [all] 2026-04-16 00:17:34.654770 | 2026-04-16 00:17:34.654842 | TASK [Build atmosphere binary] 2026-04-16 00:17:34.989402 | instance | go: downloading go1.24.4 (linux/amd64) 2026-04-16 00:17:40.779160 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-04-16 00:17:40.786956 | instance | go: downloading golang.org/x/sync v0.18.0 2026-04-16 00:17:40.949220 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-04-16 00:17:48.281777 | instance | ok: Runtime: 0:00:13.042909 2026-04-16 00:17:48.289103 | 2026-04-16 00:17:48.289174 | TASK [Deploy with parallel orchestrator] 2026-04-16 00:17:48.491533 | instance | /bin/bash: line 1: .venv/bin/activate: No such file or directory 2026-04-16 00:17:48.824197 | instance | ERROR 2026-04-16 00:17:48.824422 | instance | { 2026-04-16 00:17:48.824464 | instance | "delta": "0:00:00.009500", 2026-04-16 00:17:48.824493 | instance | "end": "2026-04-16 00:17:48.491914", 2026-04-16 00:17:48.824520 | instance | "msg": "non-zero return code", 2026-04-16 00:17:48.824546 | instance | "rc": 1, 2026-04-16 00:17:48.824572 | instance | "start": "2026-04-16 00:17:48.482414" 2026-04-16 00:17:48.824602 | instance | } failure 2026-04-16 00:17:48.826336 | 2026-04-16 00:17:48.826400 | PLAY RECAP 2026-04-16 00:17:48.826458 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-16 00:17:48.826488 | 2026-04-16 00:17:48.986577 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main] 2026-04-16 00:17:48.999448 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-16 00:17:49.667602 | 2026-04-16 00:17:49.667781 | PLAY [all] 2026-04-16 00:17:49.684334 | 2026-04-16 00:17:49.684448 | TASK [gather-host-logs : creating directory for system status] 2026-04-16 00:17:50.034934 | instance | changed 2026-04-16 00:17:50.041180 | 2026-04-16 00:17:50.041267 | TASK [gather-host-logs : Get logs for each host] 2026-04-16 00:17:50.393604 | instance | + systemd-cgls --full --all --no-pager 2026-04-16 00:17:50.405569 | instance | + ip addr 2026-04-16 00:17:50.408462 | instance | + ip route 2026-04-16 00:17:50.410642 | instance | + lsblk 2026-04-16 00:17:50.414628 | instance | + mount 2026-04-16 00:17:50.416125 | instance | + docker images 2026-04-16 00:17:50.416489 | instance | /bin/bash: line 7: docker: command not found 2026-04-16 00:17:50.416678 | instance | + brctl show 2026-04-16 00:17:50.417005 | instance | /bin/bash: line 8: brctl: command not found 2026-04-16 00:17:50.417312 | instance | + ps aux --sort=-%mem 2026-04-16 00:17:50.431608 | instance | + dpkg -l 2026-04-16 00:17:50.443419 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-16 00:17:50.443922 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-16 00:17:50.443960 | instance | /bin/bash: line 11: docker: command not found 2026-04-16 00:17:50.444325 | instance | + '[' '!' -z '' ']' 2026-04-16 00:17:50.579715 | instance | ok: Runtime: 0:00:00.056652 2026-04-16 00:17:50.588129 | 2026-04-16 00:17:50.588234 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-16 00:17:51.244392 | instance | changed: 2026-04-16 00:17:51.244601 | instance | created directory /var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/logs/instance 2026-04-16 00:17:51.244632 | instance | cd+++++++++ system/ 2026-04-16 00:17:51.244654 | instance | >f+++++++++ system/brctl-show.txt 2026-04-16 00:17:51.244676 | instance | >f+++++++++ system/docker-images.txt 2026-04-16 00:17:51.244695 | instance | >f+++++++++ system/ip-addr.txt 2026-04-16 00:17:51.244720 | instance | >f+++++++++ system/ip-route.txt 2026-04-16 00:17:51.244740 | instance | >f+++++++++ system/lsblk.txt 2026-04-16 00:17:51.244760 | instance | >f+++++++++ system/mount.txt 2026-04-16 00:17:51.244781 | instance | >f+++++++++ system/packages.txt 2026-04-16 00:17:51.244800 | instance | >f+++++++++ system/ps.txt 2026-04-16 00:17:51.244819 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-16 00:17:51.254404 | 2026-04-16 00:17:51.254478 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-16 00:17:51.455489 | instance | changed: "values" 2026-04-16 00:17:51.631382 | instance | changed: "releases" 2026-04-16 00:17:51.652399 | 2026-04-16 00:17:51.652612 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-16 00:17:51.871317 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-16 00:17:52.192304 | instance | ok: Runtime: 0:00:00.007405 2026-04-16 00:17:52.204256 | 2026-04-16 00:17:52.204466 | TASK [helm-release-status : Downloads logs to executor] 2026-04-16 00:17:52.705033 | instance | changed: 2026-04-16 00:17:52.705219 | instance | cd+++++++++ helm/ 2026-04-16 00:17:52.705258 | instance | cd+++++++++ helm/releases/ 2026-04-16 00:17:52.705288 | instance | cd+++++++++ helm/values/ 2026-04-16 00:17:52.717152 | 2026-04-16 00:17:52.717219 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-16 00:17:52.946157 | instance | changed 2026-04-16 00:17:52.951093 | 2026-04-16 00:17:52.951162 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-16 00:17:53.161499 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:53.161630 | instance | 2026-04-16 00:17:53.166808 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:53.168264 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:53.169270 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:53.171022 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:53.171804 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:53.173208 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:53.174671 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:53.175872 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:53.175907 | instance | environment: line 1: kubectl: command not found 2026-04-16 00:17:53.177012 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-16 00:17:53.484812 | instance | ok: Runtime: 0:00:00.023797 2026-04-16 00:17:53.491442 | 2026-04-16 00:17:53.491536 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-16 00:17:53.700299 | instance | changed 2026-04-16 00:17:53.706297 | 2026-04-16 00:17:53.706377 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-16 00:17:53.930817 | instance | environment: line 5: kubectl: command not found 2026-04-16 00:17:53.931622 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:53.931780 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:53.932539 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-16 00:17:54.245215 | instance | ok: Runtime: 0:00:00.010721 2026-04-16 00:17:54.250440 | 2026-04-16 00:17:54.250548 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-16 00:17:54.741141 | instance | changed: 2026-04-16 00:17:54.741345 | instance | cd+++++++++ objects/ 2026-04-16 00:17:54.741384 | instance | cd+++++++++ objects/cluster/ 2026-04-16 00:17:54.741414 | instance | cd+++++++++ objects/namespaced/ 2026-04-16 00:17:54.753388 | 2026-04-16 00:17:54.753449 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-16 00:17:54.969236 | instance | changed 2026-04-16 00:17:54.975824 | 2026-04-16 00:17:54.975893 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-16 00:17:55.183821 | instance | changed 2026-04-16 00:17:55.189171 | 2026-04-16 00:17:55.189244 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-16 00:17:55.388998 | instance | environment: line 3: kubectl: command not found 2026-04-16 00:17:55.726624 | instance | ok: Runtime: 0:00:00.008229 2026-04-16 00:17:55.732903 | 2026-04-16 00:17:55.732985 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-16 00:17:56.200624 | instance | changed: 2026-04-16 00:17:56.201318 | instance | cd+++++++++ pod-logs/ 2026-04-16 00:17:56.201365 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-16 00:17:56.213237 | 2026-04-16 00:17:56.213304 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-16 00:17:56.409621 | instance | changed 2026-04-16 00:17:56.414343 | 2026-04-16 00:17:56.414410 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-16 00:17:56.611998 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-16 00:17:56.950460 | instance | ok: Runtime: 0:00:00.033184 2026-04-16 00:17:56.957432 | 2026-04-16 00:17:56.957529 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-16 00:17:57.186788 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-16 00:17:57.217955 | instance | ceph-mgr endpoints: 2026-04-16 00:17:57.502283 | instance | ok: Runtime: 0:00:00.037278 2026-04-16 00:17:57.509025 | 2026-04-16 00:17:57.509121 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-16 00:17:57.717570 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-16 00:17:58.048031 | instance | ok: Runtime: 0:00:00.033470 2026-04-16 00:17:58.054067 | 2026-04-16 00:17:58.054149 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-16 00:17:58.563406 | instance | changed: cd+++++++++ prometheus/ 2026-04-16 00:17:58.583585 | 2026-04-16 00:17:58.583677 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-16 00:17:58.825063 | instance | changed 2026-04-16 00:17:58.830116 | 2026-04-16 00:17:58.830181 | TASK [gather-selenium-data : Get selenium data] 2026-04-16 00:17:59.031441 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-16 00:17:59.032163 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-16 00:17:59.366044 | instance | ERROR 2026-04-16 00:17:59.366266 | instance | { 2026-04-16 00:17:59.366312 | instance | "delta": "0:00:00.003658", 2026-04-16 00:17:59.366343 | instance | "end": "2026-04-16 00:17:59.032335", 2026-04-16 00:17:59.366370 | instance | "msg": "non-zero return code", 2026-04-16 00:17:59.366396 | instance | "rc": 1, 2026-04-16 00:17:59.366422 | instance | "start": "2026-04-16 00:17:59.028677" 2026-04-16 00:17:59.366447 | instance | } 2026-04-16 00:17:59.366479 | instance | ERROR: Ignoring Errors 2026-04-16 00:17:59.373241 | 2026-04-16 00:17:59.373309 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-16 00:17:59.861021 | instance | changed: cd+++++++++ selenium/ 2026-04-16 00:17:59.866917 | 2026-04-16 00:17:59.866966 | PLAY RECAP 2026-04-16 00:17:59.867009 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-16 00:17:59.867031 | 2026-04-16 00:17:59.986877 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-16 00:18:00.000116 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-16 00:18:00.601940 | 2026-04-16 00:18:00.602071 | PLAY [all] 2026-04-16 00:18:00.613403 | 2026-04-16 00:18:00.613481 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-16 00:18:00.659493 | instance | skipping: Conditional result was False 2026-04-16 00:18:00.671137 | 2026-04-16 00:18:00.671218 | TASK [fetch-output : Set log path for single node] 2026-04-16 00:18:00.716246 | instance | ok 2026-04-16 00:18:00.721884 | 2026-04-16 00:18:00.721954 | LOOP [fetch-output : Ensure local output dirs] 2026-04-16 00:18:01.129871 | instance -> localhost | ok: "/var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/logs" 2026-04-16 00:18:01.332061 | instance -> localhost | changed: "/var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/artifacts" 2026-04-16 00:18:01.555873 | instance -> localhost | changed: "/var/lib/zuul/builds/3f91c0408f46437981d2e71b8da0bdd4/work/docs" 2026-04-16 00:18:01.578259 | 2026-04-16 00:18:01.578405 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-16 00:18:02.190776 | instance | changed: .d..t...... ./ 2026-04-16 00:18:02.191027 | instance | changed: All items complete 2026-04-16 00:18:02.191060 | 2026-04-16 00:18:02.638949 | instance | changed: .d..t...... ./ 2026-04-16 00:18:03.071639 | instance | changed: .d..t...... ./ 2026-04-16 00:18:03.090614 | 2026-04-16 00:18:03.090750 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-16 00:18:03.545024 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007851 2026-04-16 00:18:03.766076 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006365 2026-04-16 00:18:03.785589 | 2026-04-16 00:18:03.785712 | PLAY [all] 2026-04-16 00:18:03.791597 | 2026-04-16 00:18:03.791668 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-16 00:18:04.197788 | instance | changed 2026-04-16 00:18:04.203432 | 2026-04-16 00:18:04.203484 | PLAY RECAP 2026-04-16 00:18:04.203530 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-16 00:18:04.203552 | 2026-04-16 00:18:04.316251 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-16 00:18:04.328704 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-16 00:18:04.950596 | 2026-04-16 00:18:04.950742 | PLAY [localhost] 2026-04-16 00:18:04.961110 | 2026-04-16 00:18:04.961182 | TASK [Generate Zuul manifest] 2026-04-16 00:18:04.979775 | localhost | ok 2026-04-16 00:18:04.997491 | 2026-04-16 00:18:04.997566 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-16 00:18:05.383736 | localhost | changed 2026-04-16 00:18:05.395587 | 2026-04-16 00:18:05.395663 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-16 00:18:05.427290 | localhost | ok 2026-04-16 00:18:05.435941 | 2026-04-16 00:18:05.436059 | TASK [Upload logs] 2026-04-16 00:18:05.459474 | localhost | ok 2026-04-16 00:18:05.574064 | 2026-04-16 00:18:05.574209 | TASK [Set zuul-log-path fact] 2026-04-16 00:18:05.594914 | localhost | ok 2026-04-16 00:18:05.607729 | 2026-04-16 00:18:05.607810 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-16 00:18:05.651022 | localhost | ok 2026-04-16 00:18:05.660340 | 2026-04-16 00:18:05.660422 | TASK [upload-logs : Create log directories] 2026-04-16 00:18:06.028707 | localhost | changed 2026-04-16 00:18:06.035239 | 2026-04-16 00:18:06.035327 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-16 00:18:06.400098 | localhost -> localhost | ok: Runtime: 0:00:00.006128 2026-04-16 00:18:06.407019 | 2026-04-16 00:18:06.407113 | TASK [upload-logs : Upload logs to log server] 2026-04-16 00:18:06.903381 | localhost | Output suppressed because no_log was given 2026-04-16 00:18:06.908463 | 2026-04-16 00:18:06.908561 | LOOP [upload-logs : Compress console log and json output] 2026-04-16 00:18:06.951641 | localhost | skipping: Conditional result was False 2026-04-16 00:18:06.958747 | localhost | skipping: Conditional result was False 2026-04-16 00:18:06.969981 | 2026-04-16 00:18:06.970126 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-16 00:18:07.007238 | localhost | skipping: Conditional result was False 2026-04-16 00:18:07.007658 | 2026-04-16 00:18:07.010917 | localhost | skipping: Conditional result was False 2026-04-16 00:18:07.020258 | 2026-04-16 00:18:07.020380 | LOOP [upload-logs : Upload console log and json output]