2026-06-07 00:02:11.140904 | Job console starting
2026-06-07 00:02:11.268145 | Updating git repos
2026-06-07 00:02:11.641784 | Cloning repos into workspace
2026-06-07 00:02:12.538473 | Restoring repo states
2026-06-07 00:02:12.558438 | Merging changes
2026-06-07 00:02:12.558463 | Checking out repos
2026-06-07 00:02:12.724309 | Preparing playbooks
2026-06-07 00:02:15.711224 | Running Ansible setup
2026-06-07 00:02:19.878230 | PRE-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/base/pre.yaml@main]
2026-06-07 00:02:20.536666 | 
2026-06-07 00:02:20.536947 | PLAY [localhost]
2026-06-07 00:02:20.544038 | 
2026-06-07 00:02:20.544124 | TASK [Gathering Facts]
2026-06-07 00:02:21.592199 | localhost | ok
2026-06-07 00:02:21.607971 | 
2026-06-07 00:02:21.608189 | TASK [Setup log path fact]
2026-06-07 00:02:21.630339 | localhost | ok
2026-06-07 00:02:21.652095 | 
2026-06-07 00:02:21.652244 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-07 00:02:21.680520 | localhost | ok
2026-06-07 00:02:21.687861 | 
2026-06-07 00:02:21.687946 | TASK [emit-job-header : Print job information]
2026-06-07 00:02:21.726441 | # Job Information
2026-06-07 00:02:21.726610 | Ansible Version: 2.16.18
2026-06-07 00:02:21.726649 | Job: sf-operator-go-test
2026-06-07 00:02:21.726676 | Pipeline: periodic
2026-06-07 00:02:21.726701 | Executor: 38.102.83.51
2026-06-07 00:02:21.726725 | Triggered by: https://softwarefactory-project.io/r/plugins/gitiles/software-factory/sf-operator/+/None^!/
2026-06-07 00:02:21.726754 | Log URL (when completed): https://gateway-cloud-softwarefactory.apps.ocp.cloud.ci.centos.org/logs/6db/sf/6db2afd3d45a43e28823a8d2e94f65ff/
2026-06-07 00:02:21.726780 | Event ID: 872662652c0e4dddb4e0687a23167e0c
2026-06-07 00:02:21.730464 | 
2026-06-07 00:02:21.730551 | LOOP [emit-job-header : Print node information]
2026-06-07 00:02:21.814797 | localhost | ok:
2026-06-07 00:02:21.814974 | localhost | # Node Information
2026-06-07 00:02:21.815000 | localhost | Inventory Hostname: controller
2026-06-07 00:02:21.815019 | localhost | Hostname: np0000066201
2026-06-07 00:02:21.815037 | localhost | Username: zuul-worker
2026-06-07 00:02:21.815057 | localhost | Distro: CentOS 9
2026-06-07 00:02:21.815074 | localhost | Provider: vexxhost-nodepool-sf
2026-06-07 00:02:21.815090 | localhost | Region: RegionOne
2026-06-07 00:02:21.815106 | localhost | Label: cloud-centos-9-stream
2026-06-07 00:02:21.815122 | localhost | Product Name: OpenStack Nova
2026-06-07 00:02:21.815137 | localhost | Interface IP: 38.102.83.155
2026-06-07 00:02:21.827586 | 
2026-06-07 00:02:21.827798 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-06-07 00:02:22.294018 | localhost -> localhost | changed
2026-06-07 00:02:22.303071 | 
2026-06-07 00:02:22.303251 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-06-07 00:02:23.318549 | localhost -> localhost | changed
2026-06-07 00:02:23.324293 | 
2026-06-07 00:02:23.324360 | PLAY [all]
2026-06-07 00:02:23.329463 | 
2026-06-07 00:02:23.329537 | TASK [include_role : start-zuul-console]
2026-06-07 00:02:23.356837 | controller | ok
2026-06-07 00:02:23.367000 | 
2026-06-07 00:02:23.367066 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-06-07 00:02:23.796842 | controller | ok
2026-06-07 00:02:23.806572 | 
2026-06-07 00:02:23.806657 | TASK [include_role : validate-host]
2026-06-07 00:02:23.846901 | controller | ok
2026-06-07 00:02:23.887458 | 
2026-06-07 00:02:23.887665 | TASK [validate-host : Define zuul_info_dir fact]
2026-06-07 00:02:23.929004 | controller | ok
2026-06-07 00:02:23.933385 | 
2026-06-07 00:02:23.933481 | TASK [validate-host : Ensure Zuul Ansible directory exists]
2026-06-07 00:02:24.170687 | controller -> localhost | ok
2026-06-07 00:02:24.178444 | 
2026-06-07 00:02:24.178617 | TASK [validate-host : Collect information about the host]
2026-06-07 00:02:24.945097 | controller | ok
2026-06-07 00:02:24.961630 | 
2026-06-07 00:02:24.961850 | TASK [validate-host : Sanitize hostname]
2026-06-07 00:02:25.092785 | controller | ok
2026-06-07 00:02:25.097223 | 
2026-06-07 00:02:25.097304 | TASK [validate-host : Write out all ansible variables/facts known for each host]
2026-06-07 00:02:25.741768 | controller -> localhost | changed
2026-06-07 00:02:25.746089 | 
2026-06-07 00:02:25.746177 | TASK [validate-host : Collect information about zuul worker]
2026-06-07 00:02:26.289568 | controller | ok
2026-06-07 00:02:26.293916 | 
2026-06-07 00:02:26.293999 | TASK [validate-host : Write out all zuul information for each host]
2026-06-07 00:02:26.775823 | controller -> localhost | changed
2026-06-07 00:02:26.782938 | 
2026-06-07 00:02:26.783007 | TASK [include_role : prepare-workspace]
2026-06-07 00:02:26.811337 | controller | ok
2026-06-07 00:02:26.827758 | 
2026-06-07 00:02:26.827828 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-06-07 00:02:27.078512 | controller | ok
2026-06-07 00:02:27.082711 | 
2026-06-07 00:02:27.082776 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-06-07 00:02:28.165341 | controller | Output suppressed because no_log was given
2026-06-07 00:02:28.172895 | 
2026-06-07 00:02:28.172986 | TASK [include_role : add-build-sshkey]
2026-06-07 00:02:28.213921 | controller | ok
2026-06-07 00:02:28.238842 | 
2026-06-07 00:02:28.238982 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-06-07 00:02:28.557187 | controller -> localhost | ok
2026-06-07 00:02:28.561646 | 
2026-06-07 00:02:28.561714 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-06-07 00:02:28.589612 | controller | ok
2026-06-07 00:02:28.602012 | controller | included: /var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-06-07 00:02:28.606750 | 
2026-06-07 00:02:28.606817 | TASK [add-build-sshkey : Create Temp SSH key]
2026-06-07 00:02:29.139410 | controller -> localhost | Generating public/private rsa key pair.
2026-06-07 00:02:29.139610 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/6db2afd3d45a43e28823a8d2e94f65ff_id_rsa
2026-06-07 00:02:29.139639 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/6db2afd3d45a43e28823a8d2e94f65ff_id_rsa.pub
2026-06-07 00:02:29.139660 | controller -> localhost | The key fingerprint is:
2026-06-07 00:02:29.139680 | controller -> localhost | SHA256:lsAMCU+p+qTngijlqwT5we+ambXO1cfYuPM5/QHxT6s zuul-build-sshkey
2026-06-07 00:02:29.139699 | controller -> localhost | The key's randomart image is:
2026-06-07 00:02:29.139718 | controller -> localhost | +---[RSA 3072]----+
2026-06-07 00:02:29.139736 | controller -> localhost | |  ..oo           |
2026-06-07 00:02:29.139756 | controller -> localhost | |   oo+           |
2026-06-07 00:02:29.139774 | controller -> localhost | |   .. +     .    |
2026-06-07 00:02:29.139792 | controller -> localhost | | o.    . .   o   |
2026-06-07 00:02:29.139810 | controller -> localhost | |o.o     S   . . .|
2026-06-07 00:02:29.139828 | controller -> localhost | |o.oo   o =   . o.|
2026-06-07 00:02:29.139846 | controller -> localhost | |oB. o . + +.  ...|
2026-06-07 00:02:29.139864 | controller -> localhost | |B +B o  .o... .. |
2026-06-07 00:02:29.139881 | controller -> localhost | |o=B+=   .oo. E.  |
2026-06-07 00:02:29.139899 | controller -> localhost | +----[SHA256]-----+
2026-06-07 00:02:29.139942 | controller -> localhost | ok: Runtime: 0:00:00.104918
2026-06-07 00:02:29.143450 | 
2026-06-07 00:02:29.143510 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-06-07 00:02:29.177427 | controller | ok
2026-06-07 00:02:29.191392 | controller | included: /var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-06-07 00:02:29.203637 | 
2026-06-07 00:02:29.203771 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-06-07 00:02:29.229441 | controller | skipping: Conditional result was False
2026-06-07 00:02:29.235589 | 
2026-06-07 00:02:29.235692 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-06-07 00:02:29.720548 | controller | changed
2026-06-07 00:02:29.731914 | 
2026-06-07 00:02:29.732065 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-06-07 00:02:29.985655 | controller | ok
2026-06-07 00:02:29.990246 | 
2026-06-07 00:02:29.990388 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-06-07 00:02:30.814464 | controller | changed
2026-06-07 00:02:30.818029 | 
2026-06-07 00:02:30.818124 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-06-07 00:02:31.631950 | controller | changed
2026-06-07 00:02:31.636826 | 
2026-06-07 00:02:31.636910 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-06-07 00:02:31.672653 | controller | skipping: Conditional result was False
2026-06-07 00:02:31.678377 | 
2026-06-07 00:02:31.678470 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-06-07 00:02:32.173320 | controller -> localhost | changed
2026-06-07 00:02:32.186520 | 
2026-06-07 00:02:32.186693 | TASK [add-build-sshkey : Add back temp key]
2026-06-07 00:02:32.469833 | controller -> localhost | Identity added: /var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/6db2afd3d45a43e28823a8d2e94f65ff_id_rsa (zuul-build-sshkey)
2026-06-07 00:02:32.470076 | controller -> localhost | ok: Runtime: 0:00:00.013164
2026-06-07 00:02:32.475150 | 
2026-06-07 00:02:32.475266 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-06-07 00:02:32.893631 | controller | ok
2026-06-07 00:02:32.900681 | 
2026-06-07 00:02:32.900848 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-06-07 00:02:32.937895 | controller | skipping: Conditional result was False
2026-06-07 00:02:32.947841 | 
2026-06-07 00:02:32.947968 | TASK [include_role : prepare-workspace-openshift]
2026-06-07 00:02:32.977624 | controller | skipping: Conditional result was False
2026-06-07 00:02:32.983649 | 
2026-06-07 00:02:32.983843 | TASK [include_role : remove-zuul-sshkey]
2026-06-07 00:02:33.000455 | controller | skipping: Conditional result was False
2026-06-07 00:02:33.007006 | 
2026-06-07 00:02:33.007244 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-06-07 00:02:33.285024 | controller | ok: "logs"
2026-06-07 00:02:33.285469 | controller | ok: All items complete
2026-06-07 00:02:33.285598 | 
2026-06-07 00:02:33.527253 | controller | ok: "artifacts"
2026-06-07 00:02:33.792190 | controller | ok: "docs"
2026-06-07 00:02:33.800694 | 
2026-06-07 00:02:33.800827 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-06-07 00:02:34.041761 | controller | changed: "logs"
2026-06-07 00:02:34.245899 | controller | changed: "artifacts"
2026-06-07 00:02:34.476782 | controller | changed: "docs"
2026-06-07 00:02:34.485994 | 
2026-06-07 00:02:34.486150 | LOOP [Tune dnf options]
2026-06-07 00:02:34.921547 | controller | changed: option added
2026-06-07 00:02:34.921983 | controller | changed: All items complete
2026-06-07 00:02:34.922092 | 
2026-06-07 00:02:35.200713 | controller | changed: option added
2026-06-07 00:02:35.463936 | controller | changed: option added
2026-06-07 00:02:35.480481 | 
2026-06-07 00:02:35.480640 | PLAY RECAP
2026-06-07 00:02:35.480733 | controller | ok: 24 changed: 11 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-07 00:02:35.480789 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-07 00:02:35.480830 | 
2026-06-07 00:02:35.654919 | PRE-RUN END RESULT_NORMAL: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/base/pre.yaml@main]
2026-06-07 00:02:35.656816 | PRE-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/rhel_subscription/register.yaml@main]
2026-06-07 00:02:36.364558 | 
2026-06-07 00:02:36.364792 | PLAY [all]
2026-06-07 00:02:36.374443 | 
2026-06-07 00:02:36.374532 | TASK [Register system]
2026-06-07 00:02:36.437419 | 
2026-06-07 00:02:36.437700 | TASK [Get minor release for EUS activation]
2026-06-07 00:02:36.494271 | controller | skipping: Conditional result was False
2026-06-07 00:02:36.500576 | 
2026-06-07 00:02:36.500740 | LOOP [Manage Extended Update Support repos]
2026-06-07 00:02:36.565327 | controller | skipping: Conditional result was False
2026-06-07 00:02:36.570108 | controller | skipping: Conditional result was False
2026-06-07 00:02:36.589293 | 
2026-06-07 00:02:36.589532 | TASK [Upgrade all packages]
2026-06-07 00:02:36.676722 | controller | skipping: Conditional result was False
2026-06-07 00:02:36.683585 | 
2026-06-07 00:02:36.683685 | TASK [Reboot to use new kernel]
2026-06-07 00:02:36.718917 | controller | skipping: Conditional result was False
2026-06-07 00:02:36.720519 | 
2026-06-07 00:02:36.720576 | PLAY RECAP
2026-06-07 00:02:36.720640 | controller | ok: 0 changed: 0 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0
2026-06-07 00:02:36.720672 | 
2026-06-07 00:02:36.873021 | PRE-RUN END RESULT_NORMAL: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/rhel_subscription/register.yaml@main]
2026-06-07 00:02:36.874473 | PRE-RUN START: [untrusted : softwarefactory-project.io/software-factory/sf-operator/playbooks/install-golang.yaml@master]
2026-06-07 00:02:37.497797 | 
2026-06-07 00:02:37.497939 | PLAY [controller]
2026-06-07 00:02:37.510675 | 
2026-06-07 00:02:37.510834 | TASK [install-golang : Check Go version]
2026-06-07 00:02:38.040034 | controller | ok: ERROR (ignored)
2026-06-07 00:02:38.040364 | controller | {
2026-06-07 00:02:38.040416 | controller |   "failed_when_result": false,
2026-06-07 00:02:38.040451 | controller |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-06-07 00:02:38.040502 | controller |   "rc": 2
2026-06-07 00:02:38.040526 | controller | }
2026-06-07 00:02:38.046344 | 
2026-06-07 00:02:38.046434 | TASK [install-golang : Ensure a clean install]
2026-06-07 00:02:38.517902 | controller | ok
2026-06-07 00:02:38.524633 | 
2026-06-07 00:02:38.524779 | TASK [install-golang : Extract Go archive]
2026-06-07 00:02:53.734342 | controller | changed
2026-06-07 00:02:53.750145 | 
2026-06-07 00:02:53.750407 | LOOP [install-golang : Create symlinks for Go binary]
2026-06-07 00:02:54.055202 | controller | changed: "go"
2026-06-07 00:02:54.297213 | controller | changed: "gofmt"
2026-06-07 00:02:54.310721 | 
2026-06-07 00:02:54.310887 | PLAY RECAP
2026-06-07 00:02:54.310951 | controller | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-07 00:02:54.310981 | 
2026-06-07 00:02:54.526000 | PRE-RUN END RESULT_NORMAL: [untrusted : softwarefactory-project.io/software-factory/sf-operator/playbooks/install-golang.yaml@master]
2026-06-07 00:02:54.528566 | RUN START: [untrusted : softwarefactory-project.io/software-factory/sf-operator/playbooks/run-go-tests.yaml@master]
2026-06-07 00:02:55.187031 | 
2026-06-07 00:02:55.187222 | PLAY [Run Go tests using Makefile]
2026-06-07 00:02:55.200837 | 
2026-06-07 00:02:55.201000 | TASK [Execute 'make test']
2026-06-06 20:02:55.669579 | controller | go: downloading go1.25.11 (linux/amd64)
2026-06-06 20:03:04.903804 | controller | mkdir -p /home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin
2026-06-06 20:03:04.917531 | controller | bash: line 1: /home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin/controller-gen: No such file or directory
2026-06-06 20:03:04.921201 | controller | ( test -f /home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin/controller-gen && [[ "" =~ "v0.18.0" ]]  ) || GOBIN=/home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin go install sigs.k8s.io/controller-tools/cmd/controller-gen@v0.18.0
2026-06-06 20:03:05.241286 | controller | go: downloading sigs.k8s.io/controller-tools v0.18.0
2026-06-06 20:03:08.103434 | controller | go: downloading golang.org/x/tools v0.32.0
2026-06-06 20:03:08.104142 | controller | go: downloading github.com/spf13/cobra v1.9.1
2026-06-06 20:03:08.106773 | controller | go: downloading k8s.io/apimachinery v0.33.0
2026-06-06 20:03:08.107779 | controller | go: downloading k8s.io/code-generator v0.33.0
2026-06-06 20:03:08.111904 | controller | go: downloading k8s.io/gengo/v2 v2.0.0-20250207200755-1244d31929d7
2026-06-06 20:03:09.149570 | controller | go: downloading github.com/gobuffalo/flect v1.0.3
2026-06-06 20:03:09.156604 | controller | go: downloading k8s.io/apiextensions-apiserver v0.33.0
2026-06-06 20:03:09.301495 | controller | go: downloading k8s.io/utils v0.0.0-20241104100929-3ea5e8cea738
2026-06-06 20:03:09.392356 | controller | go: downloading gopkg.in/yaml.v2 v2.4.0
2026-06-06 20:03:09.392802 | controller | go: downloading github.com/fatih/color v1.18.0
2026-06-06 20:03:09.622260 | controller | go: downloading k8s.io/api v0.33.0
2026-06-06 20:03:09.623670 | controller | go: downloading gopkg.in/yaml.v3 v3.0.1
2026-06-06 20:03:09.624077 | controller | go: downloading sigs.k8s.io/yaml v1.4.0
2026-06-06 20:03:09.913654 | controller | go: downloading github.com/spf13/pflag v1.0.6
2026-06-06 20:03:09.915522 | controller | go: downloading k8s.io/klog/v2 v2.130.1
2026-06-06 20:03:09.928800 | controller | go: downloading github.com/gogo/protobuf v1.3.2
2026-06-06 20:03:10.119439 | controller | go: downloading sigs.k8s.io/randfill v1.0.0
2026-06-06 20:03:10.144279 | controller | go: downloading sigs.k8s.io/structured-merge-diff/v4 v4.6.0
2026-06-06 20:03:10.420715 | controller | go: downloading github.com/google/gnostic-models v0.6.9
2026-06-06 20:03:10.439883 | controller | go: downloading k8s.io/kube-openapi v0.0.0-20250318190949-c8a335a9a2ff
2026-06-06 20:03:10.679629 | controller | go: downloading github.com/mattn/go-colorable v0.1.13
2026-06-06 20:03:10.680668 | controller | go: downloading github.com/mattn/go-isatty v0.0.20
2026-06-06 20:03:10.863223 | controller | go: downloading golang.org/x/sync v0.13.0
2026-06-06 20:03:10.885294 | controller | go: downloading gopkg.in/inf.v0 v0.9.1
2026-06-06 20:03:10.885675 | controller | go: downloading sigs.k8s.io/json v0.0.0-20241010143419-9aa6b5e7a4b3
2026-06-06 20:03:11.245271 | controller | go: downloading github.com/go-logr/logr v1.4.2
2026-06-06 20:03:11.264056 | controller | go: downloading github.com/json-iterator/go v1.1.12
2026-06-06 20:03:11.266760 | controller | go: downloading google.golang.org/protobuf v1.36.5
2026-06-06 20:03:11.407211 | controller | go: downloading golang.org/x/mod v0.24.0
2026-06-06 20:03:11.409689 | controller | go: downloading github.com/fxamacker/cbor/v2 v2.7.0
2026-06-06 20:03:11.709236 | controller | go: downloading golang.org/x/net v0.39.0
2026-06-06 20:03:11.741434 | controller | go: downloading golang.org/x/sys v0.32.0
2026-06-06 20:03:11.918860 | controller | go: downloading github.com/go-openapi/jsonreference v0.20.2
2026-06-06 20:03:11.920338 | controller | go: downloading github.com/go-openapi/swag v0.23.0
2026-06-06 20:03:12.731788 | controller | go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
2026-06-06 20:03:12.732038 | controller | go: downloading github.com/modern-go/reflect2 v1.0.2
2026-06-06 20:03:12.746450 | controller | go: downloading github.com/x448/float16 v0.8.4
2026-06-06 20:03:12.746823 | controller | go: downloading github.com/go-openapi/jsonpointer v0.21.0
2026-06-06 20:03:12.747480 | controller | go: downloading github.com/mailru/easyjson v0.7.7
2026-06-06 20:03:12.769045 | controller | go: downloading golang.org/x/text v0.24.0
2026-06-06 20:03:13.371383 | controller | go: downloading github.com/josharian/intern v1.0.0
2026-06-06 20:03:32.009894 | controller | /home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin/controller-gen crd paths="./..." output:crd:artifacts:config=config/crd/bases
2026-06-06 20:03:39.137177 | controller | /home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin/controller-gen object:headerFile="hack/boilerplate.go.txt" paths="./..."
2026-06-06 20:03:40.142478 | controller | go fmt ./...
2026-06-06 20:03:40.333051 | controller | go vet ./...
2026-06-06 20:03:40.375029 | controller | go: downloading github.com/onsi/ginkgo/v2 v2.17.2
2026-06-06 20:03:40.375502 | controller | go: downloading github.com/onsi/gomega v1.33.1
2026-06-06 20:03:40.375517 | controller | go: downloading github.com/google/shlex v0.0.0-20191202100458-e7afc7fbc510
2026-06-06 20:03:40.376036 | controller | go: downloading github.com/operator-framework/api v0.26.0
2026-06-06 20:03:41.774489 | controller | go: downloading github.com/sirupsen/logrus v1.9.3
2026-06-06 20:03:41.774686 | controller | go: downloading github.com/blang/semver/v4 v4.0.0
2026-06-06 20:04:06.928216 | controller | GOBIN=/home/zuul-worker/src/softwarefactory-project.io/software-factory/sf-operator/bin go install sigs.k8s.io/controller-runtime/tools/setup-envtest@release-0.22
2026-06-06 20:04:07.261341 | controller | go: downloading sigs.k8s.io/controller-runtime v0.22.6-0.20260125163108-a19ec76a3c5d
2026-06-06 20:04:07.316415 | controller | go: downloading sigs.k8s.io/controller-runtime/tools/setup-envtest v0.0.0-20260125163108-a19ec76a3c5d
2026-06-06 20:04:10.340815 | controller | go: downloading github.com/spf13/afero v1.12.0
2026-06-06 20:04:10.345552 | controller | go: downloading sigs.k8s.io/yaml v1.6.0
2026-06-06 20:04:10.575343 | controller | go: downloading go.uber.org/multierr v1.10.0
2026-06-06 20:04:10.964520 | controller | go: downloading golang.org/x/text v0.23.0
2026-06-06 20:04:10.987522 | controller | go: downloading go.yaml.in/yaml/v2 v2.4.2
2026-06-06 20:04:16.862423 | controller | CGO_ENABLED=1 KUBEBUILDER_ASSETS="/home/zuul-worker/.local/share/kubebuilder-envtest/k8s/1.36.0-linux-amd64" go test -race ./controllers/... -coverprofile cover.out
2026-06-06 20:05:08.226948 | controller | ok  	github.com/softwarefactory-project/sf-operator/controllers	8.288s	coverage: 13.5% of statements
2026-06-06 20:05:08.227060 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/base		coverage: 0.0% of statements
2026-06-06 20:05:08.227072 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/cert		coverage: 0.0% of statements
2026-06-06 20:05:08.227080 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/client		coverage: 0.0% of statements
2026-06-06 20:05:08.227089 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/conds		coverage: 0.0% of statements
2026-06-06 20:05:08.227097 | controller | ok  	github.com/softwarefactory-project/sf-operator/controllers/libs/logging	1.096s	coverage: 18.4% of statements
2026-06-06 20:05:08.227172 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/monitoring		coverage: 0.0% of statements
2026-06-06 20:05:08.227187 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/utils		coverage: 0.0% of statements
2026-06-06 20:05:08.227195 | controller | 	github.com/softwarefactory-project/sf-operator/controllers/libs/zuulcf		coverage: 0.0% of statements
2026-06-07 00:05:08.884673 | controller | ok: Runtime: 0:02:12.797979
2026-06-07 00:05:08.887411 | 
2026-06-07 00:05:08.887550 | PLAY RECAP
2026-06-07 00:05:08.887603 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-06-07 00:05:08.887630 | 
2026-06-07 00:05:09.047459 | RUN END RESULT_NORMAL: [untrusted : softwarefactory-project.io/software-factory/sf-operator/playbooks/run-go-tests.yaml@master]
2026-06-07 00:05:09.048742 | POST-RUN START: [trusted : gitlab.com/softwarefactory-project/centosinfra-prod/sf-config/playbooks/base/post.yaml@main]
2026-06-07 00:05:09.864336 | 
2026-06-07 00:05:09.864606 | PLAY [all]
2026-06-07 00:05:09.879531 | 
2026-06-07 00:05:09.879733 | TASK [include_role : fetch-output]
2026-06-07 00:05:09.933702 | controller | ok
2026-06-07 00:05:09.953819 | 
2026-06-07 00:05:09.954034 | TASK [fetch-output : Set log path for multiple nodes]
2026-06-07 00:05:10.020046 | controller | skipping: Conditional result was False
2026-06-07 00:05:10.026493 | 
2026-06-07 00:05:10.026683 | TASK [fetch-output : Set log path for single node]
2026-06-07 00:05:10.066764 | controller | ok
2026-06-07 00:05:10.071094 | 
2026-06-07 00:05:10.071228 | LOOP [fetch-output : Ensure local output dirs]
2026-06-07 00:05:10.618935 | controller -> localhost | changed: "/var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/logs"
2026-06-07 00:05:10.916410 | controller -> localhost | changed: "/var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/artifacts"
2026-06-07 00:05:11.232039 | controller -> localhost | changed: "/var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/docs"
2026-06-07 00:05:11.242714 | 
2026-06-07 00:05:11.242878 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-06-07 00:05:12.007407 | controller | changed: .d..t...... ./
2026-06-07 00:05:12.007783 | controller | changed: All items complete
2026-06-07 00:05:12.007819 | 
2026-06-07 00:05:12.591219 | controller | changed: .d..t...... ./
2026-06-07 00:05:13.139613 | controller | changed: .d..t...... ./
2026-06-07 00:05:13.163767 | 
2026-06-07 00:05:13.163941 | TASK [include_role : fetch-output-openshift]
2026-06-07 00:05:13.191278 | controller | skipping: Conditional result was False
2026-06-07 00:05:13.196899 | 
2026-06-07 00:05:13.197034 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-06-07 00:05:13.226896 | controller | skipping: Conditional result was False
2026-06-07 00:05:13.235241 | controller | skipping: Conditional result was False
2026-06-07 00:05:13.254161 | 
2026-06-07 00:05:13.254315 | PLAY [localhost]
2026-06-07 00:05:13.263891 | 
2026-06-07 00:05:13.264069 | TASK [add-fileserver : Create SSH private key tempfile]
2026-06-07 00:05:13.776476 | localhost | changed
2026-06-07 00:05:13.783840 | 
2026-06-07 00:05:13.784047 | TASK [add-fileserver : Create SSH private key from secret]
2026-06-07 00:05:14.678933 | localhost | changed
2026-06-07 00:05:14.686408 | 
2026-06-07 00:05:14.686570 | TASK [add-fileserver : Add fileserver ssh key]
2026-06-07 00:05:15.201194 | localhost | Identity added: /var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/tmp/ansible.4e1d815a (/var/lib/zuul/builds/6db2afd3d45a43e28823a8d2e94f65ff/work/tmp/ansible.4e1d815a)
2026-06-07 00:05:15.201426 | localhost | ok: Runtime: 0:00:00.015521
2026-06-07 00:05:15.205076 | 
2026-06-07 00:05:15.205186 | TASK [add-fileserver : Remove SSH private key from disk]
2026-06-07 00:05:15.653602 | localhost | ok: Runtime: 0:00:00.006873
2026-06-07 00:05:15.658666 | 
2026-06-07 00:05:15.658807 | TASK [add-fileserver : Add fileserver to inventory]
2026-06-07 00:05:15.719424 | localhost | changed
2026-06-07 00:05:15.724442 | 
2026-06-07 00:05:15.724528 | TASK [add-fileserver : Add fileserver server to known hosts]
2026-06-07 00:05:16.134230 | localhost | changed
2026-06-07 00:05:16.153278 | 
2026-06-07 00:05:16.153588 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-06-07 00:05:16.492006 | localhost | changed
2026-06-07 00:05:16.507965 | 
2026-06-07 00:05:16.508157 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-06-07 00:05:16.539226 | localhost | ok
2026-06-07 00:05:16.548438 | 
2026-06-07 00:05:16.548892 | TASK [zuul_return]
2026-06-07 00:05:16.596425 | localhost | skipping: Conditional result was False
2026-06-07 00:05:16.599873 | 
2026-06-07 00:05:16.600000 | PLAY [a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com]
2026-06-07 00:05:16.605025 | 
2026-06-07 00:05:16.605181 | TASK [Set zuul-log-path fact]
2026-06-07 00:05:16.623022 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-07 00:05:16.633383 | 
2026-06-07 00:05:16.633552 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-06-07 00:05:16.661754 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | ok
2026-06-07 00:05:16.665674 | 
2026-06-07 00:05:16.665816 | TASK [upload-logs : Create log directories]
2026-06-07 00:05:17.489497 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed
2026-06-07 00:05:17.492483 | 
2026-06-07 00:05:17.492629 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-06-07 00:05:17.827311 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com -> localhost | ok: Runtime: 0:00:00.008138
2026-06-07 00:05:17.832393 | 
2026-06-07 00:05:17.832568 | TASK [upload-logs : Upload logs to log server]
2026-06-07 00:05:19.029543 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | changed:
2026-06-07 00:05:19.029733 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | .d..tp..... ./
2026-06-07 00:05:19.029760 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ workspace-repos.json
2026-06-07 00:05:19.029780 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-manifest.json
2026-06-07 00:05:19.029798 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | cd+++++++++ zuul-info/
2026-06-07 00:05:19.029816 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/host-info.controller.yaml
2026-06-07 00:05:19.029834 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/inventory.yaml
2026-06-07 00:05:19.029851 | a71a93e18f1524007a0994a866a4da93-48298913.us-east-1.elb.amazonaws.com | <f+++++++++ zuul-info/zuul-info.controller.txt
2026-06-07 00:05:19.031754 | 
2026-06-07 00:05:19.031823 | LOOP [upload-logs : Compress console log and json output]
