2025-09-05 03:15:58.178981 | Job console starting 2025-09-05 03:15:58.186353 | Updating git repos 2025-09-05 03:15:58.206657 | Cloning repos into workspace 2025-09-05 03:15:58.255094 | Restoring repo states 2025-09-05 03:15:58.260743 | Merging changes 2025-09-05 03:15:58.260756 | Checking out repos 2025-09-05 03:15:58.289781 | Preparing playbooks 2025-09-05 03:15:59.080141 | Running Ansible setup 2025-09-05 03:16:04.576707 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-05 03:16:05.659015 | 2025-09-05 03:16:05.659124 | PLAY [Base pre] 2025-09-05 03:16:05.674799 | 2025-09-05 03:16:05.674905 | TASK [Setup log path fact] 2025-09-05 03:16:05.693203 | debian-bookworm | ok 2025-09-05 03:16:05.709266 | 2025-09-05 03:16:05.709368 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-05 03:16:05.738466 | debian-bookworm | ok 2025-09-05 03:16:05.748063 | 2025-09-05 03:16:05.748145 | TASK [emit-job-header : Print job information] 2025-09-05 03:16:05.786569 | # Job Information 2025-09-05 03:16:05.786699 | Ansible Version: 2.16.14 2025-09-05 03:16:05.786877 | Job: python-black 2025-09-05 03:16:05.786926 | Pipeline: periodic-daily 2025-09-05 03:16:05.786947 | Executor: 521e9411259a 2025-09-05 03:16:05.786965 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-09-05 03:16:05.786985 | Event ID: 642cd392d5b04d1ab707a51d7e6e88de 2025-09-05 03:16:05.791916 | 2025-09-05 03:16:05.791995 | LOOP [emit-job-header : Print node information] 2025-09-05 03:16:05.901974 | debian-bookworm | ok: 2025-09-05 03:16:05.902136 | debian-bookworm | # Node Information 2025-09-05 03:16:05.902169 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-05 03:16:05.902196 | debian-bookworm | Hostname: debian 2025-09-05 03:16:05.902219 | debian-bookworm | Username: zuul 2025-09-05 03:16:05.902240 | debian-bookworm | Distro: Debian 12.11 2025-09-05 03:16:05.902265 | debian-bookworm | Provider: regiocloud-a 2025-09-05 03:16:05.902287 | debian-bookworm | Region: 2025-09-05 03:16:05.902308 | debian-bookworm | Label: debian-bookworm 2025-09-05 03:16:05.902328 | debian-bookworm | Product Name: OpenStack Nova 2025-09-05 03:16:05.902348 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4c:727 2025-09-05 03:16:05.914526 | 2025-09-05 03:16:05.914613 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-05 03:16:06.341361 | debian-bookworm -> localhost | changed 2025-09-05 03:16:06.348271 | 2025-09-05 03:16:06.348370 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-05 03:16:07.293467 | debian-bookworm -> localhost | changed 2025-09-05 03:16:07.306257 | 2025-09-05 03:16:07.306351 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-05 03:16:07.561441 | debian-bookworm -> localhost | ok 2025-09-05 03:16:07.567582 | 2025-09-05 03:16:07.567680 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-05 03:16:07.585086 | debian-bookworm | ok 2025-09-05 03:16:07.601528 | debian-bookworm | included: /var/lib/zuul/builds/ad13c4ad8123482c92c7d73444ee50e6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-05 03:16:07.607513 | 2025-09-05 03:16:07.607593 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-05 03:16:08.522435 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-05 03:16:08.523112 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ad13c4ad8123482c92c7d73444ee50e6/work/ad13c4ad8123482c92c7d73444ee50e6_id_rsa 2025-09-05 03:16:08.523249 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ad13c4ad8123482c92c7d73444ee50e6/work/ad13c4ad8123482c92c7d73444ee50e6_id_rsa.pub 2025-09-05 03:16:08.523426 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-05 03:16:08.523589 | debian-bookworm -> localhost | SHA256:gOkuAQ9lrr9+Hk3pgKDaKmiq51EP6tkAGrDzLRYA9yQ zuul-build-sshkey 2025-09-05 03:16:08.523815 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-05 03:16:08.524103 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-05 03:16:08.524262 | debian-bookworm -> localhost | |. E . | 2025-09-05 03:16:08.524323 | debian-bookworm -> localhost | |.= + o | 2025-09-05 03:16:08.524502 | debian-bookworm -> localhost | |* . + . | 2025-09-05 03:16:08.524594 | debian-bookworm -> localhost | |oO o o | 2025-09-05 03:16:08.524642 | debian-bookworm -> localhost | |B = = o S | 2025-09-05 03:16:08.524810 | debian-bookworm -> localhost | |oB B B | 2025-09-05 03:16:08.524862 | debian-bookworm -> localhost | |+ @ + + | 2025-09-05 03:16:08.524966 | debian-bookworm -> localhost | |o=.O.. | 2025-09-05 03:16:08.525012 | debian-bookworm -> localhost | |O+*oo | 2025-09-05 03:16:08.525175 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-05 03:16:08.525319 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.471080 2025-09-05 03:16:08.539970 | 2025-09-05 03:16:08.540095 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-05 03:16:08.563391 | debian-bookworm | ok 2025-09-05 03:16:08.578023 | debian-bookworm | included: /var/lib/zuul/builds/ad13c4ad8123482c92c7d73444ee50e6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-05 03:16:08.592599 | 2025-09-05 03:16:08.592761 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-05 03:16:08.617443 | debian-bookworm | skipping: Conditional result was False 2025-09-05 03:16:08.634037 | 2025-09-05 03:16:08.634218 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-05 03:16:09.286798 | debian-bookworm | changed 2025-09-05 03:16:09.307384 | 2025-09-05 03:16:09.307486 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-05 03:16:09.561318 | debian-bookworm | ok 2025-09-05 03:16:09.567183 | 2025-09-05 03:16:09.567274 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-05 03:16:10.228665 | debian-bookworm | changed 2025-09-05 03:16:10.239380 | 2025-09-05 03:16:10.239537 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-05 03:16:10.906587 | debian-bookworm | changed 2025-09-05 03:16:10.913507 | 2025-09-05 03:16:10.913640 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-05 03:16:10.948721 | debian-bookworm | skipping: Conditional result was False 2025-09-05 03:16:10.955828 | 2025-09-05 03:16:10.955962 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-05 03:16:11.671878 | debian-bookworm -> localhost | changed 2025-09-05 03:16:11.705069 | 2025-09-05 03:16:11.705220 | TASK [add-build-sshkey : Add back temp key] 2025-09-05 03:16:12.386852 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ad13c4ad8123482c92c7d73444ee50e6/work/ad13c4ad8123482c92c7d73444ee50e6_id_rsa (zuul-build-sshkey) 2025-09-05 03:16:12.387456 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015334 2025-09-05 03:16:12.398599 | 2025-09-05 03:16:12.398730 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-05 03:16:12.939283 | debian-bookworm | ok 2025-09-05 03:16:12.949938 | 2025-09-05 03:16:12.950061 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-05 03:16:12.975722 | debian-bookworm | skipping: Conditional result was False 2025-09-05 03:16:12.988612 | 2025-09-05 03:16:12.988740 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-05 03:16:13.735056 | debian-bookworm | ok 2025-09-05 03:16:13.800376 | 2025-09-05 03:16:13.800807 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-05 03:16:13.911381 | debian-bookworm | ok 2025-09-05 03:16:13.934444 | 2025-09-05 03:16:13.934574 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-05 03:16:14.713780 | debian-bookworm -> localhost | ok 2025-09-05 03:16:14.720255 | 2025-09-05 03:16:14.720351 | TASK [validate-host : Collect information about the host] 2025-09-05 03:16:15.938422 | debian-bookworm | ok 2025-09-05 03:16:15.959852 | 2025-09-05 03:16:15.959980 | TASK [validate-host : Sanitize hostname] 2025-09-05 03:16:16.120958 | debian-bookworm | ok 2025-09-05 03:16:16.185717 | 2025-09-05 03:16:16.185831 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-05 03:16:16.928253 | debian-bookworm -> localhost | changed 2025-09-05 03:16:16.933709 | 2025-09-05 03:16:16.933798 | TASK [validate-host : Collect information about zuul worker] 2025-09-05 03:16:17.359205 | debian-bookworm | ok 2025-09-05 03:16:17.363603 | 2025-09-05 03:16:17.363690 | TASK [validate-host : Write out all zuul information for each host] 2025-09-05 03:16:17.986444 | debian-bookworm -> localhost | changed 2025-09-05 03:16:17.995659 | 2025-09-05 03:16:17.995755 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-05 03:16:18.292863 | debian-bookworm | ok 2025-09-05 03:16:18.299776 | 2025-09-05 03:16:18.300867 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-05 03:16:19.202337 | debian-bookworm | changed: 2025-09-05 03:16:19.202486 | debian-bookworm | cd+++++++++ src/ 2025-09-05 03:16:19.202515 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-05 03:16:19.202535 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-05 03:16:19.202553 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-09-05 03:16:19.202570 | debian-bookworm | Containerfile 2025-09-05 03:16:19.202680 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010183 2025-09-05 03:16:44.978129 | 2025-09-05 03:16:44.978240 | TASK [upload-logs : Upload logs to log server] 2025-09-05 03:16:45.559391 | localhost | Output suppressed because no_log was given 2025-09-05 03:16:45.562461 | 2025-09-05 03:16:45.562826 | LOOP [upload-logs : Compress console log and json output] 2025-09-05 03:16:45.636493 | localhost | skipping: Conditional result was False 2025-09-05 03:16:45.643493 | localhost | skipping: Conditional result was False 2025-09-05 03:16:45.651343 | 2025-09-05 03:16:45.651510 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-05 03:16:45.715626 | localhost | skipping: Conditional result was False 2025-09-05 03:16:45.715953 | 2025-09-05 03:16:45.722403 | localhost | skipping: Conditional result was False 2025-09-05 03:16:45.733765 | 2025-09-05 03:16:45.734063 | LOOP [upload-logs : Upload console log and json output]