2026-01-28 19:31:09.139016 | Job console starting 2026-01-28 19:31:09.167412 | Updating git repos 2026-01-28 19:31:09.213546 | Cloning repos into workspace 2026-01-28 19:31:09.288254 | Restoring repo states 2026-01-28 19:31:09.293503 | Merging changes 2026-01-28 19:31:09.937597 | Checking out repos 2026-01-28 19:31:10.030202 | Preparing playbooks 2026-01-28 19:31:10.837048 | Running Ansible setup 2026-01-28 19:31:15.351461 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-28 19:31:16.184368 | 2026-01-28 19:31:16.184531 | PLAY [Base pre] 2026-01-28 19:31:16.200961 | 2026-01-28 19:31:16.201144 | TASK [Setup log path fact] 2026-01-28 19:31:16.241450 | debian-bookworm | ok 2026-01-28 19:31:16.276356 | 2026-01-28 19:31:16.276526 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-28 19:31:16.348613 | debian-bookworm | ok 2026-01-28 19:31:16.371944 | 2026-01-28 19:31:16.372104 | TASK [emit-job-header : Print job information] 2026-01-28 19:31:16.453941 | # Job Information 2026-01-28 19:31:16.454249 | Ansible Version: 2.16.14 2026-01-28 19:31:16.454291 | Job: python-black 2026-01-28 19:31:16.454325 | Pipeline: check 2026-01-28 19:31:16.454348 | Executor: 521e9411259a 2026-01-28 19:31:16.454369 | Triggered by: https://github.com/osism/testbed/pull/2826 2026-01-28 19:31:16.454392 | Event ID: e047bf90-fc7f-11f0-81e4-25a13fa03958 2026-01-28 19:31:16.468765 | 2026-01-28 19:31:16.470728 | LOOP [emit-job-header : Print node information] 2026-01-28 19:31:16.696846 | debian-bookworm | ok: 2026-01-28 19:31:16.700799 | debian-bookworm | # Node Information 2026-01-28 19:31:16.700898 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-28 19:31:16.700929 | debian-bookworm | Hostname: debian 2026-01-28 19:31:16.700953 | debian-bookworm | Username: zuul 2026-01-28 19:31:16.700975 | debian-bookworm | Distro: Debian 12.13 2026-01-28 19:31:16.701000 | debian-bookworm | Provider: regiocloud-a 2026-01-28 19:31:16.701021 | debian-bookworm | Region: 2026-01-28 19:31:16.701042 | debian-bookworm | Label: debian-bookworm 2026-01-28 19:31:16.701063 | debian-bookworm | Product Name: OpenStack Nova 2026-01-28 19:31:16.701124 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:ee7f 2026-01-28 19:31:16.725936 | 2026-01-28 19:31:16.726115 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-28 19:31:17.464609 | debian-bookworm -> localhost | changed 2026-01-28 19:31:17.472228 | 2026-01-28 19:31:17.472360 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-28 19:31:18.641665 | debian-bookworm -> localhost | changed 2026-01-28 19:31:18.653184 | 2026-01-28 19:31:18.653321 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-28 19:31:18.955435 | debian-bookworm -> localhost | ok 2026-01-28 19:31:18.961813 | 2026-01-28 19:31:18.961938 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-28 19:31:18.991679 | debian-bookworm | ok 2026-01-28 19:31:19.010280 | debian-bookworm | included: /var/lib/zuul/builds/73bf7c4c937044c1876a2f189e25967f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-28 19:31:19.016744 | 2026-01-28 19:31:19.016860 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-28 19:31:20.098484 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-28 19:31:20.098718 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/73bf7c4c937044c1876a2f189e25967f/work/73bf7c4c937044c1876a2f189e25967f_id_rsa 2026-01-28 19:31:20.098758 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/73bf7c4c937044c1876a2f189e25967f/work/73bf7c4c937044c1876a2f189e25967f_id_rsa.pub 2026-01-28 19:31:20.098785 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-28 19:31:20.098810 | debian-bookworm -> localhost | SHA256:1Sh/5xqI+M9j03Ska1c9A4ePed+cOr0ojww2+UsLxI0 zuul-build-sshkey 2026-01-28 19:31:20.098880 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-28 19:31:20.098924 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-28 19:31:20.098948 | debian-bookworm -> localhost | | | 2026-01-28 19:31:20.098969 | debian-bookworm -> localhost | | o | 2026-01-28 19:31:20.098991 | debian-bookworm -> localhost | | . o . . | 2026-01-28 19:31:20.099011 | debian-bookworm -> localhost | | .+o o.. | 2026-01-28 19:31:20.099031 | debian-bookworm -> localhost | | SE...oB .| 2026-01-28 19:31:20.099056 | debian-bookworm -> localhost | | ....oo=.=o| 2026-01-28 19:31:20.099117 | debian-bookworm -> localhost | | . .*.+.o+o*| 2026-01-28 19:31:20.099139 | debian-bookworm -> localhost | | ...@.*+oo+| 2026-01-28 19:31:20.099161 | debian-bookworm -> localhost | | .ooX==o..| 2026-01-28 19:31:20.099182 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-28 19:31:20.099235 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.408932 2026-01-28 19:31:20.105821 | 2026-01-28 19:31:20.105927 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-28 19:31:20.134731 | debian-bookworm | ok 2026-01-28 19:31:20.144259 | debian-bookworm | included: /var/lib/zuul/builds/73bf7c4c937044c1876a2f189e25967f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-28 19:31:20.153441 | 2026-01-28 19:31:20.153549 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-28 19:31:20.178596 | debian-bookworm | skipping: Conditional result was False 2026-01-28 19:31:20.190724 | 2026-01-28 19:31:20.190881 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-28 19:31:20.877157 | debian-bookworm | changed 2026-01-28 19:31:20.884928 | 2026-01-28 19:31:20.885051 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-28 19:31:21.156289 | debian-bookworm | ok 2026-01-28 19:31:21.165629 | 2026-01-28 19:31:21.165778 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-28 19:31:21.852380 | debian-bookworm | changed 2026-01-28 19:31:21.859499 | 2026-01-28 19:31:21.859621 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-28 19:31:22.503185 | debian-bookworm | changed 2026-01-28 19:31:22.511528 | 2026-01-28 19:31:22.511665 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-28 19:31:22.536237 | debian-bookworm | skipping: Conditional result was False 2026-01-28 19:31:22.542621 | 2026-01-28 19:31:22.542804 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-28 19:31:23.019962 | debian-bookworm -> localhost | changed 2026-01-28 19:31:23.034868 | 2026-01-28 19:31:23.035010 | TASK [add-build-sshkey : Add back temp key] 2026-01-28 19:31:23.444245 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/73bf7c4c937044c1876a2f189e25967f/work/73bf7c4c937044c1876a2f189e25967f_id_rsa (zuul-build-sshkey) 2026-01-28 19:31:23.444602 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014903 2026-01-28 19:31:23.455590 | 2026-01-28 19:31:23.455722 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-28 19:31:23.862304 | debian-bookworm | ok 2026-01-28 19:31:23.869368 | 2026-01-28 19:31:23.869486 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-28 19:31:23.903280 | debian-bookworm | skipping: Conditional result was False 2026-01-28 19:31:23.918747 | 2026-01-28 19:31:23.918903 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-28 19:31:24.336659 | debian-bookworm | ok 2026-01-28 19:31:24.346884 | 2026-01-28 19:31:24.346982 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-28 19:31:24.374386 | debian-bookworm | ok 2026-01-28 19:31:24.379137 | 2026-01-28 19:31:24.379224 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-28 19:31:24.673575 | debian-bookworm -> localhost | ok 2026-01-28 19:31:24.679603 | 2026-01-28 19:31:24.679693 | TASK [validate-host : Collect information about the host] 2026-01-28 19:31:25.772890 | debian-bookworm | ok 2026-01-28 19:31:25.785505 | 2026-01-28 19:31:25.785619 | TASK [validate-host : Sanitize hostname] 2026-01-28 19:31:25.902783 | debian-bookworm | ok 2026-01-28 19:31:25.946636 | 2026-01-28 19:31:25.946757 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-28 19:31:26.499902 | debian-bookworm -> localhost | changed 2026-01-28 19:31:26.505297 | 2026-01-28 19:31:26.505388 | TASK [validate-host : Collect information about zuul worker] 2026-01-28 19:31:26.895459 | debian-bookworm | ok 2026-01-28 19:31:26.899878 | 2026-01-28 19:31:26.899966 | TASK [validate-host : Write out all zuul information for each host] 2026-01-28 19:31:27.395179 | debian-bookworm -> localhost | changed 2026-01-28 19:31:27.412144 | 2026-01-28 19:31:27.412238 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-28 19:31:27.692552 | debian-bookworm | ok 2026-01-28 19:31:27.698969 | 2026-01-28 19:31:27.699084 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-28 19:31:28.729533 | debian-bookworm | changed: 2026-01-28 19:31:28.729762 | debian-bookworm | cd+++++++++ src/ 2026-01-28 19:31:28.729799 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-28 19:31:28.729826 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-28 19:31:28.729849 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-28 19:31:28.729871 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006139 2026-01-28 19:31:53.634761 | 2026-01-28 19:31:53.635007 | TASK [upload-logs : Upload logs to log server] 2026-01-28 19:31:54.380080 | localhost | Output suppressed because no_log was given 2026-01-28 19:31:54.383962 | 2026-01-28 19:31:54.384204 | LOOP [upload-logs : Compress console log and json output] 2026-01-28 19:31:54.448253 | localhost | skipping: Conditional result was False 2026-01-28 19:31:54.453811 | localhost | skipping: Conditional result was False 2026-01-28 19:31:54.461946 | 2026-01-28 19:31:54.462090 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-28 19:31:54.548505 | localhost | skipping: Conditional result was False 2026-01-28 19:31:54.548915 | 2026-01-28 19:31:54.555476 | localhost | skipping: Conditional result was False 2026-01-28 19:31:54.562137 | 2026-01-28 19:31:54.562325 | LOOP [upload-logs : Upload console log and json output]