2025-08-19 13:36:49.963140 | Job console starting 2025-08-19 13:36:49.984909 | Updating git repos 2025-08-19 13:36:50.066225 | Cloning repos into workspace 2025-08-19 13:36:50.152384 | Restoring repo states 2025-08-19 13:36:50.177935 | Merging changes 2025-08-19 13:36:50.806969 | Checking out repos 2025-08-19 13:36:50.902108 | Preparing playbooks 2025-08-19 13:36:51.994183 | Running Ansible setup 2025-08-19 13:36:59.159169 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-19 13:37:00.631809 | 2025-08-19 13:37:00.631941 | PLAY [Base pre] 2025-08-19 13:37:00.670251 | 2025-08-19 13:37:00.670359 | TASK [Setup log path fact] 2025-08-19 13:37:00.697028 | debian-bookworm | ok 2025-08-19 13:37:00.723624 | 2025-08-19 13:37:00.723752 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-19 13:37:00.783992 | debian-bookworm | ok 2025-08-19 13:37:00.797158 | 2025-08-19 13:37:00.797250 | TASK [emit-job-header : Print job information] 2025-08-19 13:37:00.850330 | # Job Information 2025-08-19 13:37:00.850511 | Ansible Version: 2.16.14 2025-08-19 13:37:00.850542 | Job: python-black 2025-08-19 13:37:00.850576 | Pipeline: check 2025-08-19 13:37:00.850598 | Executor: 521e9411259a 2025-08-19 13:37:00.850615 | Triggered by: https://github.com/osism/python-osism/pull/1644 2025-08-19 13:37:00.850633 | Event ID: 89e08f40-7d01-11f0-9cdc-f3038f10b178 2025-08-19 13:37:00.854716 | 2025-08-19 13:37:00.854804 | LOOP [emit-job-header : Print node information] 2025-08-19 13:37:01.020568 | debian-bookworm | ok: 2025-08-19 13:37:01.020756 | debian-bookworm | # Node Information 2025-08-19 13:37:01.020788 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-19 13:37:01.020809 | debian-bookworm | Hostname: debian 2025-08-19 13:37:01.020827 | debian-bookworm | Username: zuul 2025-08-19 13:37:01.020843 | debian-bookworm | Distro: Debian 12.11 2025-08-19 13:37:01.020862 | debian-bookworm | Provider: regiocloud-a 2025-08-19 13:37:01.020879 | debian-bookworm | Region: 2025-08-19 13:37:01.020896 | debian-bookworm | Label: debian-bookworm 2025-08-19 13:37:01.034024 | debian-bookworm | Product Name: OpenStack Nova 2025-08-19 13:37:01.034064 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe07:5786 2025-08-19 13:37:01.052658 | 2025-08-19 13:37:01.052778 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-19 13:37:01.655861 | debian-bookworm -> localhost | changed 2025-08-19 13:37:01.661440 | 2025-08-19 13:37:01.661529 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-19 13:37:03.635261 | debian-bookworm -> localhost | changed 2025-08-19 13:37:03.643891 | 2025-08-19 13:37:03.643977 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-19 13:37:04.051663 | debian-bookworm -> localhost | ok 2025-08-19 13:37:04.056796 | 2025-08-19 13:37:04.056879 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-19 13:37:04.093599 | debian-bookworm | ok 2025-08-19 13:37:04.118963 | debian-bookworm | included: /var/lib/zuul/builds/a09f92375c574f4fbf26232e73441e26/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-19 13:37:04.123824 | 2025-08-19 13:37:04.123899 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-19 13:37:06.031909 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-19 13:37:06.032072 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a09f92375c574f4fbf26232e73441e26/work/a09f92375c574f4fbf26232e73441e26_id_rsa 2025-08-19 13:37:06.032103 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a09f92375c574f4fbf26232e73441e26/work/a09f92375c574f4fbf26232e73441e26_id_rsa.pub 2025-08-19 13:37:06.032125 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-19 13:37:06.032146 | debian-bookworm -> localhost | SHA256:FSi5m3FeD3iKNxGAtgijOahgGRkXhnZBTupbBgtza3s zuul-build-sshkey 2025-08-19 13:37:06.032164 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-19 13:37:06.032190 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-19 13:37:06.032208 | debian-bookworm -> localhost | | .=Bo..o .. | 2025-08-19 13:37:06.032225 | debian-bookworm -> localhost | |o=*.o o o . | 2025-08-19 13:37:06.032242 | debian-bookworm -> localhost | |**=+ . o o. | 2025-08-19 13:37:06.032258 | debian-bookworm -> localhost | |O=+.. o +.+ | 2025-08-19 13:37:06.032274 | debian-bookworm -> localhost | |++oo BS= o | 2025-08-19 13:37:06.032296 | debian-bookworm -> localhost | |..+. + = . | 2025-08-19 13:37:06.032314 | debian-bookworm -> localhost | | .. E . . | 2025-08-19 13:37:06.032332 | debian-bookworm -> localhost | | . | 2025-08-19 13:37:06.032349 | debian-bookworm -> localhost | | | 2025-08-19 13:37:06.032366 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-19 13:37:06.032413 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.066750 2025-08-19 13:37:06.037384 | 2025-08-19 13:37:06.037462 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-19 13:37:06.083904 | debian-bookworm | ok 2025-08-19 13:37:06.091126 | debian-bookworm | included: /var/lib/zuul/builds/a09f92375c574f4fbf26232e73441e26/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-19 13:37:06.112225 | 2025-08-19 13:37:06.112307 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-19 13:37:06.165391 | debian-bookworm | skipping: Conditional result was False 2025-08-19 13:37:06.170265 | 2025-08-19 13:37:06.170344 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-19 13:37:07.045791 | debian-bookworm | changed 2025-08-19 13:37:07.050134 | 2025-08-19 13:37:07.050209 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-19 13:37:07.417573 | debian-bookworm | ok 2025-08-19 13:37:07.422066 | 2025-08-19 13:37:07.422144 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-19 13:37:08.268545 | debian-bookworm | changed 2025-08-19 13:37:08.276234 | 2025-08-19 13:37:08.276315 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-19 13:37:08.995138 | debian-bookworm | changed 2025-08-19 13:37:08.999683 | 2025-08-19 13:37:08.999780 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-19 13:37:09.025374 | debian-bookworm | skipping: Conditional result was False 2025-08-19 13:37:09.030776 | 2025-08-19 13:37:09.030904 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-19 13:37:09.555576 | debian-bookworm -> localhost | changed 2025-08-19 13:37:09.567180 | 2025-08-19 13:37:09.567266 | TASK [add-build-sshkey : Add back temp key] 2025-08-19 13:37:10.227034 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a09f92375c574f4fbf26232e73441e26/work/a09f92375c574f4fbf26232e73441e26_id_rsa (zuul-build-sshkey) 2025-08-19 13:37:10.227213 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015829 2025-08-19 13:37:10.233382 | 2025-08-19 13:37:10.233456 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-19 13:37:10.677381 | debian-bookworm | ok 2025-08-19 13:37:10.682248 | 2025-08-19 13:37:10.682331 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-19 13:37:10.738213 | debian-bookworm | skipping: Conditional result was False 2025-08-19 13:37:10.746490 | 2025-08-19 13:37:10.746577 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-19 13:37:11.495662 | debian-bookworm | ok 2025-08-19 13:37:11.507798 | 2025-08-19 13:37:11.507889 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-19 13:37:11.574528 | debian-bookworm | ok 2025-08-19 13:37:11.579224 | 2025-08-19 13:37:11.579320 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-19 13:37:12.469431 | debian-bookworm -> localhost | ok 2025-08-19 13:37:12.475091 | 2025-08-19 13:37:12.475184 | TASK [validate-host : Collect information about the host] 2025-08-19 13:37:13.829718 | debian-bookworm | ok 2025-08-19 13:37:13.843692 | 2025-08-19 13:37:13.843809 | TASK [validate-host : Sanitize hostname] 2025-08-19 13:37:14.057400 | debian-bookworm | ok 2025-08-19 13:37:14.089337 | 2025-08-19 13:37:14.089424 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-19 13:37:14.991896 | debian-bookworm -> localhost | changed 2025-08-19 13:37:14.996547 | 2025-08-19 13:37:14.996626 | TASK [validate-host : Collect information about zuul worker] 2025-08-19 13:37:15.390358 | debian-bookworm | ok 2025-08-19 13:37:15.402745 | 2025-08-19 13:37:15.402894 | TASK [validate-host : Write out all zuul information for each host] 2025-08-19 13:37:16.165380 | debian-bookworm -> localhost | changed 2025-08-19 13:37:16.173932 | 2025-08-19 13:37:16.174021 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-19 13:37:16.472527 | debian-bookworm | ok 2025-08-19 13:37:16.477553 | 2025-08-19 13:37:16.477633 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-19 13:37:17.901120 | debian-bookworm | changed: 2025-08-19 13:37:17.901263 | debian-bookworm | cd+++++++++ src/ 2025-08-19 13:37:17.901291 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-19 13:37:17.901311 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-19 13:37:17.901329 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-19 13:37:17.901346 | debian-bookworm | Containerfile 2025-08-19 13:37:17.901439 | debian-bookworm | Containerfile 2025-08-19 13:37:17.938489 | debian-bookworm | localhost | ok: Runtime: 0:00:00.017438 2025-08-19 13:37:47.388912 | 2025-08-19 13:37:47.389050 | TASK [upload-logs : Upload logs to log server] 2025-08-19 13:37:48.771156 | localhost | Output suppressed because no_log was given 2025-08-19 13:37:48.773284 | 2025-08-19 13:37:48.773394 | LOOP [upload-logs : Compress console log and json output] 2025-08-19 13:37:48.908780 | localhost | skipping: Conditional result was False 2025-08-19 13:37:48.932817 | localhost | skipping: Conditional result was False 2025-08-19 13:37:48.942367 | 2025-08-19 13:37:48.942501 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-19 13:37:49.062661 | localhost | skipping: Conditional result was False 2025-08-19 13:37:49.063016 | 2025-08-19 13:37:49.086383 | localhost | skipping: Conditional result was False 2025-08-19 13:37:49.090123 | 2025-08-19 13:37:49.090244 | LOOP [upload-logs : Upload console log and json output]