2025-06-25 17:26:39.669913 | Job console starting 2025-06-25 17:26:39.699081 | Updating git repos 2025-06-25 17:26:39.760045 | Cloning repos into workspace 2025-06-25 17:26:39.828802 | Restoring repo states 2025-06-25 17:26:39.844460 | Merging changes 2025-06-25 17:26:40.481525 | Checking out repos 2025-06-25 17:26:40.564302 | Preparing playbooks 2025-06-25 17:26:42.056469 | Running Ansible setup 2025-06-25 17:26:49.974405 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-25 17:26:52.279747 | 2025-06-25 17:26:52.279869 | PLAY [Base pre] 2025-06-25 17:26:52.334966 | 2025-06-25 17:26:52.335083 | TASK [Setup log path fact] 2025-06-25 17:26:52.385877 | debian-bookworm | ok 2025-06-25 17:26:52.425273 | 2025-06-25 17:26:52.425425 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-25 17:26:52.478308 | debian-bookworm | ok 2025-06-25 17:26:52.492852 | 2025-06-25 17:26:52.492950 | TASK [emit-job-header : Print job information] 2025-06-25 17:26:52.644519 | # Job Information 2025-06-25 17:26:52.646628 | Ansible Version: 2.16.14 2025-06-25 17:26:52.647522 | Job: python-black 2025-06-25 17:26:52.647967 | Pipeline: check 2025-06-25 17:26:52.648506 | Executor: 521e9411259a 2025-06-25 17:26:52.649045 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/761 2025-06-25 17:26:52.649756 | Event ID: 889b3bf0-51e9-11f0-8cbc-fd6212f536a9 2025-06-25 17:26:52.690828 | 2025-06-25 17:26:52.694596 | LOOP [emit-job-header : Print node information] 2025-06-25 17:26:53.252970 | debian-bookworm | ok: 2025-06-25 17:26:53.253288 | debian-bookworm | # Node Information 2025-06-25 17:26:53.253442 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-25 17:26:53.253473 | debian-bookworm | Hostname: debian 2025-06-25 17:26:53.253496 | debian-bookworm | Username: zuul 2025-06-25 17:26:53.253517 | debian-bookworm | Distro: Debian 12.11 2025-06-25 17:26:53.253541 | debian-bookworm | Provider: regiocloud-a 2025-06-25 17:26:53.253561 | debian-bookworm | Region: 2025-06-25 17:26:53.253667 | debian-bookworm | Label: debian-bookworm 2025-06-25 17:26:53.253693 | debian-bookworm | Product Name: OpenStack Nova 2025-06-25 17:26:53.253715 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feaa:7e4d 2025-06-25 17:26:53.294025 | 2025-06-25 17:26:53.294137 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-25 17:26:54.469556 | debian-bookworm -> localhost | changed 2025-06-25 17:26:54.478140 | 2025-06-25 17:26:54.478234 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-25 17:26:57.201574 | debian-bookworm -> localhost | changed 2025-06-25 17:26:57.222717 | 2025-06-25 17:26:57.222816 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-25 17:26:57.855938 | debian-bookworm -> localhost | ok 2025-06-25 17:26:57.860984 | 2025-06-25 17:26:57.861074 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-25 17:26:57.887401 | debian-bookworm | ok 2025-06-25 17:26:57.907556 | debian-bookworm | included: /var/lib/zuul/builds/39ff142d2691493fa1cde6873f9558a2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-25 17:26:57.922747 | 2025-06-25 17:26:57.922851 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-25 17:27:00.078714 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-25 17:27:00.078893 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/39ff142d2691493fa1cde6873f9558a2/work/39ff142d2691493fa1cde6873f9558a2_id_rsa 2025-06-25 17:27:00.078926 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/39ff142d2691493fa1cde6873f9558a2/work/39ff142d2691493fa1cde6873f9558a2_id_rsa.pub 2025-06-25 17:27:00.078947 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-25 17:27:00.078966 | debian-bookworm -> localhost | SHA256:Au7TOWWbbHGi2Iea9e9kFNX0mqCSs/l+Occi5rMsKDE zuul-build-sshkey 2025-06-25 17:27:00.078985 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-25 17:27:00.079011 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-25 17:27:00.079029 | debian-bookworm -> localhost | | .o. | 2025-06-25 17:27:00.079047 | debian-bookworm -> localhost | | . .. | 2025-06-25 17:27:00.079064 | debian-bookworm -> localhost | | . . . .| 2025-06-25 17:27:00.079080 | debian-bookworm -> localhost | | . . . o . o | 2025-06-25 17:27:00.079096 | debian-bookworm -> localhost | | . . S + o | 2025-06-25 17:27:00.079116 | debian-bookworm -> localhost | | .E+ O % | 2025-06-25 17:27:00.079132 | debian-bookworm -> localhost | | +oO.O o o | 2025-06-25 17:27:00.079149 | debian-bookworm -> localhost | | .=.=.=+ = o | 2025-06-25 17:27:00.079165 | debian-bookworm -> localhost | | o. .BO= + | 2025-06-25 17:27:00.079182 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-25 17:27:00.079222 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.218106 2025-06-25 17:27:00.084470 | 2025-06-25 17:27:00.084546 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-25 17:27:00.110717 | debian-bookworm | ok 2025-06-25 17:27:00.119116 | debian-bookworm | included: /var/lib/zuul/builds/39ff142d2691493fa1cde6873f9558a2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-25 17:27:00.126394 | 2025-06-25 17:27:00.126469 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-25 17:27:00.149183 | debian-bookworm | skipping: Conditional result was False 2025-06-25 17:27:00.153981 | 2025-06-25 17:27:00.154495 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-25 17:27:00.802980 | debian-bookworm | changed 2025-06-25 17:27:00.807455 | 2025-06-25 17:27:00.807538 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-25 17:27:01.052270 | debian-bookworm | ok 2025-06-25 17:27:01.057802 | 2025-06-25 17:27:01.057895 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-25 17:27:01.690555 | debian-bookworm | changed 2025-06-25 17:27:01.703240 | 2025-06-25 17:27:01.703370 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-25 17:27:02.398296 | debian-bookworm | changed 2025-06-25 17:27:02.402988 | 2025-06-25 17:27:02.403076 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-25 17:27:02.439210 | debian-bookworm | skipping: Conditional result was False 2025-06-25 17:27:02.444099 | 2025-06-25 17:27:02.444177 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-25 17:27:03.006296 | debian-bookworm -> localhost | changed 2025-06-25 17:27:03.016698 | 2025-06-25 17:27:03.016792 | TASK [add-build-sshkey : Add back temp key] 2025-06-25 17:27:03.632933 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/39ff142d2691493fa1cde6873f9558a2/work/39ff142d2691493fa1cde6873f9558a2_id_rsa (zuul-build-sshkey) 2025-06-25 17:27:03.633142 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023960 2025-06-25 17:27:03.640997 | 2025-06-25 17:27:03.641088 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-25 17:27:04.168243 | debian-bookworm | ok 2025-06-25 17:27:04.173027 | 2025-06-25 17:27:04.173110 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-25 17:27:04.210007 | debian-bookworm | skipping: Conditional result was False 2025-06-25 17:27:04.220015 | 2025-06-25 17:27:04.220118 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-25 17:27:04.691883 | debian-bookworm | ok 2025-06-25 17:27:04.702013 | 2025-06-25 17:27:04.702112 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-25 17:27:04.743961 | debian-bookworm | ok 2025-06-25 17:27:04.748911 | 2025-06-25 17:27:04.749000 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-25 17:27:05.020642 | debian-bookworm -> localhost | ok 2025-06-25 17:27:05.026898 | 2025-06-25 17:27:05.027115 | TASK [validate-host : Collect information about the host] 2025-06-25 17:27:06.279022 | debian-bookworm | ok 2025-06-25 17:27:06.293313 | 2025-06-25 17:27:06.293434 | TASK [validate-host : Sanitize hostname] 2025-06-25 17:27:06.388656 | debian-bookworm | ok 2025-06-25 17:27:06.480039 | 2025-06-25 17:27:06.480155 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-25 17:27:07.504360 | debian-bookworm -> localhost | changed 2025-06-25 17:27:07.509731 | 2025-06-25 17:27:07.509822 | TASK [validate-host : Collect information about zuul worker] 2025-06-25 17:27:08.045018 | debian-bookworm | ok 2025-06-25 17:27:08.051225 | 2025-06-25 17:27:08.052685 | TASK [validate-host : Write out all zuul information for each host] 2025-06-25 17:27:09.225707 | debian-bookworm -> localhost | changed 2025-06-25 17:27:09.234885 | 2025-06-25 17:27:09.234975 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-25 17:27:09.526205 | debian-bookworm | ok 2025-06-25 17:27:09.532228 | 2025-06-25 17:27:09.532326 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-25 17:27:10.569943 | debian-bookworm | changed: 2025-06-25 17:27:10.570161 | debian-bookworm | cd+++++++++ src/ 2025-06-25 17:27:10.570205 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-25 17:27:10.570230 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-25 17:27:10.570252 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-06-25 17:27:10.570273 | debian-bookworm | Containerfile 2025-06-25 17:27:10.570447 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007459 2025-06-25 17:27:37.006232 | 2025-06-25 17:27:37.006354 | TASK [upload-logs : Upload logs to log server] 2025-06-25 17:27:37.595759 | localhost | Output suppressed because no_log was given 2025-06-25 17:27:37.600530 | 2025-06-25 17:27:37.600664 | LOOP [upload-logs : Compress console log and json output] 2025-06-25 17:27:37.649421 | localhost | skipping: Conditional result was False 2025-06-25 17:27:37.657940 | localhost | skipping: Conditional result was False 2025-06-25 17:27:37.667665 | 2025-06-25 17:27:37.667792 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-25 17:27:37.715826 | localhost | skipping: Conditional result was False 2025-06-25 17:27:37.716091 | 2025-06-25 17:27:37.722987 | localhost | skipping: Conditional result was False 2025-06-25 17:27:37.734190 | 2025-06-25 17:27:37.734299 | LOOP [upload-logs : Upload console log and json output]