2025-08-26 20:48:01.147876 | Job console starting 2025-08-26 20:48:01.181470 | Updating git repos 2025-08-26 20:48:01.310480 | Cloning repos into workspace 2025-08-26 20:48:01.399613 | Restoring repo states 2025-08-26 20:48:01.424149 | Merging changes 2025-08-26 20:48:02.025316 | Checking out repos 2025-08-26 20:48:02.119661 | Preparing playbooks 2025-08-26 20:48:02.904797 | Running Ansible setup 2025-08-26 20:48:08.538290 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-26 20:48:09.486167 | 2025-08-26 20:48:09.486278 | PLAY [Base pre] 2025-08-26 20:48:09.504797 | 2025-08-26 20:48:09.504901 | TASK [Setup log path fact] 2025-08-26 20:48:09.521554 | debian-bookworm | ok 2025-08-26 20:48:09.559353 | 2025-08-26 20:48:09.559532 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-26 20:48:09.609414 | debian-bookworm | ok 2025-08-26 20:48:09.626931 | 2025-08-26 20:48:09.627030 | TASK [emit-job-header : Print job information] 2025-08-26 20:48:09.669649 | # Job Information 2025-08-26 20:48:09.669821 | Ansible Version: 2.16.14 2025-08-26 20:48:09.669856 | Job: python-black 2025-08-26 20:48:09.669888 | Pipeline: check 2025-08-26 20:48:09.669912 | Executor: 521e9411259a 2025-08-26 20:48:09.669933 | Triggered by: https://github.com/osism/python-osism/pull/1685 2025-08-26 20:48:09.669956 | Event ID: ef67ea40-82bd-11f0-8751-66c926712367 2025-08-26 20:48:09.674721 | 2025-08-26 20:48:09.674821 | LOOP [emit-job-header : Print node information] 2025-08-26 20:48:09.895759 | debian-bookworm | ok: 2025-08-26 20:48:09.895910 | debian-bookworm | # Node Information 2025-08-26 20:48:09.895939 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-26 20:48:09.895959 | debian-bookworm | Hostname: debian 2025-08-26 20:48:09.895977 | debian-bookworm | Username: zuul 2025-08-26 20:48:09.895994 | debian-bookworm | Distro: Debian 12.11 2025-08-26 20:48:09.896013 | debian-bookworm | Provider: regiocloud-a 2025-08-26 20:48:09.896031 | debian-bookworm | Region: 2025-08-26 20:48:09.896049 | debian-bookworm | Label: debian-bookworm 2025-08-26 20:48:09.896065 | debian-bookworm | Product Name: OpenStack Nova 2025-08-26 20:48:09.896081 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb3:dfb2 2025-08-26 20:48:09.908341 | 2025-08-26 20:48:09.908428 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-26 20:48:10.426502 | debian-bookworm -> localhost | changed 2025-08-26 20:48:10.434381 | 2025-08-26 20:48:10.434475 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-26 20:48:12.004647 | debian-bookworm -> localhost | changed 2025-08-26 20:48:12.013606 | 2025-08-26 20:48:12.013701 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-26 20:48:12.583797 | debian-bookworm -> localhost | ok 2025-08-26 20:48:12.588907 | 2025-08-26 20:48:12.588996 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-26 20:48:12.616427 | debian-bookworm | ok 2025-08-26 20:48:12.652851 | debian-bookworm | included: /var/lib/zuul/builds/5cb547a5aa114fe49c9cb5b2db58962e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-26 20:48:12.669984 | 2025-08-26 20:48:12.670077 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-26 20:48:14.334389 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-26 20:48:14.334584 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5cb547a5aa114fe49c9cb5b2db58962e/work/5cb547a5aa114fe49c9cb5b2db58962e_id_rsa 2025-08-26 20:48:14.334620 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5cb547a5aa114fe49c9cb5b2db58962e/work/5cb547a5aa114fe49c9cb5b2db58962e_id_rsa.pub 2025-08-26 20:48:14.334642 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-26 20:48:14.334664 | debian-bookworm -> localhost | SHA256:8x1gyWpkA7PRs4fpqgJZu032Zrekq9m4B3aDl031PuI zuul-build-sshkey 2025-08-26 20:48:14.334682 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-26 20:48:14.334707 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-26 20:48:14.334726 | debian-bookworm -> localhost | | +. | 2025-08-26 20:48:14.334744 | debian-bookworm -> localhost | | =o... | 2025-08-26 20:48:14.334761 | debian-bookworm -> localhost | | . +*=. | 2025-08-26 20:48:14.334777 | debian-bookworm -> localhost | | . o=+... | 2025-08-26 20:48:14.334793 | debian-bookworm -> localhost | | o . . =S. .. | 2025-08-26 20:48:14.334814 | debian-bookworm -> localhost | |o . * =.oo..o. | 2025-08-26 20:48:14.334843 | debian-bookworm -> localhost | | . * = o...... | 2025-08-26 20:48:14.334862 | debian-bookworm -> localhost | | o .+*o. E | 2025-08-26 20:48:14.334879 | debian-bookworm -> localhost | | .*B+o.. | 2025-08-26 20:48:14.334896 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-26 20:48:14.334938 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.009121 2025-08-26 20:48:14.340027 | 2025-08-26 20:48:14.340104 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-26 20:48:14.376421 | debian-bookworm | ok 2025-08-26 20:48:14.383668 | debian-bookworm | included: /var/lib/zuul/builds/5cb547a5aa114fe49c9cb5b2db58962e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-26 20:48:14.401247 | 2025-08-26 20:48:14.401334 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-26 20:48:14.434307 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:48:14.440130 | 2025-08-26 20:48:14.440214 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-26 20:48:15.061229 | debian-bookworm | changed 2025-08-26 20:48:15.067690 | 2025-08-26 20:48:15.067781 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-26 20:48:15.314393 | debian-bookworm | ok 2025-08-26 20:48:15.319400 | 2025-08-26 20:48:15.319477 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-26 20:48:15.996124 | debian-bookworm | changed 2025-08-26 20:48:16.005716 | 2025-08-26 20:48:16.005815 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-26 20:48:16.642445 | debian-bookworm | changed 2025-08-26 20:48:16.647887 | 2025-08-26 20:48:16.647975 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-26 20:48:16.670171 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:48:16.674796 | 2025-08-26 20:48:16.674896 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-26 20:48:17.144081 | debian-bookworm -> localhost | changed 2025-08-26 20:48:17.158307 | 2025-08-26 20:48:17.158422 | TASK [add-build-sshkey : Add back temp key] 2025-08-26 20:48:17.475567 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5cb547a5aa114fe49c9cb5b2db58962e/work/5cb547a5aa114fe49c9cb5b2db58962e_id_rsa (zuul-build-sshkey) 2025-08-26 20:48:17.475768 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008209 2025-08-26 20:48:17.481970 | 2025-08-26 20:48:17.482046 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-26 20:48:17.878700 | debian-bookworm | ok 2025-08-26 20:48:17.883848 | 2025-08-26 20:48:17.883944 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-26 20:48:17.917531 | debian-bookworm | skipping: Conditional result was False 2025-08-26 20:48:17.928205 | 2025-08-26 20:48:17.928295 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-26 20:48:18.420354 | debian-bookworm | ok 2025-08-26 20:48:18.436044 | 2025-08-26 20:48:18.436141 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-26 20:48:18.469504 | debian-bookworm | ok 2025-08-26 20:48:18.479268 | 2025-08-26 20:48:18.479355 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-26 20:48:18.960260 | debian-bookworm -> localhost | ok 2025-08-26 20:48:18.966659 | 2025-08-26 20:48:18.966757 | TASK [validate-host : Collect information about the host] 2025-08-26 20:48:20.159393 | debian-bookworm | ok 2025-08-26 20:48:20.175534 | 2025-08-26 20:48:20.175655 | TASK [validate-host : Sanitize hostname] 2025-08-26 20:48:20.285060 | debian-bookworm | ok 2025-08-26 20:48:20.317722 | 2025-08-26 20:48:20.317811 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-26 20:48:20.959304 | debian-bookworm -> localhost | changed 2025-08-26 20:48:20.967421 | 2025-08-26 20:48:20.967517 | TASK [validate-host : Collect information about zuul worker] 2025-08-26 20:48:21.369293 | debian-bookworm | ok 2025-08-26 20:48:21.374971 | 2025-08-26 20:48:21.375060 | TASK [validate-host : Write out all zuul information for each host] 2025-08-26 20:48:22.175848 | debian-bookworm -> localhost | changed 2025-08-26 20:48:22.186228 | 2025-08-26 20:48:22.186318 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-26 20:48:22.489717 | debian-bookworm | ok 2025-08-26 20:48:22.494101 | 2025-08-26 20:48:22.494178 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-26 20:48:23.568744 | debian-bookworm | changed: 2025-08-26 20:48:23.568910 | debian-bookworm | cd+++++++++ src/ 2025-08-26 20:48:23.568942 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-26 20:48:23.568967 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-26 20:48:23.568989 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-26 20:48:23.569010 | debian-bookworm | Containerfile 2025-08-26 20:48:23.569126 | debian-bookworm | Containerfile 2025-08-26 20:48:23.577622 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008308 2025-08-26 20:48:49.802804 | 2025-08-26 20:48:49.802968 | TASK [upload-logs : Upload logs to log server] 2025-08-26 20:48:50.370433 | localhost | Output suppressed because no_log was given 2025-08-26 20:48:50.374513 | 2025-08-26 20:48:50.374708 | LOOP [upload-logs : Compress console log and json output] 2025-08-26 20:48:50.433243 | localhost | skipping: Conditional result was False 2025-08-26 20:48:50.438228 | localhost | skipping: Conditional result was False 2025-08-26 20:48:50.444641 | 2025-08-26 20:48:50.444804 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-26 20:48:50.490154 | localhost | skipping: Conditional result was False 2025-08-26 20:48:50.490685 | 2025-08-26 20:48:50.494471 | localhost | skipping: Conditional result was False 2025-08-26 20:48:50.506678 | 2025-08-26 20:48:50.507803 | LOOP [upload-logs : Upload console log and json output]