2025-09-22 03:09:35.158328 | Job console starting 2025-09-22 03:09:35.169194 | Updating git repos 2025-09-22 03:09:35.209354 | Cloning repos into workspace 2025-09-22 03:09:35.287681 | Restoring repo states 2025-09-22 03:09:35.307400 | Merging changes 2025-09-22 03:09:35.307417 | Checking out repos 2025-09-22 03:09:35.396822 | Preparing playbooks 2025-09-22 03:09:36.768395 | Running Ansible setup 2025-09-22 03:09:41.791501 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-22 03:09:42.934951 | 2025-09-22 03:09:42.935121 | PLAY [Base pre] 2025-09-22 03:09:42.974409 | 2025-09-22 03:09:42.974600 | TASK [Setup log path fact] 2025-09-22 03:09:43.013840 | debian-bookworm | ok 2025-09-22 03:09:43.039671 | 2025-09-22 03:09:43.039845 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-22 03:09:43.078306 | debian-bookworm | ok 2025-09-22 03:09:43.088881 | 2025-09-22 03:09:43.089006 | TASK [emit-job-header : Print job information] 2025-09-22 03:09:43.159233 | # Job Information 2025-09-22 03:09:43.159441 | Ansible Version: 2.16.14 2025-09-22 03:09:43.159492 | Job: python-black 2025-09-22 03:09:43.159528 | Pipeline: periodic-daily 2025-09-22 03:09:43.159551 | Executor: 521e9411259a 2025-09-22 03:09:43.159571 | Triggered by: https://github.com/osism/python-osism 2025-09-22 03:09:43.159593 | Event ID: a7687acf4d514509817fd6f2dbe621a2 2025-09-22 03:09:43.165800 | 2025-09-22 03:09:43.165939 | LOOP [emit-job-header : Print node information] 2025-09-22 03:09:43.381142 | debian-bookworm | ok: 2025-09-22 03:09:43.381383 | debian-bookworm | # Node Information 2025-09-22 03:09:43.381419 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-22 03:09:43.381445 | debian-bookworm | Hostname: debian 2025-09-22 03:09:43.381467 | debian-bookworm | Username: zuul 2025-09-22 03:09:43.381531 | debian-bookworm | Distro: Debian 12.12 2025-09-22 03:09:43.381557 | debian-bookworm | Provider: regiocloud-a 2025-09-22 03:09:43.381578 | debian-bookworm | Region: 2025-09-22 03:09:43.381601 | debian-bookworm | Label: debian-bookworm 2025-09-22 03:09:43.381621 | debian-bookworm | Product Name: OpenStack Nova 2025-09-22 03:09:43.381641 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec5:3ada 2025-09-22 03:09:43.394051 | 2025-09-22 03:09:43.394181 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-22 03:09:44.184012 | debian-bookworm -> localhost | changed 2025-09-22 03:09:44.191594 | 2025-09-22 03:09:44.191720 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-22 03:09:45.713323 | debian-bookworm -> localhost | changed 2025-09-22 03:09:45.729098 | 2025-09-22 03:09:45.729201 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-22 03:09:46.196836 | debian-bookworm -> localhost | ok 2025-09-22 03:09:46.202552 | 2025-09-22 03:09:46.202647 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-22 03:09:46.223911 | debian-bookworm | ok 2025-09-22 03:09:46.242811 | debian-bookworm | included: /var/lib/zuul/builds/ae51c5d221ed476d81ab19ec44ad356d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-22 03:09:46.248480 | 2025-09-22 03:09:46.248568 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-22 03:09:48.219295 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-22 03:09:48.219497 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ae51c5d221ed476d81ab19ec44ad356d/work/ae51c5d221ed476d81ab19ec44ad356d_id_rsa 2025-09-22 03:09:48.219533 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ae51c5d221ed476d81ab19ec44ad356d/work/ae51c5d221ed476d81ab19ec44ad356d_id_rsa.pub 2025-09-22 03:09:48.219557 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-22 03:09:48.219578 | debian-bookworm -> localhost | SHA256:XgQVsLu6kQR8J3UrB1v8+mS5JTUZ6R3dCljQhraz0XU zuul-build-sshkey 2025-09-22 03:09:48.219597 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-22 03:09:48.219624 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-22 03:09:48.219645 | debian-bookworm -> localhost | | =+*B. .o| 2025-09-22 03:09:48.219665 | debian-bookworm -> localhost | | . . B=.+ +.E| 2025-09-22 03:09:48.219684 | debian-bookworm -> localhost | | o o =.+= + *.| 2025-09-22 03:09:48.219703 | debian-bookworm -> localhost | | o o =+ o * .| 2025-09-22 03:09:48.219722 | debian-bookworm -> localhost | | . S .= o . | 2025-09-22 03:09:48.219744 | debian-bookworm -> localhost | | . o oo = . | 2025-09-22 03:09:48.219762 | debian-bookworm -> localhost | | o o + + | 2025-09-22 03:09:48.219781 | debian-bookworm -> localhost | | o o | 2025-09-22 03:09:48.219800 | debian-bookworm -> localhost | | o. | 2025-09-22 03:09:48.219819 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-22 03:09:48.219866 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.383062 2025-09-22 03:09:48.224944 | 2025-09-22 03:09:48.225021 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-22 03:09:48.243723 | debian-bookworm | ok 2025-09-22 03:09:48.251249 | debian-bookworm | included: /var/lib/zuul/builds/ae51c5d221ed476d81ab19ec44ad356d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-22 03:09:48.259702 | 2025-09-22 03:09:48.259773 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-22 03:09:48.272195 | debian-bookworm | skipping: Conditional result was False 2025-09-22 03:09:48.276654 | 2025-09-22 03:09:48.276725 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-22 03:09:48.927825 | debian-bookworm | changed 2025-09-22 03:09:48.935845 | 2025-09-22 03:09:48.935948 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-22 03:09:49.188900 | debian-bookworm | ok 2025-09-22 03:09:49.197597 | 2025-09-22 03:09:49.197698 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-22 03:09:49.826562 | debian-bookworm | changed 2025-09-22 03:09:49.836640 | 2025-09-22 03:09:49.836750 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-22 03:09:50.464340 | debian-bookworm | changed 2025-09-22 03:09:50.469495 | 2025-09-22 03:09:50.469583 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-22 03:09:50.492592 | debian-bookworm | skipping: Conditional result was False 2025-09-22 03:09:50.500122 | 2025-09-22 03:09:50.500230 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-22 03:09:50.928502 | debian-bookworm -> localhost | changed 2025-09-22 03:09:50.949900 | 2025-09-22 03:09:50.950023 | TASK [add-build-sshkey : Add back temp key] 2025-09-22 03:09:51.328393 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ae51c5d221ed476d81ab19ec44ad356d/work/ae51c5d221ed476d81ab19ec44ad356d_id_rsa (zuul-build-sshkey) 2025-09-22 03:09:51.328625 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025827 2025-09-22 03:09:51.336357 | 2025-09-22 03:09:51.336446 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-22 03:09:51.703438 | debian-bookworm | ok 2025-09-22 03:09:51.708752 | 2025-09-22 03:09:51.708866 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-22 03:09:51.743024 | debian-bookworm | skipping: Conditional result was False 2025-09-22 03:09:51.754750 | 2025-09-22 03:09:51.754914 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-22 03:09:52.229883 | debian-bookworm | ok 2025-09-22 03:09:52.241262 | 2025-09-22 03:09:52.241383 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-22 03:09:52.275183 | debian-bookworm | ok 2025-09-22 03:09:52.283320 | 2025-09-22 03:09:52.283531 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-22 03:09:52.561582 | debian-bookworm -> localhost | ok 2025-09-22 03:09:52.568299 | 2025-09-22 03:09:52.568411 | TASK [validate-host : Collect information about the host] 2025-09-22 03:09:53.816546 | debian-bookworm | ok 2025-09-22 03:09:53.830892 | 2025-09-22 03:09:53.831181 | TASK [validate-host : Sanitize hostname] 2025-09-22 03:09:54.046162 | debian-bookworm | ok 2025-09-22 03:09:54.161240 | 2025-09-22 03:09:54.161393 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-22 03:09:55.301986 | debian-bookworm -> localhost | changed 2025-09-22 03:09:55.308066 | 2025-09-22 03:09:55.308190 | TASK [validate-host : Collect information about zuul worker] 2025-09-22 03:09:55.897895 | debian-bookworm | ok 2025-09-22 03:09:55.904251 | 2025-09-22 03:09:55.904382 | TASK [validate-host : Write out all zuul information for each host] 2025-09-22 03:09:56.871147 | debian-bookworm -> localhost | changed 2025-09-22 03:09:56.880841 | 2025-09-22 03:09:56.881088 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-22 03:09:57.177726 | debian-bookworm | ok 2025-09-22 03:09:57.183901 | 2025-09-22 03:09:57.184037 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-22 03:09:58.460323 | debian-bookworm | changed: 2025-09-22 03:09:58.460573 | debian-bookworm | cd+++++++++ src/ 2025-09-22 03:09:58.460611 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-22 03:09:58.460636 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-22 03:09:58.460658 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-22 03:09:58.460679 | debian-bookworm | Containerfile 2025-09-22 03:09:58.460795 | debian-bookworm | Containerfile 2025-09-22 03:09:58.504380 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003332 2025-09-22 03:10:26.474002 | 2025-09-22 03:10:26.474087 | TASK [upload-logs : Upload logs to log server] 2025-09-22 03:10:27.184718 | localhost | Output suppressed because no_log was given 2025-09-22 03:10:27.187279 | 2025-09-22 03:10:27.187370 | LOOP [upload-logs : Compress console log and json output] 2025-09-22 03:10:27.245387 | localhost | skipping: Conditional result was False 2025-09-22 03:10:27.252393 | localhost | skipping: Conditional result was False 2025-09-22 03:10:27.258144 | 2025-09-22 03:10:27.258284 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-22 03:10:27.299829 | localhost | skipping: Conditional result was False 2025-09-22 03:10:27.300063 | 2025-09-22 03:10:27.306674 | localhost | skipping: Conditional result was False 2025-09-22 03:10:27.315624 | 2025-09-22 03:10:27.315790 | LOOP [upload-logs : Upload console log and json output]