2026-01-03 03:18:23.489791 | Job console starting 2026-01-03 03:18:23.499527 | Updating git repos 2026-01-03 03:18:23.515857 | Cloning repos into workspace 2026-01-03 03:18:23.602693 | Restoring repo states 2026-01-03 03:18:23.619140 | Merging changes 2026-01-03 03:18:23.619186 | Checking out repos 2026-01-03 03:18:23.723510 | Preparing playbooks 2026-01-03 03:18:24.727165 | Running Ansible setup 2026-01-03 03:18:32.538158 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-03 03:18:35.244682 | 2026-01-03 03:18:35.244862 | PLAY [Base pre] 2026-01-03 03:18:35.278605 | 2026-01-03 03:18:35.279195 | TASK [Setup log path fact] 2026-01-03 03:18:35.326418 | debian-bookworm | ok 2026-01-03 03:18:35.355758 | 2026-01-03 03:18:35.356505 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-03 03:18:35.399604 | debian-bookworm | ok 2026-01-03 03:18:35.413240 | 2026-01-03 03:18:35.413375 | TASK [emit-job-header : Print job information] 2026-01-03 03:18:35.487535 | # Job Information 2026-01-03 03:18:35.487735 | Ansible Version: 2.16.14 2026-01-03 03:18:35.487771 | Job: python-black 2026-01-03 03:18:35.487803 | Pipeline: periodic-daily 2026-01-03 03:18:35.487826 | Executor: 521e9411259a 2026-01-03 03:18:35.487846 | Triggered by: https://github.com/osism/cfg-cookiecutter 2026-01-03 03:18:35.487867 | Event ID: 911e57afb67f474aa3451f928b64900b 2026-01-03 03:18:35.498008 | 2026-01-03 03:18:35.498151 | LOOP [emit-job-header : Print node information] 2026-01-03 03:18:35.642148 | debian-bookworm | ok: 2026-01-03 03:18:35.642522 | debian-bookworm | # Node Information 2026-01-03 03:18:35.642569 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-03 03:18:35.642597 | debian-bookworm | Hostname: debian 2026-01-03 03:18:35.642619 | debian-bookworm | Username: zuul 2026-01-03 03:18:35.642640 | debian-bookworm | Distro: Debian 12.12 2026-01-03 03:18:35.642664 | debian-bookworm | Provider: regiocloud-a 2026-01-03 03:18:35.642685 | debian-bookworm | Region: 2026-01-03 03:18:35.642706 | debian-bookworm | Label: debian-bookworm 2026-01-03 03:18:35.642726 | debian-bookworm | Product Name: OpenStack Nova 2026-01-03 03:18:35.642745 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2b:c819 2026-01-03 03:18:35.665378 | 2026-01-03 03:18:35.665582 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-03 03:18:36.804913 | debian-bookworm -> localhost | changed 2026-01-03 03:18:36.816852 | 2026-01-03 03:18:36.817125 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-03 03:18:38.422767 | debian-bookworm -> localhost | changed 2026-01-03 03:18:38.436200 | 2026-01-03 03:18:38.436336 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-03 03:18:38.821644 | debian-bookworm -> localhost | ok 2026-01-03 03:18:38.828895 | 2026-01-03 03:18:38.829073 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-03 03:18:38.903795 | debian-bookworm | ok 2026-01-03 03:18:38.940418 | debian-bookworm | included: /var/lib/zuul/builds/1f0ff10d04a141eb8000d8cc93e5c8b7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-03 03:18:38.947713 | 2026-01-03 03:18:38.947835 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-03 03:18:41.262136 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-03 03:18:41.262770 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1f0ff10d04a141eb8000d8cc93e5c8b7/work/1f0ff10d04a141eb8000d8cc93e5c8b7_id_rsa 2026-01-03 03:18:41.263318 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1f0ff10d04a141eb8000d8cc93e5c8b7/work/1f0ff10d04a141eb8000d8cc93e5c8b7_id_rsa.pub 2026-01-03 03:18:41.263355 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-03 03:18:41.263424 | debian-bookworm -> localhost | SHA256:Z/hRoJPXQGalDrc2bV+0v6hLRO1dzhn25A/F0Q3VZAo zuul-build-sshkey 2026-01-03 03:18:41.263452 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-03 03:18:41.263485 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-03 03:18:41.263557 | debian-bookworm -> localhost | | .*.E .=B| 2026-01-03 03:18:41.263583 | debian-bookworm -> localhost | | = =.. +=| 2026-01-03 03:18:41.263605 | debian-bookworm -> localhost | | = +.o..o*| 2026-01-03 03:18:41.263625 | debian-bookworm -> localhost | | B.+. oB*| 2026-01-03 03:18:41.263645 | debian-bookworm -> localhost | | S O.o..+*| 2026-01-03 03:18:41.263672 | debian-bookworm -> localhost | | =.+ . oo| 2026-01-03 03:18:41.263692 | debian-bookworm -> localhost | | .. . o| 2026-01-03 03:18:41.263712 | debian-bookworm -> localhost | | . . .| 2026-01-03 03:18:41.263733 | debian-bookworm -> localhost | | oo. . | 2026-01-03 03:18:41.263753 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-03 03:18:41.263821 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.491268 2026-01-03 03:18:41.276819 | 2026-01-03 03:18:41.276956 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-03 03:18:41.318605 | debian-bookworm | ok 2026-01-03 03:18:41.332661 | debian-bookworm | included: /var/lib/zuul/builds/1f0ff10d04a141eb8000d8cc93e5c8b7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-03 03:18:41.344420 | 2026-01-03 03:18:41.344558 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-03 03:18:41.369028 | debian-bookworm | skipping: Conditional result was False 2026-01-03 03:18:41.379641 | 2026-01-03 03:18:41.379808 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-03 03:18:42.142228 | debian-bookworm | changed 2026-01-03 03:18:42.152800 | 2026-01-03 03:18:42.152958 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-03 03:18:42.407119 | debian-bookworm | ok 2026-01-03 03:18:42.421999 | 2026-01-03 03:18:42.422151 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-03 03:18:43.121223 | debian-bookworm | changed 2026-01-03 03:18:43.132350 | 2026-01-03 03:18:43.132558 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-03 03:18:43.768520 | debian-bookworm | changed 2026-01-03 03:18:43.774250 | 2026-01-03 03:18:43.774373 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-03 03:18:43.801911 | debian-bookworm | skipping: Conditional result was False 2026-01-03 03:18:43.813757 | 2026-01-03 03:18:43.813900 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-03 03:18:44.446304 | debian-bookworm -> localhost | changed 2026-01-03 03:18:44.472931 | 2026-01-03 03:18:44.473109 | TASK [add-build-sshkey : Add back temp key] 2026-01-03 03:18:45.232360 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1f0ff10d04a141eb8000d8cc93e5c8b7/work/1f0ff10d04a141eb8000d8cc93e5c8b7_id_rsa (zuul-build-sshkey) 2026-01-03 03:18:45.232633 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026828 2026-01-03 03:18:45.249471 | 2026-01-03 03:18:45.258648 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-03 03:18:45.858638 | debian-bookworm | ok 2026-01-03 03:18:45.869194 | 2026-01-03 03:18:45.869332 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-03 03:18:45.909246 | debian-bookworm | skipping: Conditional result was False 2026-01-03 03:18:45.935250 | 2026-01-03 03:18:45.935455 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-03 03:18:46.513175 | debian-bookworm | ok 2026-01-03 03:18:46.544678 | 2026-01-03 03:18:46.544826 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-03 03:18:46.658317 | debian-bookworm | ok 2026-01-03 03:18:46.676437 | 2026-01-03 03:18:46.676593 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-03 03:18:47.487508 | debian-bookworm -> localhost | ok 2026-01-03 03:18:47.494258 | 2026-01-03 03:18:47.494373 | TASK [validate-host : Collect information about the host] 2026-01-03 03:18:48.790642 | debian-bookworm | ok 2026-01-03 03:18:48.806042 | 2026-01-03 03:18:48.806169 | TASK [validate-host : Sanitize hostname] 2026-01-03 03:18:48.964061 | debian-bookworm | ok 2026-01-03 03:18:49.059571 | 2026-01-03 03:18:49.059735 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-03 03:18:50.479539 | debian-bookworm -> localhost | changed 2026-01-03 03:18:50.497204 | 2026-01-03 03:18:50.497361 | TASK [validate-host : Collect information about zuul worker] 2026-01-03 03:18:51.112820 | debian-bookworm | ok 2026-01-03 03:18:51.127004 | 2026-01-03 03:18:51.127156 | TASK [validate-host : Write out all zuul information for each host] 2026-01-03 03:18:52.150908 | debian-bookworm -> localhost | changed 2026-01-03 03:18:52.196580 | 2026-01-03 03:18:52.196749 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-03 03:18:52.536896 | debian-bookworm | ok 2026-01-03 03:18:52.554786 | 2026-01-03 03:18:52.554965 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-03 03:18:54.106347 | debian-bookworm | changed: 2026-01-03 03:18:54.106590 | debian-bookworm | cd+++++++++ src/ 2026-01-03 03:18:54.106625 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-03 03:18:54.106650 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-03 03:18:54.106672 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-01-03 03:18:54.106692 | debian-bookworm | Containerfile 2026-01-03 03:18:54.106821 | debian-bookworm | localhost | ok: Runtime: 0:00:00.016355 2026-01-03 03:19:30.329613 | 2026-01-03 03:19:30.329760 | TASK [upload-logs : Upload logs to log server] 2026-01-03 03:19:32.056090 | localhost | Output suppressed because no_log was given 2026-01-03 03:19:32.058003 | 2026-01-03 03:19:32.058111 | LOOP [upload-logs : Compress console log and json output] 2026-01-03 03:19:32.121234 | localhost | skipping: Conditional result was False 2026-01-03 03:19:32.130692 | localhost | skipping: Conditional result was False 2026-01-03 03:19:32.138193 | 2026-01-03 03:19:32.138325 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-03 03:19:32.202745 | localhost | skipping: Conditional result was False 2026-01-03 03:19:32.203179 | 2026-01-03 03:19:32.215500 | localhost | skipping: Conditional result was False 2026-01-03 03:19:32.229648 | 2026-01-03 03:19:32.230074 | LOOP [upload-logs : Upload console log and json output]