2026-01-29 21:02:19.207336 | Job console starting 2026-01-29 21:02:19.249890 | Updating git repos 2026-01-29 21:02:19.296141 | Cloning repos into workspace 2026-01-29 21:02:19.361167 | Restoring repo states 2026-01-29 21:02:19.369148 | Merging changes 2026-01-29 21:02:20.035823 | Checking out repos 2026-01-29 21:02:20.137518 | Preparing playbooks 2026-01-29 21:02:21.506143 | Running Ansible setup 2026-01-29 21:02:27.408514 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 21:02:28.559863 | 2026-01-29 21:02:28.559978 | PLAY [Base pre] 2026-01-29 21:02:28.607854 | 2026-01-29 21:02:28.607968 | TASK [Setup log path fact] 2026-01-29 21:02:28.634576 | debian-bookworm | ok 2026-01-29 21:02:28.654512 | 2026-01-29 21:02:28.654722 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 21:02:28.682212 | debian-bookworm | ok 2026-01-29 21:02:28.698871 | 2026-01-29 21:02:28.698963 | TASK [emit-job-header : Print job information] 2026-01-29 21:02:28.745920 | # Job Information 2026-01-29 21:02:28.746092 | Ansible Version: 2.16.14 2026-01-29 21:02:28.746122 | Job: python-black 2026-01-29 21:02:28.746151 | Pipeline: check 2026-01-29 21:02:28.746173 | Executor: 521e9411259a 2026-01-29 21:02:28.746190 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/811 2026-01-29 21:02:28.746208 | Event ID: c4d73110-fd55-11f0-8a6f-5d0ab7cccfd5 2026-01-29 21:02:28.750312 | 2026-01-29 21:02:28.750410 | LOOP [emit-job-header : Print node information] 2026-01-29 21:02:29.021050 | debian-bookworm | ok: 2026-01-29 21:02:29.021192 | debian-bookworm | # Node Information 2026-01-29 21:02:29.021220 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 21:02:29.021240 | debian-bookworm | Hostname: debian 2026-01-29 21:02:29.021259 | debian-bookworm | Username: zuul 2026-01-29 21:02:29.021276 | debian-bookworm | Distro: Debian 12.13 2026-01-29 21:02:29.021295 | debian-bookworm | Provider: regiocloud-a 2026-01-29 21:02:29.021311 | debian-bookworm | Region: 2026-01-29 21:02:29.021328 | debian-bookworm | Label: debian-bookworm 2026-01-29 21:02:29.021344 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 21:02:29.021360 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe66:b77c 2026-01-29 21:02:29.031064 | 2026-01-29 21:02:29.031164 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 21:02:30.023945 | debian-bookworm -> localhost | changed 2026-01-29 21:02:30.029895 | 2026-01-29 21:02:30.029994 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 21:02:31.999839 | debian-bookworm -> localhost | changed 2026-01-29 21:02:32.008185 | 2026-01-29 21:02:32.008273 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 21:02:32.473661 | debian-bookworm -> localhost | ok 2026-01-29 21:02:32.478622 | 2026-01-29 21:02:32.478715 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 21:02:32.505583 | debian-bookworm | ok 2026-01-29 21:02:32.537994 | debian-bookworm | included: /var/lib/zuul/builds/620e4634f835400ca3e9f4cb64198b01/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 21:02:32.557471 | 2026-01-29 21:02:32.557569 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 21:02:35.294938 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 21:02:35.295106 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/620e4634f835400ca3e9f4cb64198b01/work/620e4634f835400ca3e9f4cb64198b01_id_rsa 2026-01-29 21:02:35.295139 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/620e4634f835400ca3e9f4cb64198b01/work/620e4634f835400ca3e9f4cb64198b01_id_rsa.pub 2026-01-29 21:02:35.295161 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 21:02:35.295182 | debian-bookworm -> localhost | SHA256:snU6v3av8OyGmOPDzs3HW1fdcINg3GwHg0Mcf9hrTFY zuul-build-sshkey 2026-01-29 21:02:35.295200 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 21:02:35.295226 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 21:02:35.295244 | debian-bookworm -> localhost | | +==o. E| 2026-01-29 21:02:35.295262 | debian-bookworm -> localhost | | .=o+=..| 2026-01-29 21:02:35.295278 | debian-bookworm -> localhost | | o+o*.| 2026-01-29 21:02:35.295294 | debian-bookworm -> localhost | | =o=| 2026-01-29 21:02:35.295311 | debian-bookworm -> localhost | | . S . ++| 2026-01-29 21:02:35.295332 | debian-bookworm -> localhost | | + o . .| 2026-01-29 21:02:35.295349 | debian-bookworm -> localhost | | ..oo.o . .| 2026-01-29 21:02:35.295366 | debian-bookworm -> localhost | | .*=o+=. . | 2026-01-29 21:02:35.295383 | debian-bookworm -> localhost | | o++=**+. | 2026-01-29 21:02:35.295398 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 21:02:35.295441 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.608861 2026-01-29 21:02:35.300466 | 2026-01-29 21:02:35.300547 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 21:02:35.346722 | debian-bookworm | ok 2026-01-29 21:02:35.353925 | debian-bookworm | included: /var/lib/zuul/builds/620e4634f835400ca3e9f4cb64198b01/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 21:02:35.381196 | 2026-01-29 21:02:35.381297 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 21:02:35.413940 | debian-bookworm | skipping: Conditional result was False 2026-01-29 21:02:35.418678 | 2026-01-29 21:02:35.418819 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 21:02:36.227652 | debian-bookworm | changed 2026-01-29 21:02:36.232943 | 2026-01-29 21:02:36.233032 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 21:02:36.489103 | debian-bookworm | ok 2026-01-29 21:02:36.495689 | 2026-01-29 21:02:36.495797 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 21:02:37.216964 | debian-bookworm | changed 2026-01-29 21:02:37.227352 | 2026-01-29 21:02:37.229916 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 21:02:37.856305 | debian-bookworm | changed 2026-01-29 21:02:37.862221 | 2026-01-29 21:02:37.862320 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 21:02:37.885797 | debian-bookworm | skipping: Conditional result was False 2026-01-29 21:02:37.900736 | 2026-01-29 21:02:37.900863 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 21:02:38.423126 | debian-bookworm -> localhost | changed 2026-01-29 21:02:38.433650 | 2026-01-29 21:02:38.433766 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 21:02:39.103925 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/620e4634f835400ca3e9f4cb64198b01/work/620e4634f835400ca3e9f4cb64198b01_id_rsa (zuul-build-sshkey) 2026-01-29 21:02:39.104144 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032383 2026-01-29 21:02:39.111648 | 2026-01-29 21:02:39.111782 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 21:02:39.633599 | debian-bookworm | ok 2026-01-29 21:02:39.639988 | 2026-01-29 21:02:39.640096 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 21:02:39.667725 | debian-bookworm | skipping: Conditional result was False 2026-01-29 21:02:39.678568 | 2026-01-29 21:02:39.678670 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 21:02:40.298231 | debian-bookworm | ok 2026-01-29 21:02:40.306933 | 2026-01-29 21:02:40.307026 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 21:02:40.369279 | debian-bookworm | ok 2026-01-29 21:02:40.374689 | 2026-01-29 21:02:40.374792 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 21:02:40.835549 | debian-bookworm -> localhost | ok 2026-01-29 21:02:40.843312 | 2026-01-29 21:02:40.843572 | TASK [validate-host : Collect information about the host] 2026-01-29 21:02:42.432848 | debian-bookworm | ok 2026-01-29 21:02:42.442815 | 2026-01-29 21:02:42.442946 | TASK [validate-host : Sanitize hostname] 2026-01-29 21:02:42.554455 | debian-bookworm | ok 2026-01-29 21:02:42.592791 | 2026-01-29 21:02:42.592917 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 21:02:43.374652 | debian-bookworm -> localhost | changed 2026-01-29 21:02:43.380235 | 2026-01-29 21:02:43.380334 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 21:02:43.865891 | debian-bookworm | ok 2026-01-29 21:02:43.870393 | 2026-01-29 21:02:43.870493 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 21:02:44.840774 | debian-bookworm -> localhost | changed 2026-01-29 21:02:44.849959 | 2026-01-29 21:02:44.850058 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 21:02:45.172786 | debian-bookworm | ok 2026-01-29 21:02:45.178226 | 2026-01-29 21:02:45.178331 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 21:02:46.655155 | debian-bookworm | changed: 2026-01-29 21:02:46.655375 | debian-bookworm | cd+++++++++ src/ 2026-01-29 21:02:46.655410 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 21:02:46.655434 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 21:02:46.655456 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-01-29 21:02:46.655476 | debian-bookworm | Containerfile 2026-01-29 21:02:46.655604 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007204 2026-01-29 21:03:14.933877 | 2026-01-29 21:03:14.933997 | TASK [upload-logs : Upload logs to log server] 2026-01-29 21:03:15.501815 | localhost | Output suppressed because no_log was given 2026-01-29 21:03:15.503668 | 2026-01-29 21:03:15.503809 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 21:03:15.549782 | localhost | skipping: Conditional result was False 2026-01-29 21:03:15.556349 | localhost | skipping: Conditional result was False 2026-01-29 21:03:15.566310 | 2026-01-29 21:03:15.566425 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 21:03:15.609841 | localhost | skipping: Conditional result was False 2026-01-29 21:03:15.610127 | 2026-01-29 21:03:15.622360 | localhost | skipping: Conditional result was False 2026-01-29 21:03:15.634192 | 2026-01-29 21:03:15.634343 | LOOP [upload-logs : Upload console log and json output]