2025-11-10 15:38:51.923190 | Job console starting 2025-11-10 15:38:51.945898 | Updating git repos 2025-11-10 15:38:52.064545 | Cloning repos into workspace 2025-11-10 15:38:52.153802 | Restoring repo states 2025-11-10 15:38:52.183467 | Merging changes 2025-11-10 15:38:52.847368 | Checking out repos 2025-11-10 15:38:52.974637 | Preparing playbooks 2025-11-10 15:38:53.925712 | Running Ansible setup 2025-11-10 15:38:59.403803 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-10 15:39:00.397941 | 2025-11-10 15:39:00.398125 | PLAY [Base pre] 2025-11-10 15:39:00.437505 | 2025-11-10 15:39:00.437659 | TASK [Setup log path fact] 2025-11-10 15:39:00.477223 | debian-bookworm | ok 2025-11-10 15:39:00.506334 | 2025-11-10 15:39:00.506494 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-10 15:39:00.600614 | debian-bookworm | ok 2025-11-10 15:39:00.617095 | 2025-11-10 15:39:00.617222 | TASK [emit-job-header : Print job information] 2025-11-10 15:39:00.721200 | # Job Information 2025-11-10 15:39:00.721378 | Ansible Version: 2.16.14 2025-11-10 15:39:00.721413 | Job: python-black 2025-11-10 15:39:00.721445 | Pipeline: check 2025-11-10 15:39:00.721468 | Executor: 521e9411259a 2025-11-10 15:39:00.721489 | Triggered by: https://github.com/osism/python-osism/pull/1810 2025-11-10 15:39:00.721512 | Event ID: 56de01a0-be4b-11f0-81cd-49305064be47 2025-11-10 15:39:00.726742 | 2025-11-10 15:39:00.726880 | LOOP [emit-job-header : Print node information] 2025-11-10 15:39:00.992879 | debian-bookworm | ok: 2025-11-10 15:39:00.993056 | debian-bookworm | # Node Information 2025-11-10 15:39:00.993090 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-10 15:39:00.993115 | debian-bookworm | Hostname: debian 2025-11-10 15:39:00.993136 | debian-bookworm | Username: zuul 2025-11-10 15:39:00.993156 | debian-bookworm | Distro: Debian 12.12 2025-11-10 15:39:00.993180 | debian-bookworm | Provider: regiocloud-a 2025-11-10 15:39:00.993201 | debian-bookworm | Region: 2025-11-10 15:39:00.993222 | debian-bookworm | Label: debian-bookworm 2025-11-10 15:39:00.993242 | debian-bookworm | Product Name: OpenStack Nova 2025-11-10 15:39:00.993262 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe34:6e1a 2025-11-10 15:39:01.003858 | 2025-11-10 15:39:01.003980 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-10 15:39:01.707855 | debian-bookworm -> localhost | changed 2025-11-10 15:39:01.721716 | 2025-11-10 15:39:01.721876 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-10 15:39:03.105823 | debian-bookworm -> localhost | changed 2025-11-10 15:39:03.122123 | 2025-11-10 15:39:03.122230 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-10 15:39:03.542595 | debian-bookworm -> localhost | ok 2025-11-10 15:39:03.549081 | 2025-11-10 15:39:03.549178 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-10 15:39:03.579348 | debian-bookworm | ok 2025-11-10 15:39:03.607618 | debian-bookworm | included: /var/lib/zuul/builds/f8949846ac17478d95fde81c25f60acd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-10 15:39:03.622365 | 2025-11-10 15:39:03.622462 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-10 15:39:04.766423 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-10 15:39:04.766599 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f8949846ac17478d95fde81c25f60acd/work/f8949846ac17478d95fde81c25f60acd_id_rsa 2025-11-10 15:39:04.766638 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f8949846ac17478d95fde81c25f60acd/work/f8949846ac17478d95fde81c25f60acd_id_rsa.pub 2025-11-10 15:39:04.766665 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-10 15:39:04.766689 | debian-bookworm -> localhost | SHA256:6LUr181yT5ag62ZJSAdgsTigW0mZmhL20HRcbqwTlXA zuul-build-sshkey 2025-11-10 15:39:04.766712 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-10 15:39:04.766743 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-10 15:39:04.766765 | debian-bookworm -> localhost | | =+.o*E. | 2025-11-10 15:39:04.766787 | debian-bookworm -> localhost | |.=o+.+=o. | 2025-11-10 15:39:04.766807 | debian-bookworm -> localhost | |o+= o..+ . | 2025-11-10 15:39:04.766828 | debian-bookworm -> localhost | |+o . .+.. . | 2025-11-10 15:39:04.766863 | debian-bookworm -> localhost | |o o..So . | 2025-11-10 15:39:04.766889 | debian-bookworm -> localhost | | ....... . . | 2025-11-10 15:39:04.766910 | debian-bookworm -> localhost | | . .o.+ + | 2025-11-10 15:39:04.766930 | debian-bookworm -> localhost | | . ..*.+o | 2025-11-10 15:39:04.766952 | debian-bookworm -> localhost | | o.+oo .. | 2025-11-10 15:39:04.766973 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-10 15:39:04.767034 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.699283 2025-11-10 15:39:04.773133 | 2025-11-10 15:39:04.773223 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-10 15:39:04.800437 | debian-bookworm | ok 2025-11-10 15:39:04.820599 | debian-bookworm | included: /var/lib/zuul/builds/f8949846ac17478d95fde81c25f60acd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-10 15:39:04.840260 | 2025-11-10 15:39:04.840358 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-10 15:39:04.863323 | debian-bookworm | skipping: Conditional result was False 2025-11-10 15:39:04.869042 | 2025-11-10 15:39:04.869129 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-10 15:39:05.657532 | debian-bookworm | changed 2025-11-10 15:39:05.670793 | 2025-11-10 15:39:05.672389 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-10 15:39:05.949828 | debian-bookworm | ok 2025-11-10 15:39:05.955678 | 2025-11-10 15:39:05.955766 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-10 15:39:06.595973 | debian-bookworm | changed 2025-11-10 15:39:06.602298 | 2025-11-10 15:39:06.602382 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-10 15:39:07.200950 | debian-bookworm | changed 2025-11-10 15:39:07.205371 | 2025-11-10 15:39:07.205444 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-10 15:39:07.231799 | debian-bookworm | skipping: Conditional result was False 2025-11-10 15:39:07.246767 | 2025-11-10 15:39:07.246945 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-10 15:39:07.764233 | debian-bookworm -> localhost | changed 2025-11-10 15:39:07.775510 | 2025-11-10 15:39:07.775600 | TASK [add-build-sshkey : Add back temp key] 2025-11-10 15:39:08.031918 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f8949846ac17478d95fde81c25f60acd/work/f8949846ac17478d95fde81c25f60acd_id_rsa (zuul-build-sshkey) 2025-11-10 15:39:08.032145 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013430 2025-11-10 15:39:08.038226 | 2025-11-10 15:39:08.038299 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-10 15:39:08.394950 | debian-bookworm | ok 2025-11-10 15:39:08.399807 | 2025-11-10 15:39:08.399890 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-10 15:39:08.440898 | debian-bookworm | skipping: Conditional result was False 2025-11-10 15:39:08.450670 | 2025-11-10 15:39:08.460931 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-10 15:39:08.867742 | debian-bookworm | ok 2025-11-10 15:39:08.882445 | 2025-11-10 15:39:08.882533 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-10 15:39:08.929238 | debian-bookworm | ok 2025-11-10 15:39:08.937771 | 2025-11-10 15:39:08.937858 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-10 15:39:09.269429 | debian-bookworm -> localhost | ok 2025-11-10 15:39:09.275131 | 2025-11-10 15:39:09.275213 | TASK [validate-host : Collect information about the host] 2025-11-10 15:39:10.318027 | debian-bookworm | ok 2025-11-10 15:39:10.330614 | 2025-11-10 15:39:10.330708 | TASK [validate-host : Sanitize hostname] 2025-11-10 15:39:10.408288 | debian-bookworm | ok 2025-11-10 15:39:10.434587 | 2025-11-10 15:39:10.434672 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-10 15:39:10.956182 | debian-bookworm -> localhost | changed 2025-11-10 15:39:10.961451 | 2025-11-10 15:39:10.961537 | TASK [validate-host : Collect information about zuul worker] 2025-11-10 15:39:11.383493 | debian-bookworm | ok 2025-11-10 15:39:11.405679 | 2025-11-10 15:39:11.405780 | TASK [validate-host : Write out all zuul information for each host] 2025-11-10 15:39:12.134062 | debian-bookworm -> localhost | changed 2025-11-10 15:39:12.141535 | 2025-11-10 15:39:12.141618 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-10 15:39:12.406964 | debian-bookworm | ok 2025-11-10 15:39:12.412356 | 2025-11-10 15:39:12.412445 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-10 15:39:13.377686 | debian-bookworm | changed: 2025-11-10 15:39:13.377849 | debian-bookworm | cd+++++++++ src/ 2025-11-10 15:39:13.377882 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-10 15:39:13.377906 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-10 15:39:13.377928 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-10 15:39:13.377948 | debian-bookworm | Containerfile 2025-11-10 15:39:13.378078 | debian-bookworm | Containerfile 2025-11-10 15:39:13.394598 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006612 2025-11-10 15:39:39.607350 | 2025-11-10 15:39:39.607466 | TASK [upload-logs : Upload logs to log server] 2025-11-10 15:39:40.162151 | localhost | Output suppressed because no_log was given 2025-11-10 15:39:40.165705 | 2025-11-10 15:39:40.165865 | LOOP [upload-logs : Compress console log and json output] 2025-11-10 15:39:40.214796 | localhost | skipping: Conditional result was False 2025-11-10 15:39:40.219234 | localhost | skipping: Conditional result was False 2025-11-10 15:39:40.227288 | 2025-11-10 15:39:40.227502 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-10 15:39:40.274824 | localhost | skipping: Conditional result was False 2025-11-10 15:39:40.275412 | 2025-11-10 15:39:40.278888 | localhost | skipping: Conditional result was False 2025-11-10 15:39:40.292249 | 2025-11-10 15:39:40.292455 | LOOP [upload-logs : Upload console log and json output]