2025-05-29 07:31:56.348396 | Job console starting 2025-05-29 07:31:56.382585 | Updating git repos 2025-05-29 07:31:56.446538 | Cloning repos into workspace 2025-05-29 07:31:56.651732 | Restoring repo states 2025-05-29 07:31:56.671196 | Merging changes 2025-05-29 07:31:57.208082 | Checking out repos 2025-05-29 07:31:57.278968 | Preparing playbooks 2025-05-29 07:31:58.171214 | Running Ansible setup 2025-05-29 07:32:03.232760 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-29 07:32:04.314751 | 2025-05-29 07:32:04.315012 | PLAY [Base pre] 2025-05-29 07:32:04.331769 | 2025-05-29 07:32:04.331973 | TASK [Setup log path fact] 2025-05-29 07:32:04.353467 | debian-bookworm | ok 2025-05-29 07:32:04.371465 | 2025-05-29 07:32:04.371616 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-29 07:32:04.444153 | debian-bookworm | ok 2025-05-29 07:32:04.461008 | 2025-05-29 07:32:04.461152 | TASK [emit-job-header : Print job information] 2025-05-29 07:32:04.505260 | # Job Information 2025-05-29 07:32:04.505490 | Ansible Version: 2.16.14 2025-05-29 07:32:04.505528 | Job: python-black 2025-05-29 07:32:04.505562 | Pipeline: check 2025-05-29 07:32:04.505586 | Executor: 521e9411259a 2025-05-29 07:32:04.505607 | Triggered by: https://github.com/osism/python-osism/pull/1380 2025-05-29 07:32:04.505630 | Event ID: f9e76810-3c5e-11f0-92db-02bd5e55e720 2025-05-29 07:32:04.510872 | 2025-05-29 07:32:04.511009 | LOOP [emit-job-header : Print node information] 2025-05-29 07:32:04.631052 | debian-bookworm | ok: 2025-05-29 07:32:04.631282 | debian-bookworm | # Node Information 2025-05-29 07:32:04.631321 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-29 07:32:04.631348 | debian-bookworm | Hostname: debian 2025-05-29 07:32:04.631371 | debian-bookworm | Username: zuul 2025-05-29 07:32:04.631393 | debian-bookworm | Distro: Debian 12.11 2025-05-29 07:32:04.631418 | debian-bookworm | Provider: regiocloud-a 2025-05-29 07:32:04.631439 | debian-bookworm | Region: 2025-05-29 07:32:04.631461 | debian-bookworm | Label: debian-bookworm 2025-05-29 07:32:04.631481 | debian-bookworm | Product Name: OpenStack Nova 2025-05-29 07:32:04.631501 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb1:786c 2025-05-29 07:32:04.643716 | 2025-05-29 07:32:04.643837 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-29 07:32:05.102713 | debian-bookworm -> localhost | changed 2025-05-29 07:32:05.109604 | 2025-05-29 07:32:05.109703 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-29 07:32:06.377512 | debian-bookworm -> localhost | changed 2025-05-29 07:32:06.389198 | 2025-05-29 07:32:06.389311 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-29 07:32:06.799545 | debian-bookworm -> localhost | ok 2025-05-29 07:32:06.805695 | 2025-05-29 07:32:06.805795 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-29 07:32:06.835115 | debian-bookworm | ok 2025-05-29 07:32:06.868591 | debian-bookworm | included: /var/lib/zuul/builds/436065d0ade4459cb3f85eeb29c65013/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-29 07:32:06.874465 | 2025-05-29 07:32:06.874555 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-29 07:32:07.821811 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-29 07:32:07.822053 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/436065d0ade4459cb3f85eeb29c65013/work/436065d0ade4459cb3f85eeb29c65013_id_rsa 2025-05-29 07:32:07.822090 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/436065d0ade4459cb3f85eeb29c65013/work/436065d0ade4459cb3f85eeb29c65013_id_rsa.pub 2025-05-29 07:32:07.822116 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-29 07:32:07.822139 | debian-bookworm -> localhost | SHA256:gS0VJLvqLvN3v3Fkrbw150pzSo2nQrxLiP7dscgjeeM zuul-build-sshkey 2025-05-29 07:32:07.822160 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-29 07:32:07.822193 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-29 07:32:07.822216 | debian-bookworm -> localhost | | ..+. | 2025-05-29 07:32:07.822237 | debian-bookworm -> localhost | | * | 2025-05-29 07:32:07.822257 | debian-bookworm -> localhost | | + o | 2025-05-29 07:32:07.822277 | debian-bookworm -> localhost | | o . . | 2025-05-29 07:32:07.822296 | debian-bookworm -> localhost | | . S .o . | 2025-05-29 07:32:07.822319 | debian-bookworm -> localhost | | . . =o. o | 2025-05-29 07:32:07.822340 | debian-bookworm -> localhost | | . . oo=.O =| 2025-05-29 07:32:07.822359 | debian-bookworm -> localhost | | o. ... o**B % | 2025-05-29 07:32:07.822380 | debian-bookworm -> localhost | | =+. ..o+=E=*..| 2025-05-29 07:32:07.822400 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-29 07:32:07.822447 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.404131 2025-05-29 07:32:07.828687 | 2025-05-29 07:32:07.828787 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-29 07:32:07.869054 | debian-bookworm | ok 2025-05-29 07:32:07.886110 | debian-bookworm | included: /var/lib/zuul/builds/436065d0ade4459cb3f85eeb29c65013/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-29 07:32:07.905153 | 2025-05-29 07:32:07.905241 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-29 07:32:07.941376 | debian-bookworm | skipping: Conditional result was False 2025-05-29 07:32:07.948288 | 2025-05-29 07:32:07.948398 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-29 07:32:08.628627 | debian-bookworm | changed 2025-05-29 07:32:08.636663 | 2025-05-29 07:32:08.636776 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-29 07:32:08.896806 | debian-bookworm | ok 2025-05-29 07:32:08.905276 | 2025-05-29 07:32:08.905400 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-29 07:32:09.577857 | debian-bookworm | changed 2025-05-29 07:32:09.589985 | 2025-05-29 07:32:09.590397 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-29 07:32:10.258112 | debian-bookworm | changed 2025-05-29 07:32:10.265489 | 2025-05-29 07:32:10.265620 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-29 07:32:10.290004 | debian-bookworm | skipping: Conditional result was False 2025-05-29 07:32:10.298599 | 2025-05-29 07:32:10.298710 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-29 07:32:10.895807 | debian-bookworm -> localhost | changed 2025-05-29 07:32:10.912967 | 2025-05-29 07:32:10.913127 | TASK [add-build-sshkey : Add back temp key] 2025-05-29 07:32:11.707009 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/436065d0ade4459cb3f85eeb29c65013/work/436065d0ade4459cb3f85eeb29c65013_id_rsa (zuul-build-sshkey) 2025-05-29 07:32:11.707626 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030724 2025-05-29 07:32:11.721558 | 2025-05-29 07:32:11.721677 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-29 07:32:12.231748 | debian-bookworm | ok 2025-05-29 07:32:12.246322 | 2025-05-29 07:32:12.246488 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-29 07:32:12.326536 | debian-bookworm | skipping: Conditional result was False 2025-05-29 07:32:12.340221 | 2025-05-29 07:32:12.340379 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-29 07:32:12.824263 | debian-bookworm | ok 2025-05-29 07:32:12.841231 | 2025-05-29 07:32:12.841550 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-29 07:32:12.888410 | debian-bookworm | ok 2025-05-29 07:32:12.903664 | 2025-05-29 07:32:12.903987 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-29 07:32:13.552714 | debian-bookworm -> localhost | ok 2025-05-29 07:32:13.564675 | 2025-05-29 07:32:13.564959 | TASK [validate-host : Collect information about the host] 2025-05-29 07:32:14.994997 | debian-bookworm | ok 2025-05-29 07:32:15.017633 | 2025-05-29 07:32:15.018001 | TASK [validate-host : Sanitize hostname] 2025-05-29 07:32:15.169164 | debian-bookworm | ok 2025-05-29 07:32:15.218162 | 2025-05-29 07:32:15.218318 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-29 07:32:16.271132 | debian-bookworm -> localhost | changed 2025-05-29 07:32:16.296410 | 2025-05-29 07:32:16.296589 | TASK [validate-host : Collect information about zuul worker] 2025-05-29 07:32:16.948235 | debian-bookworm | ok 2025-05-29 07:32:16.955364 | 2025-05-29 07:32:16.955499 | TASK [validate-host : Write out all zuul information for each host] 2025-05-29 07:32:17.954058 | debian-bookworm -> localhost | changed 2025-05-29 07:32:17.969203 | 2025-05-29 07:32:17.969349 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-29 07:32:18.243958 | debian-bookworm | ok 2025-05-29 07:32:18.263330 | 2025-05-29 07:32:18.263522 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-29 07:32:19.352986 | debian-bookworm | changed: 2025-05-29 07:32:19.359477 | debian-bookworm | cd+++++++++ src/ 2025-05-29 07:32:19.359557 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-29 07:32:19.359595 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-29 07:32:19.359621 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-05-29 07:32:19.359643 | debian-bookworm | Containerfile 2025-05-29 07:32:19.359889 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008099 2025-05-29 07:32:45.749061 | 2025-05-29 07:32:45.749186 | TASK [upload-logs : Upload logs to log server] 2025-05-29 07:32:46.331300 | localhost | Output suppressed because no_log was given 2025-05-29 07:32:46.335718 | 2025-05-29 07:32:46.335933 | LOOP [upload-logs : Compress console log and json output] 2025-05-29 07:32:46.393151 | localhost | skipping: Conditional result was False 2025-05-29 07:32:46.398625 | localhost | skipping: Conditional result was False 2025-05-29 07:32:46.410317 | 2025-05-29 07:32:46.410484 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-29 07:32:46.461822 | localhost | skipping: Conditional result was False 2025-05-29 07:32:46.462253 | 2025-05-29 07:32:46.466816 | localhost | skipping: Conditional result was False 2025-05-29 07:32:46.470534 | 2025-05-29 07:32:46.470647 | LOOP [upload-logs : Upload console log and json output]