2025-07-28 03:11:46.407225 | Job console starting 2025-07-28 03:11:46.419265 | Updating git repos 2025-07-28 03:11:46.495180 | Cloning repos into workspace 2025-07-28 03:11:46.621955 | Restoring repo states 2025-07-28 03:11:46.655158 | Merging changes 2025-07-28 03:11:46.655177 | Checking out repos 2025-07-28 03:11:46.819329 | Preparing playbooks 2025-07-28 03:11:48.100529 | Running Ansible setup 2025-07-28 03:11:54.118728 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-28 03:11:54.913182 | 2025-07-28 03:11:54.913289 | PLAY [Base pre] 2025-07-28 03:11:54.925709 | 2025-07-28 03:11:54.925797 | TASK [Setup log path fact] 2025-07-28 03:11:54.952478 | debian-bookworm | ok 2025-07-28 03:11:54.964338 | 2025-07-28 03:11:54.964440 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-28 03:11:54.995275 | debian-bookworm | ok 2025-07-28 03:11:55.002949 | 2025-07-28 03:11:55.003037 | TASK [emit-job-header : Print job information] 2025-07-28 03:11:55.040134 | # Job Information 2025-07-28 03:11:55.040269 | Ansible Version: 2.16.14 2025-07-28 03:11:55.040297 | Job: python-black 2025-07-28 03:11:55.040323 | Pipeline: periodic-daily 2025-07-28 03:11:55.040342 | Executor: 521e9411259a 2025-07-28 03:11:55.040359 | Triggered by: https://github.com/osism/python-osism 2025-07-28 03:11:55.040377 | Event ID: fb3401ac249446b4a7e29ed9883662aa 2025-07-28 03:11:55.044270 | 2025-07-28 03:11:55.044347 | LOOP [emit-job-header : Print node information] 2025-07-28 03:11:55.174087 | debian-bookworm | ok: 2025-07-28 03:11:55.174275 | debian-bookworm | # Node Information 2025-07-28 03:11:55.174318 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-28 03:11:55.174349 | debian-bookworm | Hostname: debian 2025-07-28 03:11:55.174376 | debian-bookworm | Username: zuul 2025-07-28 03:11:55.174401 | debian-bookworm | Distro: Debian 12.11 2025-07-28 03:11:55.174430 | debian-bookworm | Provider: regiocloud-a 2025-07-28 03:11:55.174457 | debian-bookworm | Region: 2025-07-28 03:11:55.174483 | debian-bookworm | Label: debian-bookworm 2025-07-28 03:11:55.174508 | debian-bookworm | Product Name: OpenStack Nova 2025-07-28 03:11:55.174533 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe57:4cbf 2025-07-28 03:11:55.190390 | 2025-07-28 03:11:55.190529 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-28 03:11:55.602823 | debian-bookworm -> localhost | changed 2025-07-28 03:11:55.608468 | 2025-07-28 03:11:55.608556 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-28 03:11:56.817124 | debian-bookworm -> localhost | changed 2025-07-28 03:11:56.827208 | 2025-07-28 03:11:56.827298 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-28 03:11:57.281586 | debian-bookworm -> localhost | ok 2025-07-28 03:11:57.287491 | 2025-07-28 03:11:57.287595 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-28 03:11:57.315415 | debian-bookworm | ok 2025-07-28 03:11:57.341697 | debian-bookworm | included: /var/lib/zuul/builds/b89250252be44681b6da1ecddaa8bb6e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-28 03:11:57.356205 | 2025-07-28 03:11:57.356305 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-28 03:12:00.142028 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-28 03:12:00.142228 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b89250252be44681b6da1ecddaa8bb6e/work/b89250252be44681b6da1ecddaa8bb6e_id_rsa 2025-07-28 03:12:00.142268 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b89250252be44681b6da1ecddaa8bb6e/work/b89250252be44681b6da1ecddaa8bb6e_id_rsa.pub 2025-07-28 03:12:00.142296 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-28 03:12:00.142320 | debian-bookworm -> localhost | SHA256:smlC7WTEJsw5NRnylJ491Y9nAbuBGHFLDzTMkR2Jptg zuul-build-sshkey 2025-07-28 03:12:00.142342 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-28 03:12:00.142374 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-28 03:12:00.142397 | debian-bookworm -> localhost | | . =+o=B*o+ | 2025-07-28 03:12:00.142434 | debian-bookworm -> localhost | | o Bo. =B*+.. | 2025-07-28 03:12:00.142457 | debian-bookworm -> localhost | | *.==.+o +o . | 2025-07-28 03:12:00.142478 | debian-bookworm -> localhost | | *+ E .o+ | 2025-07-28 03:12:00.142498 | debian-bookworm -> localhost | | . = S. .o | 2025-07-28 03:12:00.142521 | debian-bookworm -> localhost | | . + + | 2025-07-28 03:12:00.142543 | debian-bookworm -> localhost | | . = | 2025-07-28 03:12:00.142564 | debian-bookworm -> localhost | | o | 2025-07-28 03:12:00.142585 | debian-bookworm -> localhost | | | 2025-07-28 03:12:00.142606 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-28 03:12:00.142672 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.196349 2025-07-28 03:12:00.149334 | 2025-07-28 03:12:00.149435 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-28 03:12:00.167680 | debian-bookworm | ok 2025-07-28 03:12:00.176520 | debian-bookworm | included: /var/lib/zuul/builds/b89250252be44681b6da1ecddaa8bb6e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-28 03:12:00.185694 | 2025-07-28 03:12:00.185785 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-28 03:12:00.209799 | debian-bookworm | skipping: Conditional result was False 2025-07-28 03:12:00.215604 | 2025-07-28 03:12:00.215711 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-28 03:12:00.903351 | debian-bookworm | changed 2025-07-28 03:12:00.910595 | 2025-07-28 03:12:00.910710 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-28 03:12:01.185185 | debian-bookworm | ok 2025-07-28 03:12:01.195059 | 2025-07-28 03:12:01.195152 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-28 03:12:01.849892 | debian-bookworm | changed 2025-07-28 03:12:01.862590 | 2025-07-28 03:12:01.862729 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-28 03:12:02.562768 | debian-bookworm | changed 2025-07-28 03:12:02.568053 | 2025-07-28 03:12:02.568134 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-28 03:12:02.581136 | debian-bookworm | skipping: Conditional result was False 2025-07-28 03:12:02.587878 | 2025-07-28 03:12:02.587989 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-28 03:12:02.977846 | debian-bookworm -> localhost | changed 2025-07-28 03:12:03.001397 | 2025-07-28 03:12:03.001527 | TASK [add-build-sshkey : Add back temp key] 2025-07-28 03:12:03.355180 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b89250252be44681b6da1ecddaa8bb6e/work/b89250252be44681b6da1ecddaa8bb6e_id_rsa (zuul-build-sshkey) 2025-07-28 03:12:03.355375 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008652 2025-07-28 03:12:03.361662 | 2025-07-28 03:12:03.361748 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-28 03:12:03.728711 | debian-bookworm | ok 2025-07-28 03:12:03.735391 | 2025-07-28 03:12:03.735491 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-28 03:12:03.769469 | debian-bookworm | skipping: Conditional result was False 2025-07-28 03:12:03.788172 | 2025-07-28 03:12:03.788302 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-28 03:12:04.217520 | debian-bookworm | ok 2025-07-28 03:12:04.229993 | 2025-07-28 03:12:04.230091 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-28 03:12:04.271314 | debian-bookworm | ok 2025-07-28 03:12:04.278263 | 2025-07-28 03:12:04.278371 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-28 03:12:04.545438 | debian-bookworm -> localhost | ok 2025-07-28 03:12:04.552112 | 2025-07-28 03:12:04.552196 | TASK [validate-host : Collect information about the host] 2025-07-28 03:12:05.645136 | debian-bookworm | ok 2025-07-28 03:12:05.656329 | 2025-07-28 03:12:05.656470 | TASK [validate-host : Sanitize hostname] 2025-07-28 03:12:05.773531 | debian-bookworm | ok 2025-07-28 03:12:05.823342 | 2025-07-28 03:12:05.823482 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-28 03:12:06.416398 | debian-bookworm -> localhost | changed 2025-07-28 03:12:06.422513 | 2025-07-28 03:12:06.422649 | TASK [validate-host : Collect information about zuul worker] 2025-07-28 03:12:06.839661 | debian-bookworm | ok 2025-07-28 03:12:06.847914 | 2025-07-28 03:12:06.848062 | TASK [validate-host : Write out all zuul information for each host] 2025-07-28 03:12:07.402820 | debian-bookworm -> localhost | changed 2025-07-28 03:12:07.416104 | 2025-07-28 03:12:07.416249 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-28 03:12:07.688870 | debian-bookworm | ok 2025-07-28 03:12:07.697572 | 2025-07-28 03:12:07.697748 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-28 03:12:08.730105 | debian-bookworm | changed: 2025-07-28 03:12:08.730328 | debian-bookworm | cd+++++++++ src/ 2025-07-28 03:12:08.730365 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-28 03:12:08.730390 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-28 03:12:08.730412 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-07-28 03:12:08.730433 | debian-bookworm | Containerfile 2025-07-28 03:12:08.730551 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012344 2025-07-28 03:12:35.995653 | 2025-07-28 03:12:35.995774 | TASK [upload-logs : Upload logs to log server] 2025-07-28 03:12:36.656311 | localhost | Output suppressed because no_log was given 2025-07-28 03:12:36.660956 | 2025-07-28 03:12:36.661167 | LOOP [upload-logs : Compress console log and json output] 2025-07-28 03:12:36.725379 | localhost | skipping: Conditional result was False 2025-07-28 03:12:36.734082 | localhost | skipping: Conditional result was False 2025-07-28 03:12:36.741157 | 2025-07-28 03:12:36.741278 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-28 03:12:36.812919 | localhost | skipping: Conditional result was False 2025-07-28 03:12:36.813315 | 2025-07-28 03:12:36.824713 | localhost | skipping: Conditional result was False 2025-07-28 03:12:36.829492 | 2025-07-28 03:12:36.829640 | LOOP [upload-logs : Upload console log and json output]