2025-07-18 03:14:03.620975 | Job console starting 2025-07-18 03:14:03.634193 | Updating git repos 2025-07-18 03:14:03.652110 | Cloning repos into workspace 2025-07-18 03:14:03.695384 | Restoring repo states 2025-07-18 03:14:03.700495 | Merging changes 2025-07-18 03:14:03.700509 | Checking out repos 2025-07-18 03:14:03.747856 | Preparing playbooks 2025-07-18 03:14:04.300120 | Running Ansible setup 2025-07-18 03:14:08.916747 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-18 03:14:09.709538 | 2025-07-18 03:14:09.709717 | PLAY [Base pre] 2025-07-18 03:14:09.725966 | 2025-07-18 03:14:09.726113 | TASK [Setup log path fact] 2025-07-18 03:14:09.755593 | debian-bookworm | ok 2025-07-18 03:14:09.770953 | 2025-07-18 03:14:09.771108 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-18 03:14:09.802994 | debian-bookworm | ok 2025-07-18 03:14:09.813923 | 2025-07-18 03:14:09.814033 | TASK [emit-job-header : Print job information] 2025-07-18 03:14:09.853498 | # Job Information 2025-07-18 03:14:09.853655 | Ansible Version: 2.16.14 2025-07-18 03:14:09.853691 | Job: python-black 2025-07-18 03:14:09.853724 | Pipeline: periodic-daily 2025-07-18 03:14:09.853747 | Executor: 521e9411259a 2025-07-18 03:14:09.853768 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-07-18 03:14:09.853789 | Event ID: 85f9bed91b79485584a9bab80cc99db6 2025-07-18 03:14:09.858391 | 2025-07-18 03:14:09.858481 | LOOP [emit-job-header : Print node information] 2025-07-18 03:14:09.993663 | debian-bookworm | ok: 2025-07-18 03:14:09.993947 | debian-bookworm | # Node Information 2025-07-18 03:14:09.994006 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-18 03:14:09.994049 | debian-bookworm | Hostname: debian 2025-07-18 03:14:09.994085 | debian-bookworm | Username: zuul 2025-07-18 03:14:09.994119 | debian-bookworm | Distro: Debian 12.11 2025-07-18 03:14:09.994159 | debian-bookworm | Provider: regiocloud-a 2025-07-18 03:14:09.994194 | debian-bookworm | Region: 2025-07-18 03:14:09.994230 | debian-bookworm | Label: debian-bookworm 2025-07-18 03:14:09.994264 | debian-bookworm | Product Name: OpenStack Nova 2025-07-18 03:14:09.994297 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe19:c19d 2025-07-18 03:14:10.012698 | 2025-07-18 03:14:10.012838 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-18 03:14:10.461808 | debian-bookworm -> localhost | changed 2025-07-18 03:14:10.470612 | 2025-07-18 03:14:10.470749 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-18 03:14:11.397547 | debian-bookworm -> localhost | changed 2025-07-18 03:14:11.407996 | 2025-07-18 03:14:11.408098 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-18 03:14:11.675125 | debian-bookworm -> localhost | ok 2025-07-18 03:14:11.690013 | 2025-07-18 03:14:11.690256 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-18 03:14:11.709204 | debian-bookworm | ok 2025-07-18 03:14:11.729220 | debian-bookworm | included: /var/lib/zuul/builds/a65a8d5ab78548d3b3ece8c4a55b493d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-18 03:14:11.735456 | 2025-07-18 03:14:11.735557 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-18 03:14:13.323922 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-18 03:14:13.324326 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a65a8d5ab78548d3b3ece8c4a55b493d/work/a65a8d5ab78548d3b3ece8c4a55b493d_id_rsa 2025-07-18 03:14:13.324396 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a65a8d5ab78548d3b3ece8c4a55b493d/work/a65a8d5ab78548d3b3ece8c4a55b493d_id_rsa.pub 2025-07-18 03:14:13.324442 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-18 03:14:13.324485 | debian-bookworm -> localhost | SHA256:w13uejZbY82Okq5W7RchmVUb5SIwNAL/lkietfw5P9c zuul-build-sshkey 2025-07-18 03:14:13.324525 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-18 03:14:13.324578 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-18 03:14:13.324617 | debian-bookworm -> localhost | | ....= .=| 2025-07-18 03:14:13.324657 | debian-bookworm -> localhost | | . . + oo| 2025-07-18 03:14:13.324694 | debian-bookworm -> localhost | | o . o =..| 2025-07-18 03:14:13.324729 | debian-bookworm -> localhost | | + B = = o | 2025-07-18 03:14:13.324765 | debian-bookworm -> localhost | | S B ... .| 2025-07-18 03:14:13.324804 | debian-bookworm -> localhost | | o o...+ | 2025-07-18 03:14:13.324859 | debian-bookworm -> localhost | | .=o+ =| 2025-07-18 03:14:13.324896 | debian-bookworm -> localhost | | ..*=o+E| 2025-07-18 03:14:13.324932 | debian-bookworm -> localhost | | .o=o+o+.| 2025-07-18 03:14:13.324967 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-18 03:14:13.325069 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.143704 2025-07-18 03:14:13.339876 | 2025-07-18 03:14:13.339991 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-18 03:14:13.373045 | debian-bookworm | ok 2025-07-18 03:14:13.382750 | debian-bookworm | included: /var/lib/zuul/builds/a65a8d5ab78548d3b3ece8c4a55b493d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-18 03:14:13.391867 | 2025-07-18 03:14:13.391953 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-18 03:14:13.415850 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:14:13.421867 | 2025-07-18 03:14:13.421965 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-18 03:14:14.039218 | debian-bookworm | changed 2025-07-18 03:14:14.049862 | 2025-07-18 03:14:14.049998 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-18 03:14:14.301616 | debian-bookworm | ok 2025-07-18 03:14:14.307115 | 2025-07-18 03:14:14.307213 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-18 03:14:14.994567 | debian-bookworm | changed 2025-07-18 03:14:15.001301 | 2025-07-18 03:14:15.001397 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-18 03:14:15.679497 | debian-bookworm | changed 2025-07-18 03:14:15.684836 | 2025-07-18 03:14:15.684918 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-18 03:14:15.708428 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:14:15.716608 | 2025-07-18 03:14:15.716772 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-18 03:14:16.251360 | debian-bookworm -> localhost | changed 2025-07-18 03:14:16.263026 | 2025-07-18 03:14:16.263122 | TASK [add-build-sshkey : Add back temp key] 2025-07-18 03:14:16.714020 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a65a8d5ab78548d3b3ece8c4a55b493d/work/a65a8d5ab78548d3b3ece8c4a55b493d_id_rsa (zuul-build-sshkey) 2025-07-18 03:14:16.714488 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018896 2025-07-18 03:14:16.733777 | 2025-07-18 03:14:16.733909 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-18 03:14:17.182885 | debian-bookworm | ok 2025-07-18 03:14:17.188381 | 2025-07-18 03:14:17.188491 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-18 03:14:17.212689 | debian-bookworm | skipping: Conditional result was False 2025-07-18 03:14:17.223730 | 2025-07-18 03:14:17.223870 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-18 03:14:17.772698 | debian-bookworm | ok 2025-07-18 03:14:17.789035 | 2025-07-18 03:14:17.789142 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-18 03:14:17.823564 | debian-bookworm | ok 2025-07-18 03:14:17.833963 | 2025-07-18 03:14:17.834052 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-18 03:14:18.192589 | debian-bookworm -> localhost | ok 2025-07-18 03:14:18.198795 | 2025-07-18 03:14:18.199411 | TASK [validate-host : Collect information about the host] 2025-07-18 03:14:19.319962 | debian-bookworm | ok 2025-07-18 03:14:19.337681 | 2025-07-18 03:14:19.337917 | TASK [validate-host : Sanitize hostname] 2025-07-18 03:14:19.464132 | debian-bookworm | ok 2025-07-18 03:14:19.532601 | 2025-07-18 03:14:19.532792 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-18 03:14:20.396092 | debian-bookworm -> localhost | changed 2025-07-18 03:14:20.403150 | 2025-07-18 03:14:20.403277 | TASK [validate-host : Collect information about zuul worker] 2025-07-18 03:14:20.974468 | debian-bookworm | ok 2025-07-18 03:14:20.983206 | 2025-07-18 03:14:20.983368 | TASK [validate-host : Write out all zuul information for each host] 2025-07-18 03:14:21.705181 | debian-bookworm -> localhost | changed 2025-07-18 03:14:21.720000 | 2025-07-18 03:14:21.720135 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-18 03:14:22.031925 | debian-bookworm | ok 2025-07-18 03:14:22.042112 | 2025-07-18 03:14:22.042256 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-18 03:14:23.115749 | debian-bookworm | changed: 2025-07-18 03:14:23.116280 | debian-bookworm | cd+++++++++ src/ 2025-07-18 03:14:23.116487 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-18 03:14:23.116516 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-18 03:14:23.116540 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-07-18 03:14:23.116562 | debian-bookworm | Containerfile 2025-07-18 03:14:23.116698 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010922 2025-07-18 03:14:48.996211 | 2025-07-18 03:14:48.996326 | TASK [upload-logs : Upload logs to log server] 2025-07-18 03:14:49.730628 | localhost | Output suppressed because no_log was given 2025-07-18 03:14:49.732524 | 2025-07-18 03:14:49.732630 | LOOP [upload-logs : Compress console log and json output] 2025-07-18 03:14:49.797429 | localhost | skipping: Conditional result was False 2025-07-18 03:14:49.802605 | localhost | skipping: Conditional result was False 2025-07-18 03:14:49.815752 | 2025-07-18 03:14:49.815886 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-18 03:14:49.878000 | localhost | skipping: Conditional result was False 2025-07-18 03:14:49.878305 | 2025-07-18 03:14:49.895594 | localhost | skipping: Conditional result was False 2025-07-18 03:14:49.903174 | 2025-07-18 03:14:49.903295 | LOOP [upload-logs : Upload console log and json output]