2025-05-19 03:24:32.640929 | Job console starting 2025-05-19 03:24:32.650226 | Updating git repos 2025-05-19 03:24:32.671532 | Cloning repos into workspace 2025-05-19 03:24:32.705986 | Restoring repo states 2025-05-19 03:24:32.713472 | Merging changes 2025-05-19 03:24:32.713492 | Checking out repos 2025-05-19 03:24:32.749008 | Preparing playbooks 2025-05-19 03:24:33.385611 | Running Ansible setup 2025-05-19 03:24:37.608102 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-19 03:24:38.413250 | 2025-05-19 03:24:38.413420 | PLAY [Base pre] 2025-05-19 03:24:38.432014 | 2025-05-19 03:24:38.432166 | TASK [Setup log path fact] 2025-05-19 03:24:38.462142 | debian-bookworm | ok 2025-05-19 03:24:38.479291 | 2025-05-19 03:24:38.479467 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-19 03:24:38.521934 | debian-bookworm | ok 2025-05-19 03:24:38.533776 | 2025-05-19 03:24:38.533933 | TASK [emit-job-header : Print job information] 2025-05-19 03:24:38.581259 | # Job Information 2025-05-19 03:24:38.581579 | Ansible Version: 2.16.14 2025-05-19 03:24:38.581657 | Job: python-black 2025-05-19 03:24:38.581725 | Pipeline: periodic-daily 2025-05-19 03:24:38.581773 | Executor: 521e9411259a 2025-05-19 03:24:38.581816 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-05-19 03:24:38.582002 | Event ID: a1c55cd80bcb4ce9abab8046e12e59ac 2025-05-19 03:24:38.590020 | 2025-05-19 03:24:38.590181 | LOOP [emit-job-header : Print node information] 2025-05-19 03:24:38.705925 | debian-bookworm | ok: 2025-05-19 03:24:38.706124 | debian-bookworm | # Node Information 2025-05-19 03:24:38.706158 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-19 03:24:38.706183 | debian-bookworm | Hostname: debian 2025-05-19 03:24:38.706205 | debian-bookworm | Username: zuul 2025-05-19 03:24:38.706226 | debian-bookworm | Distro: Debian 12.11 2025-05-19 03:24:38.706249 | debian-bookworm | Provider: regiocloud-a 2025-05-19 03:24:38.706269 | debian-bookworm | Region: 2025-05-19 03:24:38.706290 | debian-bookworm | Label: debian-bookworm 2025-05-19 03:24:38.706310 | debian-bookworm | Product Name: OpenStack Nova 2025-05-19 03:24:38.706330 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6c:90a7 2025-05-19 03:24:38.717961 | 2025-05-19 03:24:38.718085 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-19 03:24:39.240311 | debian-bookworm -> localhost | changed 2025-05-19 03:24:39.247862 | 2025-05-19 03:24:39.247991 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-19 03:24:40.379262 | debian-bookworm -> localhost | changed 2025-05-19 03:24:40.405585 | 2025-05-19 03:24:40.405730 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-19 03:24:40.740397 | debian-bookworm -> localhost | ok 2025-05-19 03:24:40.755623 | 2025-05-19 03:24:40.755819 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-19 03:24:40.794006 | debian-bookworm | ok 2025-05-19 03:24:40.817368 | debian-bookworm | included: /var/lib/zuul/builds/cd877f21fbd14edb8bfcbaeec35a6aec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-19 03:24:40.823669 | 2025-05-19 03:24:40.823779 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-19 03:24:41.873024 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-19 03:24:41.873317 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/cd877f21fbd14edb8bfcbaeec35a6aec/work/cd877f21fbd14edb8bfcbaeec35a6aec_id_rsa 2025-05-19 03:24:41.873364 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/cd877f21fbd14edb8bfcbaeec35a6aec/work/cd877f21fbd14edb8bfcbaeec35a6aec_id_rsa.pub 2025-05-19 03:24:41.873399 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-19 03:24:41.873427 | debian-bookworm -> localhost | SHA256:e52wSzus4kwErP/F4bTMLfvHsnZM5ujerA/Vjk29Zw0 zuul-build-sshkey 2025-05-19 03:24:41.873451 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-19 03:24:41.873488 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-19 03:24:41.873512 | debian-bookworm -> localhost | | | 2025-05-19 03:24:41.873536 | debian-bookworm -> localhost | | . | 2025-05-19 03:24:41.873559 | debian-bookworm -> localhost | | o | 2025-05-19 03:24:41.873582 | debian-bookworm -> localhost | | . . . . | 2025-05-19 03:24:41.873604 | debian-bookworm -> localhost | | . . S . . E .| 2025-05-19 03:24:41.873632 | debian-bookworm -> localhost | | . . * = =o* .o| 2025-05-19 03:24:41.873655 | debian-bookworm -> localhost | | . . X.*B+ o.+| 2025-05-19 03:24:41.873677 | debian-bookworm -> localhost | | +.. =*** ..| 2025-05-19 03:24:41.873699 | debian-bookworm -> localhost | | .+.o*OO+ | 2025-05-19 03:24:41.873721 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-19 03:24:41.873779 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.532915 2025-05-19 03:24:41.880696 | 2025-05-19 03:24:41.880866 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-19 03:24:41.928297 | debian-bookworm | ok 2025-05-19 03:24:41.941594 | debian-bookworm | included: /var/lib/zuul/builds/cd877f21fbd14edb8bfcbaeec35a6aec/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-19 03:24:41.952030 | 2025-05-19 03:24:41.952140 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-19 03:24:41.976390 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:24:41.982753 | 2025-05-19 03:24:41.982933 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-19 03:24:42.676021 | debian-bookworm | changed 2025-05-19 03:24:42.681840 | 2025-05-19 03:24:42.681958 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-19 03:24:42.961917 | debian-bookworm | ok 2025-05-19 03:24:42.971663 | 2025-05-19 03:24:42.971814 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-19 03:24:43.679397 | debian-bookworm | changed 2025-05-19 03:24:43.689593 | 2025-05-19 03:24:43.689741 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-19 03:24:44.393801 | debian-bookworm | changed 2025-05-19 03:24:44.409486 | 2025-05-19 03:24:44.409674 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-19 03:24:44.435651 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:24:44.447643 | 2025-05-19 03:24:44.447809 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-19 03:24:44.950755 | debian-bookworm -> localhost | changed 2025-05-19 03:24:44.967536 | 2025-05-19 03:24:44.967815 | TASK [add-build-sshkey : Add back temp key] 2025-05-19 03:24:45.399722 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/cd877f21fbd14edb8bfcbaeec35a6aec/work/cd877f21fbd14edb8bfcbaeec35a6aec_id_rsa (zuul-build-sshkey) 2025-05-19 03:24:45.400000 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017196 2025-05-19 03:24:45.421572 | 2025-05-19 03:24:45.421717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-19 03:24:45.894199 | debian-bookworm | ok 2025-05-19 03:24:45.903503 | 2025-05-19 03:24:45.903644 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-19 03:24:45.940423 | debian-bookworm | skipping: Conditional result was False 2025-05-19 03:24:45.954263 | 2025-05-19 03:24:45.954673 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-19 03:24:46.398230 | debian-bookworm | ok 2025-05-19 03:24:46.409605 | 2025-05-19 03:24:46.409739 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-19 03:24:46.448939 | debian-bookworm | ok 2025-05-19 03:24:46.454087 | 2025-05-19 03:24:46.454198 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-19 03:24:46.881723 | debian-bookworm -> localhost | ok 2025-05-19 03:24:46.889217 | 2025-05-19 03:24:46.889354 | TASK [validate-host : Collect information about the host] 2025-05-19 03:24:48.058911 | debian-bookworm | ok 2025-05-19 03:24:48.078116 | 2025-05-19 03:24:48.078324 | TASK [validate-host : Sanitize hostname] 2025-05-19 03:24:48.211935 | debian-bookworm | ok 2025-05-19 03:24:48.257026 | 2025-05-19 03:24:48.257173 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-19 03:24:48.966183 | debian-bookworm -> localhost | changed 2025-05-19 03:24:48.974087 | 2025-05-19 03:24:48.974215 | TASK [validate-host : Collect information about zuul worker] 2025-05-19 03:24:49.389470 | debian-bookworm | ok 2025-05-19 03:24:49.394352 | 2025-05-19 03:24:49.394471 | TASK [validate-host : Write out all zuul information for each host] 2025-05-19 03:24:49.926086 | debian-bookworm -> localhost | changed 2025-05-19 03:24:49.940499 | 2025-05-19 03:24:49.940629 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-19 03:24:50.233174 | debian-bookworm | ok 2025-05-19 03:24:50.241477 | 2025-05-19 03:24:50.241623 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-19 03:24:51.138605 | debian-bookworm | changed: 2025-05-19 03:24:51.138800 | debian-bookworm | cd+++++++++ src/ 2025-05-19 03:24:51.138888 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-19 03:24:51.138913 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-19 03:24:51.138934 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-19 03:24:51.138954 | debian-bookworm | Containerfile 2025-05-19 03:24:51.139082 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009399 2025-05-19 03:25:16.466237 | 2025-05-19 03:25:16.466360 | TASK [upload-logs : Upload logs to log server] 2025-05-19 03:25:17.104519 | localhost | Output suppressed because no_log was given 2025-05-19 03:25:17.107005 | 2025-05-19 03:25:17.107119 | LOOP [upload-logs : Compress console log and json output] 2025-05-19 03:25:17.174823 | localhost | skipping: Conditional result was False 2025-05-19 03:25:17.184508 | localhost | skipping: Conditional result was False 2025-05-19 03:25:17.196592 | 2025-05-19 03:25:17.196861 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-19 03:25:17.269543 | localhost | skipping: Conditional result was False 2025-05-19 03:25:17.269767 | 2025-05-19 03:25:17.270734 | localhost | skipping: Conditional result was False 2025-05-19 03:25:17.276003 | 2025-05-19 03:25:17.276154 | LOOP [upload-logs : Upload console log and json output]