2026-05-11 07:09:19.322125 | Job console starting
2026-05-11 07:09:19.347605 | Updating git repos
2026-05-11 07:09:19.477668 | Cloning repos into workspace
2026-05-11 07:09:19.668184 | Restoring repo states
2026-05-11 07:09:19.690165 | Merging changes
2026-05-11 07:09:21.006198 | Checking out repos
2026-05-11 07:09:21.202257 | Preparing playbooks
2026-05-11 07:09:24.090649 | Running Ansible setup
2026-05-11 07:09:27.865322 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-11 07:09:28.487488 | 
2026-05-11 07:09:28.529930 | PLAY [localhost]
2026-05-11 07:09:28.541370 | 
2026-05-11 07:09:28.541499 | TASK [Gathering Facts]
2026-05-11 07:09:29.584675 | localhost | ok
2026-05-11 07:09:29.594840 | 
2026-05-11 07:09:29.595006 | TASK [Setup log path fact]
2026-05-11 07:09:29.613735 | localhost | ok
2026-05-11 07:09:29.627279 | 
2026-05-11 07:09:29.627450 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-11 07:09:29.657766 | localhost | ok
2026-05-11 07:09:29.666734 | 
2026-05-11 07:09:29.666860 | TASK [emit-job-header : Print job information]
2026-05-11 07:09:29.705301 | # Job Information
2026-05-11 07:09:29.705498 | Ansible Version: 2.16.18
2026-05-11 07:09:29.705542 | Job: atmosphere-go-test
2026-05-11 07:09:29.705573 | Pipeline: check
2026-05-11 07:09:29.705601 | Executor: 2d72f0692154
2026-05-11 07:09:29.705628 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3915
2026-05-11 07:09:29.705661 | Event ID: 3d110a00-4d08-11f1-8267-555a5996a5b4
2026-05-11 07:09:29.709502 | 
2026-05-11 07:09:29.709593 | LOOP [emit-job-header : Print node information]
2026-05-11 07:09:29.810789 | localhost | ok:
2026-05-11 07:09:29.811031 | localhost | # Node Information
2026-05-11 07:09:29.811093 | localhost | Inventory Hostname: instance
2026-05-11 07:09:29.811144 | localhost | Hostname: np0000173487
2026-05-11 07:09:29.811189 | localhost | Username: zuul
2026-05-11 07:09:29.811242 | localhost | Distro: Ubuntu 22.04
2026-05-11 07:09:29.811287 | localhost | Provider: yul1
2026-05-11 07:09:29.811329 | localhost | Region: ca-ymq-1
2026-05-11 07:09:29.811372 | localhost | Label: ubuntu-jammy
2026-05-11 07:09:29.811413 | localhost | Product Name: OpenStack Nova
2026-05-11 07:09:29.811454 | localhost | Interface IP: 199.204.45.235
2026-05-11 07:09:29.829382 | 
2026-05-11 07:09:29.829566 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-11 07:09:30.234540 | localhost -> localhost | changed
2026-05-11 07:09:30.243712 | 
2026-05-11 07:09:30.243801 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-11 07:09:31.164631 | localhost -> localhost | changed
2026-05-11 07:09:31.175804 | 
2026-05-11 07:09:31.175949 | PLAY [all]
2026-05-11 07:09:31.185026 | 
2026-05-11 07:09:31.185152 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-11 07:09:31.422561 | instance -> localhost | ok
2026-05-11 07:09:31.430416 | 
2026-05-11 07:09:31.430572 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-11 07:09:31.462870 | instance | ok
2026-05-11 07:09:31.479270 | instance | included: /var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-11 07:09:31.486811 | 
2026-05-11 07:09:31.486948 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-11 07:09:32.558538 | instance -> localhost | Generating public/private rsa key pair.
2026-05-11 07:09:32.558851 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/work/b1f104cf41d14a00bfa2c63ae9c601c1_id_rsa
2026-05-11 07:09:32.558896 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/work/b1f104cf41d14a00bfa2c63ae9c601c1_id_rsa.pub
2026-05-11 07:09:32.558930 | instance -> localhost | The key fingerprint is:
2026-05-11 07:09:32.558963 | instance -> localhost | SHA256:24PM2KPhOGEq2mfCQIzQXUkHccvlwUJn6ctjeWQvsrc zuul-build-sshkey
2026-05-11 07:09:32.559016 | instance -> localhost | The key's randomart image is:
2026-05-11 07:09:32.559049 | instance -> localhost | +---[RSA 3072]----+
2026-05-11 07:09:32.559091 | instance -> localhost | | . . o==+.=.     |
2026-05-11 07:09:32.559124 | instance -> localhost | |. . . .+.*o.     |
2026-05-11 07:09:32.559153 | instance -> localhost | |+       oo.      |
2026-05-11 07:09:32.559183 | instance -> localhost | |.o        . o    |
2026-05-11 07:09:32.559212 | instance -> localhost | |.       S. = .   |
2026-05-11 07:09:32.559248 | instance -> localhost | |.   o  = +B o .  |
2026-05-11 07:09:32.559292 | instance -> localhost | | o o .o B.o= .   |
2026-05-11 07:09:32.559326 | instance -> localhost | |..+ +o o ....    |
2026-05-11 07:09:32.559367 | instance -> localhost | |o..+..o    .E.   |
2026-05-11 07:09:32.559409 | instance -> localhost | +----[SHA256]-----+
2026-05-11 07:09:32.559528 | instance -> localhost | ok: Runtime: 0:00:00.597212
2026-05-11 07:09:32.566830 | 
2026-05-11 07:09:32.566981 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-11 07:09:32.599956 | instance | ok
2026-05-11 07:09:32.610544 | instance | included: /var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-11 07:09:32.619567 | 
2026-05-11 07:09:32.619708 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-11 07:09:32.644177 | instance | skipping: Conditional result was False
2026-05-11 07:09:32.655452 | 
2026-05-11 07:09:32.655641 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-11 07:09:33.111794 | instance | changed
2026-05-11 07:09:33.116633 | 
2026-05-11 07:09:33.116691 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-11 07:09:33.310711 | instance | ok
2026-05-11 07:09:33.315823 | 
2026-05-11 07:09:33.315913 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-11 07:09:33.754163 | instance | changed
2026-05-11 07:09:33.763262 | 
2026-05-11 07:09:33.763391 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-11 07:09:34.202318 | instance | changed
2026-05-11 07:09:34.210967 | 
2026-05-11 07:09:34.211169 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-11 07:09:34.236668 | instance | skipping: Conditional result was False
2026-05-11 07:09:34.249204 | 
2026-05-11 07:09:34.249333 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-11 07:09:34.653461 | instance -> localhost | changed
2026-05-11 07:09:34.668658 | 
2026-05-11 07:09:34.668810 | TASK [add-build-sshkey : Add back temp key]
2026-05-11 07:09:35.009953 | instance -> localhost | Identity added: /var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/work/b1f104cf41d14a00bfa2c63ae9c601c1_id_rsa (zuul-build-sshkey)
2026-05-11 07:09:35.010275 | instance -> localhost | ok: Runtime: 0:00:00.014272
2026-05-11 07:09:35.016042 | 
2026-05-11 07:09:35.016113 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-11 07:09:35.340356 | instance | ok
2026-05-11 07:09:35.345747 | 
2026-05-11 07:09:35.345813 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-11 07:09:35.370676 | instance | skipping: Conditional result was False
2026-05-11 07:09:35.387517 | 
2026-05-11 07:09:35.387606 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-11 07:09:35.748315 | instance | ok
2026-05-11 07:09:35.754871 | 
2026-05-11 07:09:35.754990 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-11 07:09:37.512533 | instance | Output suppressed because no_log was given
2026-05-11 07:09:37.523454 | 
2026-05-11 07:09:37.523644 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-11 07:09:37.726711 | instance | ok: "logs"
2026-05-11 07:09:37.726963 | instance | ok: All items complete
2026-05-11 07:09:37.727002 | 
2026-05-11 07:09:37.873948 | instance | ok: "artifacts"
2026-05-11 07:09:38.030190 | instance | ok: "docs"
2026-05-11 07:09:38.045814 | 
2026-05-11 07:09:38.045985 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-11 07:09:38.235469 | instance | changed: "logs"
2026-05-11 07:09:38.407354 | instance | changed: "artifacts"
2026-05-11 07:09:38.573110 | instance | changed: "docs"
2026-05-11 07:09:38.589800 | 
2026-05-11 07:09:38.589934 | PLAY RECAP
2026-05-11 07:09:38.590003 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-11 07:09:38.590046 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-11 07:09:38.590079 | 
2026-05-11 07:09:38.731617 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-11 07:09:38.733948 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/go-test/run.yml@main]
2026-05-11 07:09:39.391760 | 
2026-05-11 07:09:39.391895 | PLAY [Install Go runtime on test host]
2026-05-11 07:09:39.404199 | 
2026-05-11 07:09:39.404292 | TASK [ensure-go : Check installed go version]
2026-05-11 07:09:39.942257 | instance | ok: ERROR (ignored)
2026-05-11 07:09:39.942685 | instance | {
2026-05-11 07:09:39.942774 | instance |   "failed_when_result": false,
2026-05-11 07:09:39.942840 | instance |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-05-11 07:09:39.942945 | instance |   "rc": 2
2026-05-11 07:09:39.943020 | instance | }
2026-05-11 07:09:39.950022 | 
2026-05-11 07:09:39.950095 | TASK [ensure-go : Skip if correct version of go is installed]
2026-05-11 07:09:40.003846 | instance | ok
2026-05-11 07:09:40.014000 | instance | included: /var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml
2026-05-11 07:09:40.019014 | 
2026-05-11 07:09:40.019107 | TASK [ensure-go : Create temp directory]
2026-05-11 07:09:40.375596 | instance | changed
2026-05-11 07:09:40.400231 | 
2026-05-11 07:09:40.400431 | TASK [ensure-go : Get archive checksum]
2026-05-11 07:09:41.361964 | instance | ok: OK (64 bytes)
2026-05-11 07:09:41.369393 | 
2026-05-11 07:09:41.369497 | TASK [ensure-go : Download go archive]
2026-05-11 07:09:42.895291 | instance | changed: OK (78559214 bytes)
2026-05-11 07:09:42.901796 | 
2026-05-11 07:09:42.901864 | TASK [ensure-go : Install go]
2026-05-11 07:09:48.863346 | instance | changed
2026-05-11 07:09:48.871217 | 
2026-05-11 07:09:48.871320 | PLAY [Run Atmosphere Go unit tests]
2026-05-11 07:09:48.877301 | 
2026-05-11 07:09:48.877396 | TASK [Run Go unit tests]
2026-05-11 07:09:48.983315 | instance | go: downloading github.com/containers/image/v5 v5.35.0
2026-05-11 07:09:48.983427 | instance | go: downloading github.com/goccy/go-yaml v1.18.0
2026-05-11 07:09:48.983736 | instance | go: downloading github.com/opencontainers/go-digest v1.0.0
2026-05-11 07:09:48.983861 | instance | go: downloading github.com/sirupsen/logrus v1.9.3
2026-05-11 07:09:49.182525 | instance | go: downloading golang.org/x/sync v0.18.0
2026-05-11 07:09:49.205848 | instance | go: downloading github.com/stretchr/testify v1.10.0
2026-05-11 07:09:49.218192 | instance | go: downloading gopkg.in/yaml.v2 v2.4.0
2026-05-11 07:09:49.262139 | instance | go: downloading helm.sh/helm/v3 v3.18.5
2026-05-11 07:09:49.385027 | instance | go: downloading k8s.io/api v0.34.0
2026-05-11 07:09:49.385145 | instance | go: downloading k8s.io/apimachinery v0.34.0
2026-05-11 07:09:49.385884 | instance | go: downloading k8s.io/cli-runtime v0.34.0
2026-05-11 07:09:49.452158 | instance | go: downloading k8s.io/client-go v0.34.0
2026-05-11 07:09:49.568650 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-05-11 07:09:49.602965 | instance | go: downloading golang.org/x/sys v0.38.0
2026-05-11 07:09:49.660256 | instance | go: downloading github.com/davecgh/go-spew v1.1.2-0.20180830191138-d8f796af33cc
2026-05-11 07:09:49.667342 | instance | go: downloading github.com/pmezard/go-difflib v1.0.1-0.20181226105442-5d4384ee4fb2
2026-05-11 07:09:49.699327 | instance | go: downloading github.com/containers/storage v1.58.0
2026-05-11 07:09:49.862133 | instance | go: downloading github.com/docker/distribution v2.8.3+incompatible
2026-05-11 07:09:49.909890 | instance | go: downloading github.com/docker/go-connections v0.5.0
2026-05-11 07:09:49.940360 | instance | go: downloading github.com/opencontainers/image-spec v1.1.1
2026-05-11 07:09:49.980779 | instance | go: downloading gopkg.in/yaml.v3 v3.0.1
2026-05-11 07:09:49.989278 | instance | go: downloading github.com/containers/libtrust v0.0.0-20230121012942-c1716e8a8d01
2026-05-11 07:09:49.989367 | instance | go: downloading github.com/containers/ocicrypt v1.2.1
2026-05-11 07:09:50.021836 | instance | go: downloading github.com/google/uuid v1.6.0
2026-05-11 07:09:50.022285 | instance | go: downloading github.com/docker/docker v28.3.3+incompatible
2026-05-11 07:09:50.068282 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-05-11 07:09:50.072521 | instance | go: downloading gopkg.in/evanphx/json-patch.v4 v4.12.0
2026-05-11 07:09:50.224973 | instance | go: downloading k8s.io/utils v0.0.0-20250604170112-4c0f3b243397
2026-05-11 07:09:50.225251 | instance | go: downloading github.com/pkg/errors v0.9.1
2026-05-11 07:09:50.225382 | instance | go: downloading github.com/Masterminds/semver/v3 v3.3.1
2026-05-11 07:09:50.225402 | instance | go: downloading sigs.k8s.io/yaml v1.6.0
2026-05-11 07:09:50.225676 | instance | go: downloading github.com/cyphar/filepath-securejoin v0.4.1
2026-05-11 07:09:50.225946 | instance | go: downloading github.com/mitchellh/copystructure v1.2.0
2026-05-11 07:09:50.226768 | instance | go: downloading github.com/santhosh-tekuri/jsonschema/v6 v6.0.2
2026-05-11 07:09:50.253164 | instance | go: downloading k8s.io/apiextensions-apiserver v0.34.0
2026-05-11 07:09:50.267070 | instance | go: downloading github.com/gogo/protobuf v1.3.2
2026-05-11 07:09:50.271698 | instance | go: downloading sigs.k8s.io/randfill v1.0.0
2026-05-11 07:09:50.302940 | instance | go: downloading github.com/docker/docker-credential-helpers v0.9.3
2026-05-11 07:09:50.317923 | instance | go: downloading github.com/BurntSushi/toml v1.5.0
2026-05-11 07:09:50.337448 | instance | go: downloading github.com/distribution/reference v0.6.0
2026-05-11 07:09:50.338251 | instance | go: downloading github.com/gorilla/mux v1.8.1
2026-05-11 07:09:50.374608 | instance | go: downloading k8s.io/klog/v2 v2.130.1
2026-05-11 07:09:50.383953 | instance | go: downloading sigs.k8s.io/structured-merge-diff/v6 v6.3.0
2026-05-11 07:09:50.420495 | instance | go: downloading sigs.k8s.io/json v0.0.0-20250730193827-2d320260d730
2026-05-11 07:09:50.430745 | instance | go: downloading github.com/liggitt/tabwriter v0.0.0-20181228230101-89fcab3d43de
2026-05-11 07:09:50.450692 | instance | go: downloading github.com/moby/term v0.5.2
2026-05-11 07:09:50.450854 | instance | go: downloading github.com/google/gnostic-models v0.7.0
2026-05-11 07:09:50.452063 | instance | go: downloading go.yaml.in/yaml/v2 v2.4.2
2026-05-11 07:09:50.453862 | instance | go: downloading golang.org/x/text v0.31.0
2026-05-11 07:09:50.513398 | instance | go: downloading k8s.io/kube-openapi v0.0.0-20250910181357-589584f1c912
2026-05-11 07:09:50.526493 | instance | go: downloading sigs.k8s.io/kustomize/api v0.20.1
2026-05-11 07:09:50.640065 | instance | go: downloading sigs.k8s.io/kustomize/kyaml v0.20.1
2026-05-11 07:09:50.642790 | instance | go: downloading github.com/gorilla/websocket v1.5.4-0.20250319132907-e064f32e3674
2026-05-11 07:09:50.683050 | instance | go: downloading golang.org/x/term v0.37.0
2026-05-11 07:09:50.695890 | instance | go: downloading google.golang.org/protobuf v1.36.6
2026-05-11 07:09:50.706079 | instance | go: downloading github.com/munnerz/goautoneg v0.0.0-20191010083416-a7dc8b61c822
2026-05-11 07:09:50.751592 | instance | go: downloading golang.org/x/net v0.47.0
2026-05-11 07:09:50.823503 | instance | go: downloading github.com/gregjones/httpcache v0.0.0-20190611155906-901d90724c79
2026-05-11 07:09:50.849931 | instance | go: downloading github.com/peterbourgon/diskv v2.0.1+incompatible
2026-05-11 07:09:50.854929 | instance | go: downloading github.com/mitchellh/reflectwalk v1.0.2
2026-05-11 07:09:50.869487 | instance | go: downloading gopkg.in/inf.v0 v0.9.1
2026-05-11 07:09:50.904575 | instance | go: downloading github.com/moby/sys/capability v0.4.0
2026-05-11 07:09:50.928722 | instance | go: downloading github.com/opencontainers/runtime-spec v1.2.1
2026-05-11 07:09:50.965027 | instance | go: downloading github.com/go-logr/logr v1.4.3
2026-05-11 07:09:50.968725 | instance | go: downloading go.yaml.in/yaml/v3 v3.0.4
2026-05-11 07:09:50.999906 | instance | go: downloading github.com/json-iterator/go v1.1.12
2026-05-11 07:09:51.018482 | instance | go: downloading golang.org/x/time v0.12.0
2026-05-11 07:09:51.019085 | instance | go: downloading github.com/moby/spdystream v0.5.0
2026-05-11 07:09:51.045613 | instance | go: downloading github.com/fxamacker/cbor/v2 v2.9.0
2026-05-11 07:09:51.046664 | instance | go: downloading golang.org/x/oauth2 v0.30.0
2026-05-11 07:09:51.051263 | instance | go: downloading github.com/go-openapi/swag v0.23.1
2026-05-11 07:09:51.059090 | instance | go: downloading github.com/go-openapi/jsonreference v0.21.0
2026-05-11 07:09:51.084067 | instance | go: downloading github.com/google/btree v1.1.3
2026-05-11 07:09:51.088269 | instance | go: downloading github.com/docker/go-units v0.5.0
2026-05-11 07:09:51.090448 | instance | go: downloading github.com/moby/sys/user v0.4.0
2026-05-11 07:09:51.097633 | instance | go: downloading github.com/blang/semver/v4 v4.0.0
2026-05-11 07:09:51.107792 | instance | go: downloading github.com/go-errors/errors v1.5.1
2026-05-11 07:09:51.110169 | instance | go: downloading github.com/mxk/go-flowrate v0.0.0-20140419014527-cca7078d478f
2026-05-11 07:09:51.113808 | instance | go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
2026-05-11 07:09:51.121209 | instance | go: downloading github.com/modern-go/reflect2 v1.0.3-0.20250322232337-35a7c28c31ee
2026-05-11 07:09:51.133771 | instance | go: downloading github.com/go-openapi/jsonpointer v0.21.1
2026-05-11 07:09:51.134615 | instance | go: downloading github.com/mailru/easyjson v0.9.0
2026-05-11 07:09:51.149900 | instance | go: downloading github.com/moby/sys/mountinfo v0.7.2
2026-05-11 07:09:51.157702 | instance | go: downloading github.com/x448/float16 v0.8.4
2026-05-11 07:09:51.171478 | instance | go: downloading github.com/emicklei/go-restful/v3 v3.12.2
2026-05-11 07:09:51.172068 | instance | go: downloading github.com/monochromegane/go-gitignore v0.0.0-20200626010858-205db1a8cc00
2026-05-11 07:09:51.176501 | instance | go: downloading github.com/xlab/treeprint v1.2.0
2026-05-11 07:09:51.211121 | instance | go: downloading github.com/josharian/intern v1.0.0
2026-05-11 07:09:59.040277 | instance | ok  	github.com/vexxhost/atmosphere/pkg/dag	0.356s
2026-05-11 07:09:59.040332 | instance | --- FAIL: TestDeployMultipleTags_KeystoneAlone (0.00s)
2026-05-11 07:09:59.040337 | instance |     orchestrator_subgraph_pregate_test.go:68: Deploy returned error: starting ansible-playbook: exec: "ansible-playbook": executable file not found in $PATH
2026-05-11 07:09:59.040342 | instance | FAIL
2026-05-11 07:09:59.040347 | instance | FAIL	github.com/vexxhost/atmosphere/internal/deploy	0.270s
2026-05-11 07:10:17.965544 | instance | ?   	github.com/vexxhost/atmosphere/internal/openstack_helm	[no test files]
2026-05-11 07:10:23.565576 | instance | ?   	github.com/vexxhost/atmosphere/internal/portforwardutil	[no test files]
2026-05-11 07:10:23.565838 | instance | ?   	github.com/vexxhost/atmosphere/internal/testutils	[no test files]
2026-05-11 07:10:23.565987 | instance | ?   	github.com/vexxhost/atmosphere/cmd/atmosphere	[no test files]
2026-05-11 07:10:24.217160 | instance | ok  	github.com/vexxhost/atmosphere/cmd/pinimages	0.006s
2026-05-11 07:10:24.217222 | instance | FAIL
2026-05-11 07:10:24.834554 | instance | ERROR
2026-05-11 07:10:24.834823 | instance | {
2026-05-11 07:10:24.834853 | instance |   "delta": "0:00:35.485264",
2026-05-11 07:10:24.834874 | instance |   "end": "2026-05-11 07:10:24.444142",
2026-05-11 07:10:24.834919 | instance |   "msg": "non-zero return code",
2026-05-11 07:10:24.834938 | instance |   "rc": 1,
2026-05-11 07:10:24.834955 | instance |   "start": "2026-05-11 07:09:48.958878"
2026-05-11 07:10:24.834972 | instance | }
failure
2026-05-11 07:10:24.837226 | 
2026-05-11 07:10:24.837276 | PLAY RECAP
2026-05-11 07:10:24.837323 | instance | ok: 6 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-05-11 07:10:24.837344 | 
2026-05-11 07:10:24.990813 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/go-test/run.yml@main]
2026-05-11 07:10:24.993919 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-11 07:10:25.653565 | 
2026-05-11 07:10:25.653739 | PLAY [all]
2026-05-11 07:10:25.666084 | 
2026-05-11 07:10:25.666237 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-11 07:10:25.712354 | instance | skipping: Conditional result was False
2026-05-11 07:10:25.721616 | 
2026-05-11 07:10:25.721768 | TASK [fetch-output : Set log path for single node]
2026-05-11 07:10:25.765824 | instance | ok
2026-05-11 07:10:25.772256 | 
2026-05-11 07:10:25.772370 | LOOP [fetch-output : Ensure local output dirs]
2026-05-11 07:10:26.179032 | instance -> localhost | ok: "/var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/work/logs"
2026-05-11 07:10:26.406068 | instance -> localhost | changed: "/var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/work/artifacts"
2026-05-11 07:10:26.631259 | instance -> localhost | changed: "/var/lib/zuul/builds/b1f104cf41d14a00bfa2c63ae9c601c1/work/docs"
2026-05-11 07:10:26.646758 | 
2026-05-11 07:10:26.646886 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-11 07:10:27.300356 | instance | ok
2026-05-11 07:10:27.300620 | instance | changed: All items complete
2026-05-11 07:10:27.300663 | 
2026-05-11 07:10:27.753760 | instance | changed: .d..t...... ./
2026-05-11 07:10:28.211655 | instance | changed: .d..t...... ./
2026-05-11 07:10:28.231246 | 
2026-05-11 07:10:28.231399 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-11 07:10:28.675330 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.005893
2026-05-11 07:10:28.898178 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007614
2026-05-11 07:10:28.911338 | 
2026-05-11 07:10:28.911482 | PLAY [all]
2026-05-11 07:10:28.920592 | 
2026-05-11 07:10:28.920717 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-11 07:10:29.342994 | instance | changed
2026-05-11 07:10:29.351772 | 
2026-05-11 07:10:29.351840 | PLAY RECAP
2026-05-11 07:10:29.351886 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-11 07:10:29.351909 | 
2026-05-11 07:10:29.534887 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-11 07:10:29.537466 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-11 07:10:30.172744 | 
2026-05-11 07:10:30.172950 | PLAY [localhost]
2026-05-11 07:10:30.185513 | 
2026-05-11 07:10:30.185663 | TASK [Generate Zuul manifest]
2026-05-11 07:10:30.206278 | localhost | ok
2026-05-11 07:10:30.228157 | 
2026-05-11 07:10:30.228344 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-11 07:10:30.611799 | localhost | changed
2026-05-11 07:10:30.624746 | 
2026-05-11 07:10:30.624851 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-11 07:10:30.658039 | localhost | ok
2026-05-11 07:10:30.667306 | 
2026-05-11 07:10:30.667395 | TASK [Upload logs]
2026-05-11 07:10:30.686540 | localhost | ok
2026-05-11 07:10:30.744797 | 
2026-05-11 07:10:30.744930 | TASK [Set zuul-log-path fact]
2026-05-11 07:10:30.765692 | localhost | ok
2026-05-11 07:10:30.781338 | 
2026-05-11 07:10:30.781509 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-11 07:10:30.813599 | localhost | ok
2026-05-11 07:10:30.823358 | 
2026-05-11 07:10:30.823574 | TASK [upload-logs : Create log directories]
2026-05-11 07:10:31.282800 | localhost | changed
2026-05-11 07:10:31.291237 | 
2026-05-11 07:10:31.291346 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-11 07:10:31.709370 | localhost -> localhost | ok: Runtime: 0:00:00.003437
2026-05-11 07:10:31.716236 | 
2026-05-11 07:10:31.716374 | TASK [upload-logs : Upload logs to log server]
2026-05-11 07:10:32.256919 | localhost | Output suppressed because no_log was given
2026-05-11 07:10:32.262070 | 
2026-05-11 07:10:32.262135 | LOOP [upload-logs : Compress console log and json output]
2026-05-11 07:10:32.309708 | localhost | skipping: Conditional result was False
2026-05-11 07:10:32.317503 | localhost | skipping: Conditional result was False
2026-05-11 07:10:32.326496 | 
2026-05-11 07:10:32.326628 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-11 07:10:32.370098 | localhost | skipping: Conditional result was False
2026-05-11 07:10:32.370536 | 
2026-05-11 07:10:32.374926 | localhost | skipping: Conditional result was False
2026-05-11 07:10:32.391496 | 
2026-05-11 07:10:32.391705 | LOOP [upload-logs : Upload console log and json output]