2026-03-13 22:40:27.112518 | Job console starting 2026-03-13 22:40:27.131936 | Updating git repos 2026-03-13 22:40:27.175040 | Cloning repos into workspace 2026-03-13 22:40:27.308325 | Restoring repo states 2026-03-13 22:40:27.313579 | Merging changes 2026-03-13 22:40:27.928350 | Checking out repos 2026-03-13 22:40:28.078564 | Preparing playbooks 2026-03-13 22:40:29.621764 | Running Ansible setup 2026-03-13 22:40:36.438189 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-13 22:40:37.615279 | 2026-03-13 22:40:37.615430 | PLAY [Base pre] 2026-03-13 22:40:37.645094 | 2026-03-13 22:40:37.645216 | TASK [Setup log path fact] 2026-03-13 22:40:37.676367 | debian-bookworm | ok 2026-03-13 22:40:37.702958 | 2026-03-13 22:40:37.703094 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-13 22:40:37.732967 | debian-bookworm | ok 2026-03-13 22:40:37.747930 | 2026-03-13 22:40:37.748036 | TASK [emit-job-header : Print job information] 2026-03-13 22:40:37.836959 | # Job Information 2026-03-13 22:40:37.837212 | Ansible Version: 2.16.14 2026-03-13 22:40:37.837253 | Job: python-black 2026-03-13 22:40:37.837289 | Pipeline: check 2026-03-13 22:40:37.837318 | Executor: 521e9411259a 2026-03-13 22:40:37.837338 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/819 2026-03-13 22:40:37.837360 | Event ID: 9afb35e0-1f2d-11f1-929a-3ed266a906e2 2026-03-13 22:40:37.842380 | 2026-03-13 22:40:37.842489 | LOOP [emit-job-header : Print node information] 2026-03-13 22:40:38.058734 | debian-bookworm | ok: 2026-03-13 22:40:38.059011 | debian-bookworm | # Node Information 2026-03-13 22:40:38.059049 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-13 22:40:38.059074 | debian-bookworm | Hostname: debian 2026-03-13 22:40:38.059097 | debian-bookworm | Username: zuul 2026-03-13 22:40:38.059118 | debian-bookworm | Distro: Debian 12.13 2026-03-13 22:40:38.059142 | debian-bookworm | Provider: regiocloud-a 2026-03-13 22:40:38.059163 | debian-bookworm | Region: 2026-03-13 22:40:38.059185 | debian-bookworm | Label: debian-bookworm 2026-03-13 22:40:38.059205 | debian-bookworm | Product Name: OpenStack Nova 2026-03-13 22:40:38.059225 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe41:ce88 2026-03-13 22:40:38.073040 | 2026-03-13 22:40:38.073160 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-13 22:40:38.818345 | debian-bookworm -> localhost | changed 2026-03-13 22:40:38.824997 | 2026-03-13 22:40:38.825107 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-13 22:40:40.915787 | debian-bookworm -> localhost | changed 2026-03-13 22:40:40.926084 | 2026-03-13 22:40:40.926191 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-13 22:40:41.398668 | debian-bookworm -> localhost | ok 2026-03-13 22:40:41.404453 | 2026-03-13 22:40:41.404553 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-13 22:40:41.443188 | debian-bookworm | ok 2026-03-13 22:40:41.494537 | debian-bookworm | included: /var/lib/zuul/builds/08759f418e7c4994869a7b956827505c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-13 22:40:41.506317 | 2026-03-13 22:40:41.506422 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-13 22:40:43.970311 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-13 22:40:43.970487 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/08759f418e7c4994869a7b956827505c/work/08759f418e7c4994869a7b956827505c_id_rsa 2026-03-13 22:40:43.970523 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/08759f418e7c4994869a7b956827505c/work/08759f418e7c4994869a7b956827505c_id_rsa.pub 2026-03-13 22:40:43.970549 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-13 22:40:43.970572 | debian-bookworm -> localhost | SHA256:nFOmVj1hUgp5NFhZfyYdpoC4gYvWyVQc4zEDbp48cM4 zuul-build-sshkey 2026-03-13 22:40:43.970594 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-13 22:40:43.970625 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-13 22:40:43.970648 | debian-bookworm -> localhost | | .=B+=*== o | 2026-03-13 22:40:43.970669 | debian-bookworm -> localhost | | .o.+Boo*.oo..| 2026-03-13 22:40:43.970690 | debian-bookworm -> localhost | | .=+o.o.= o.o +| 2026-03-13 22:40:43.970709 | debian-bookworm -> localhost | | oO=.o * . + | 2026-03-13 22:40:43.970729 | debian-bookworm -> localhost | | . E S | 2026-03-13 22:40:43.970762 | debian-bookworm -> localhost | | .. . | 2026-03-13 22:40:43.970785 | debian-bookworm -> localhost | | | 2026-03-13 22:40:43.970805 | debian-bookworm -> localhost | | | 2026-03-13 22:40:43.970826 | debian-bookworm -> localhost | | | 2026-03-13 22:40:43.970867 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-13 22:40:43.970919 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.369969 2026-03-13 22:40:43.976945 | 2026-03-13 22:40:43.977037 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-13 22:40:44.004743 | debian-bookworm | ok 2026-03-13 22:40:44.013599 | debian-bookworm | included: /var/lib/zuul/builds/08759f418e7c4994869a7b956827505c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-13 22:40:44.035009 | 2026-03-13 22:40:44.035096 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-13 22:40:44.068098 | debian-bookworm | skipping: Conditional result was False 2026-03-13 22:40:44.072883 | 2026-03-13 22:40:44.072972 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-13 22:40:44.766412 | debian-bookworm | changed 2026-03-13 22:40:44.771033 | 2026-03-13 22:40:44.771114 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-13 22:40:45.031746 | debian-bookworm | ok 2026-03-13 22:40:45.038337 | 2026-03-13 22:40:45.038436 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-13 22:40:45.776625 | debian-bookworm | changed 2026-03-13 22:40:45.787538 | 2026-03-13 22:40:45.787650 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-13 22:40:46.404466 | debian-bookworm | changed 2026-03-13 22:40:46.409714 | 2026-03-13 22:40:46.409816 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-13 22:40:46.427263 | debian-bookworm | skipping: Conditional result was False 2026-03-13 22:40:46.433668 | 2026-03-13 22:40:46.433788 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-13 22:40:47.000065 | debian-bookworm -> localhost | changed 2026-03-13 22:40:47.010858 | 2026-03-13 22:40:47.010959 | TASK [add-build-sshkey : Add back temp key] 2026-03-13 22:40:47.439770 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/08759f418e7c4994869a7b956827505c/work/08759f418e7c4994869a7b956827505c_id_rsa (zuul-build-sshkey) 2026-03-13 22:40:47.439975 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012037 2026-03-13 22:40:47.447511 | 2026-03-13 22:40:47.447613 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-13 22:40:47.912166 | debian-bookworm | ok 2026-03-13 22:40:47.917123 | 2026-03-13 22:40:47.917210 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-13 22:40:47.984571 | debian-bookworm | skipping: Conditional result was False 2026-03-13 22:40:47.996772 | 2026-03-13 22:40:47.996899 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-13 22:40:48.482660 | debian-bookworm | ok 2026-03-13 22:40:48.502016 | 2026-03-13 22:40:48.502126 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-13 22:40:48.550094 | debian-bookworm | ok 2026-03-13 22:40:48.574018 | 2026-03-13 22:40:48.574127 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-13 22:40:49.026305 | debian-bookworm -> localhost | ok 2026-03-13 22:40:49.032363 | 2026-03-13 22:40:49.032452 | TASK [validate-host : Collect information about the host] 2026-03-13 22:40:50.454640 | debian-bookworm | ok 2026-03-13 22:40:50.471569 | 2026-03-13 22:40:50.471680 | TASK [validate-host : Sanitize hostname] 2026-03-13 22:40:50.572621 | debian-bookworm | ok 2026-03-13 22:40:50.614868 | 2026-03-13 22:40:50.614978 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-13 22:40:51.722492 | debian-bookworm -> localhost | changed 2026-03-13 22:40:51.727025 | 2026-03-13 22:40:51.727103 | TASK [validate-host : Collect information about zuul worker] 2026-03-13 22:40:52.127869 | debian-bookworm | ok 2026-03-13 22:40:52.132323 | 2026-03-13 22:40:52.132410 | TASK [validate-host : Write out all zuul information for each host] 2026-03-13 22:40:52.788533 | debian-bookworm -> localhost | changed 2026-03-13 22:40:52.797651 | 2026-03-13 22:40:52.797761 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-13 22:40:53.112938 | debian-bookworm | ok 2026-03-13 22:40:53.118258 | 2026-03-13 22:40:53.118349 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-13 22:40:54.319609 | debian-bookworm | changed: 2026-03-13 22:40:54.319808 | debian-bookworm | cd+++++++++ src/ 2026-03-13 22:40:54.319845 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-13 22:40:54.319870 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-13 22:40:54.319892 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-03-13 22:40:54.319912 | debian-bookworm | Containerfile 2026-03-13 22:40:54.320045 | debian-bookworm | localhost | ok: Runtime: 0:00:00.023810 2026-03-13 22:41:20.536526 | 2026-03-13 22:41:20.536652 | TASK [upload-logs : Upload logs to log server] 2026-03-13 22:41:21.142067 | localhost | Output suppressed because no_log was given 2026-03-13 22:41:21.144105 | 2026-03-13 22:41:21.144223 | LOOP [upload-logs : Compress console log and json output] 2026-03-13 22:41:21.197889 | localhost | skipping: Conditional result was False 2026-03-13 22:41:21.202794 | localhost | skipping: Conditional result was False 2026-03-13 22:41:21.214485 | 2026-03-13 22:41:21.214763 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-13 22:41:21.266036 | localhost | skipping: Conditional result was False 2026-03-13 22:41:21.266499 | 2026-03-13 22:41:21.270383 | localhost | skipping: Conditional result was False 2026-03-13 22:41:21.283087 | 2026-03-13 22:41:21.283239 | LOOP [upload-logs : Upload console log and json output]