2025-10-06 03:02:21.336909 | Job console starting 2025-10-06 03:02:21.343849 | Updating git repos 2025-10-06 03:02:21.378595 | Cloning repos into workspace 2025-10-06 03:02:21.459922 | Restoring repo states 2025-10-06 03:02:21.471377 | Merging changes 2025-10-06 03:02:21.471391 | Checking out repos 2025-10-06 03:02:21.553209 | Preparing playbooks 2025-10-06 03:02:22.909472 | Running Ansible setup 2025-10-06 03:02:30.336465 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-06 03:02:31.352701 | 2025-10-06 03:02:31.352836 | PLAY [Base pre] 2025-10-06 03:02:31.368442 | 2025-10-06 03:02:31.368551 | TASK [Setup log path fact] 2025-10-06 03:02:31.386471 | debian-bookworm | ok 2025-10-06 03:02:31.401727 | 2025-10-06 03:02:31.401891 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-06 03:02:31.442300 | debian-bookworm | ok 2025-10-06 03:02:31.473343 | 2025-10-06 03:02:31.473458 | TASK [emit-job-header : Print job information] 2025-10-06 03:02:31.571716 | # Job Information 2025-10-06 03:02:31.571892 | Ansible Version: 2.16.14 2025-10-06 03:02:31.571954 | Job: python-black 2025-10-06 03:02:31.572058 | Pipeline: periodic-daily 2025-10-06 03:02:31.572087 | Executor: 521e9411259a 2025-10-06 03:02:31.572109 | Triggered by: https://github.com/osism/node-image 2025-10-06 03:02:31.572132 | Event ID: c50de56471b841e5bec3082b87e2d5b6 2025-10-06 03:02:31.584512 | 2025-10-06 03:02:31.584619 | LOOP [emit-job-header : Print node information] 2025-10-06 03:02:31.708542 | debian-bookworm | ok: 2025-10-06 03:02:31.708711 | debian-bookworm | # Node Information 2025-10-06 03:02:31.708746 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-06 03:02:31.708770 | debian-bookworm | Hostname: debian 2025-10-06 03:02:31.708791 | debian-bookworm | Username: zuul 2025-10-06 03:02:31.708811 | debian-bookworm | Distro: Debian 12.12 2025-10-06 03:02:31.708845 | debian-bookworm | Provider: regiocloud-a 2025-10-06 03:02:31.708866 | debian-bookworm | Region: 2025-10-06 03:02:31.708888 | debian-bookworm | Label: debian-bookworm 2025-10-06 03:02:31.708908 | debian-bookworm | Product Name: OpenStack Nova 2025-10-06 03:02:31.708927 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe70:8619 2025-10-06 03:02:31.717998 | 2025-10-06 03:02:31.718094 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-06 03:02:32.116601 | debian-bookworm -> localhost | changed 2025-10-06 03:02:32.122202 | 2025-10-06 03:02:32.122288 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-06 03:02:33.598561 | debian-bookworm -> localhost | changed 2025-10-06 03:02:33.609997 | 2025-10-06 03:02:33.610090 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-06 03:02:33.981742 | debian-bookworm -> localhost | ok 2025-10-06 03:02:33.987715 | 2025-10-06 03:02:33.987821 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-06 03:02:34.025426 | debian-bookworm | ok 2025-10-06 03:02:34.054190 | debian-bookworm | included: /var/lib/zuul/builds/5c3778404b864f14bca61459e48b210f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-06 03:02:34.065761 | 2025-10-06 03:02:34.065892 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-06 03:02:35.431942 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-06 03:02:35.432129 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5c3778404b864f14bca61459e48b210f/work/5c3778404b864f14bca61459e48b210f_id_rsa 2025-10-06 03:02:35.432161 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5c3778404b864f14bca61459e48b210f/work/5c3778404b864f14bca61459e48b210f_id_rsa.pub 2025-10-06 03:02:35.432183 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-06 03:02:35.432201 | debian-bookworm -> localhost | SHA256:n5Kq02ajsqSC1yWsaio/nI2m5mvA/9C5QulcsdZFgeI zuul-build-sshkey 2025-10-06 03:02:35.432219 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-06 03:02:35.432244 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-06 03:02:35.432261 | debian-bookworm -> localhost | | ... | 2025-10-06 03:02:35.432278 | debian-bookworm -> localhost | | . . . | 2025-10-06 03:02:35.432294 | debian-bookworm -> localhost | | . . . | 2025-10-06 03:02:35.432310 | debian-bookworm -> localhost | | E . | 2025-10-06 03:02:35.432325 | debian-bookworm -> localhost | |. .. + S | 2025-10-06 03:02:35.432343 | debian-bookworm -> localhost | |.. o++o. o . | 2025-10-06 03:02:35.432359 | debian-bookworm -> localhost | |o.*Bo* o o | 2025-10-06 03:02:35.432375 | debian-bookworm -> localhost | |+*X== *. . | 2025-10-06 03:02:35.432392 | debian-bookworm -> localhost | |&O++=O.. | 2025-10-06 03:02:35.432408 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-06 03:02:35.432446 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.863635 2025-10-06 03:02:35.437507 | 2025-10-06 03:02:35.437581 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-06 03:02:35.477339 | debian-bookworm | ok 2025-10-06 03:02:35.484526 | debian-bookworm | included: /var/lib/zuul/builds/5c3778404b864f14bca61459e48b210f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-06 03:02:35.491517 | 2025-10-06 03:02:35.491583 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-06 03:02:35.504011 | debian-bookworm | skipping: Conditional result was False 2025-10-06 03:02:35.508444 | 2025-10-06 03:02:35.508510 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-06 03:02:36.171810 | debian-bookworm | changed 2025-10-06 03:02:36.177895 | 2025-10-06 03:02:36.177972 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-06 03:02:36.431123 | debian-bookworm | ok 2025-10-06 03:02:36.436315 | 2025-10-06 03:02:36.436405 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-06 03:02:37.045575 | debian-bookworm | changed 2025-10-06 03:02:37.069975 | 2025-10-06 03:02:37.070081 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-06 03:02:37.823176 | debian-bookworm | changed 2025-10-06 03:02:37.827793 | 2025-10-06 03:02:37.827903 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-06 03:02:37.840508 | debian-bookworm | skipping: Conditional result was False 2025-10-06 03:02:37.846012 | 2025-10-06 03:02:37.846101 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-06 03:02:38.757000 | debian-bookworm -> localhost | changed 2025-10-06 03:02:38.777611 | 2025-10-06 03:02:38.777718 | TASK [add-build-sshkey : Add back temp key] 2025-10-06 03:02:39.427284 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5c3778404b864f14bca61459e48b210f/work/5c3778404b864f14bca61459e48b210f_id_rsa (zuul-build-sshkey) 2025-10-06 03:02:39.427743 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.070213 2025-10-06 03:02:39.442368 | 2025-10-06 03:02:39.442475 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-06 03:02:40.038134 | debian-bookworm | ok 2025-10-06 03:02:40.042952 | 2025-10-06 03:02:40.043047 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-06 03:02:40.066039 | debian-bookworm | skipping: Conditional result was False 2025-10-06 03:02:40.075808 | 2025-10-06 03:02:40.075933 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-06 03:02:40.481533 | debian-bookworm | ok 2025-10-06 03:02:40.501042 | 2025-10-06 03:02:40.501147 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-06 03:02:40.567293 | debian-bookworm | ok 2025-10-06 03:02:40.577429 | 2025-10-06 03:02:40.581576 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-06 03:02:40.856923 | debian-bookworm -> localhost | ok 2025-10-06 03:02:40.864851 | 2025-10-06 03:02:40.864966 | TASK [validate-host : Collect information about the host] 2025-10-06 03:02:41.943523 | debian-bookworm | ok 2025-10-06 03:02:41.952750 | 2025-10-06 03:02:41.952855 | TASK [validate-host : Sanitize hostname] 2025-10-06 03:02:42.050403 | debian-bookworm | ok 2025-10-06 03:02:42.082138 | 2025-10-06 03:02:42.082238 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-06 03:02:42.659285 | debian-bookworm -> localhost | changed 2025-10-06 03:02:42.670521 | 2025-10-06 03:02:42.670627 | TASK [validate-host : Collect information about zuul worker] 2025-10-06 03:02:43.048744 | debian-bookworm | ok 2025-10-06 03:02:43.056592 | 2025-10-06 03:02:43.056721 | TASK [validate-host : Write out all zuul information for each host] 2025-10-06 03:02:43.563649 | debian-bookworm -> localhost | changed 2025-10-06 03:02:43.573416 | 2025-10-06 03:02:43.573504 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-06 03:02:43.835539 | debian-bookworm | ok 2025-10-06 03:02:43.840648 | 2025-10-06 03:02:43.840732 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-06 03:02:45.305681 | debian-bookworm | changed: 2025-10-06 03:02:45.305882 | debian-bookworm | cd+++++++++ src/ 2025-10-06 03:02:45.305918 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-06 03:02:45.305943 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-06 03:02:45.305994 | debian-bookworm | cd+++++++++ src/github.com/osism/node-image/ 2025-10-06 03:02:45.306017 | debian-bookworm | Containerfile 2025-10-06 03:02:45.306350 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006333 2025-10-06 03:03:08.696391 | 2025-10-06 03:03:08.696542 | TASK [upload-logs : Upload logs to log server] 2025-10-06 03:03:09.203250 | localhost | Output suppressed because no_log was given 2025-10-06 03:03:09.204790 | 2025-10-06 03:03:09.204900 | LOOP [upload-logs : Compress console log and json output] 2025-10-06 03:03:09.258051 | localhost | skipping: Conditional result was False 2025-10-06 03:03:09.263193 | localhost | skipping: Conditional result was False 2025-10-06 03:03:09.272739 | 2025-10-06 03:03:09.272937 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-06 03:03:09.327681 | localhost | skipping: Conditional result was False 2025-10-06 03:03:09.328949 | 2025-10-06 03:03:09.331795 | localhost | skipping: Conditional result was False 2025-10-06 03:03:09.344341 | 2025-10-06 03:03:09.344566 | LOOP [upload-logs : Upload console log and json output]