2025-08-18 23:00:03.893658 | Job console starting 2025-08-18 23:00:03.913042 | Updating git repos 2025-08-18 23:00:03.943823 | Cloning repos into workspace 2025-08-18 23:00:03.984125 | Restoring repo states 2025-08-18 23:00:03.991460 | Merging changes 2025-08-18 23:00:05.197353 | Checking out repos 2025-08-18 23:00:05.225748 | Preparing playbooks 2025-08-18 23:00:05.814164 | Running Ansible setup 2025-08-18 23:00:10.216227 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-18 23:00:11.007115 | 2025-08-18 23:00:11.007334 | PLAY [Base pre] 2025-08-18 23:00:11.025661 | 2025-08-18 23:00:11.025821 | TASK [Setup log path fact] 2025-08-18 23:00:11.062128 | debian-bookworm | ok 2025-08-18 23:00:11.082172 | 2025-08-18 23:00:11.082371 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-18 23:00:11.130183 | debian-bookworm | ok 2025-08-18 23:00:11.143881 | 2025-08-18 23:00:11.144020 | TASK [emit-job-header : Print job information] 2025-08-18 23:00:11.193372 | # Job Information 2025-08-18 23:00:11.193613 | Ansible Version: 2.16.14 2025-08-18 23:00:11.193663 | Job: python-black 2025-08-18 23:00:11.193710 | Pipeline: check 2025-08-18 23:00:11.193743 | Executor: 521e9411259a 2025-08-18 23:00:11.193773 | Triggered by: https://github.com/osism/openstack-project-manager/pull/238 2025-08-18 23:00:11.193804 | Event ID: fa5b1360-7c86-11f0-83d6-ede6812c9643 2025-08-18 23:00:11.200313 | 2025-08-18 23:00:11.200451 | LOOP [emit-job-header : Print node information] 2025-08-18 23:00:11.307919 | debian-bookworm | ok: 2025-08-18 23:00:11.308286 | debian-bookworm | # Node Information 2025-08-18 23:00:11.308350 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-18 23:00:11.308377 | debian-bookworm | Hostname: debian 2025-08-18 23:00:11.308399 | debian-bookworm | Username: zuul 2025-08-18 23:00:11.308420 | debian-bookworm | Distro: Debian 12.11 2025-08-18 23:00:11.308444 | debian-bookworm | Provider: regiocloud-a 2025-08-18 23:00:11.308465 | debian-bookworm | Region: 2025-08-18 23:00:11.308486 | debian-bookworm | Label: debian-bookworm 2025-08-18 23:00:11.308504 | debian-bookworm | Product Name: OpenStack Nova 2025-08-18 23:00:11.308523 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6b:2222 2025-08-18 23:00:11.335574 | 2025-08-18 23:00:11.335731 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-18 23:00:11.820354 | debian-bookworm -> localhost | changed 2025-08-18 23:00:11.827784 | 2025-08-18 23:00:11.827906 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-18 23:00:12.939799 | debian-bookworm -> localhost | changed 2025-08-18 23:00:12.959285 | 2025-08-18 23:00:12.959435 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-18 23:00:13.227964 | debian-bookworm -> localhost | ok 2025-08-18 23:00:13.234994 | 2025-08-18 23:00:13.235121 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-18 23:00:13.264807 | debian-bookworm | ok 2025-08-18 23:00:13.283445 | debian-bookworm | included: /var/lib/zuul/builds/30d8047ebeef48daaf44763a120e7da8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-18 23:00:13.289740 | 2025-08-18 23:00:13.289857 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-18 23:00:14.138020 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-18 23:00:14.138302 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/30d8047ebeef48daaf44763a120e7da8/work/30d8047ebeef48daaf44763a120e7da8_id_rsa 2025-08-18 23:00:14.138343 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/30d8047ebeef48daaf44763a120e7da8/work/30d8047ebeef48daaf44763a120e7da8_id_rsa.pub 2025-08-18 23:00:14.138370 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-18 23:00:14.138396 | debian-bookworm -> localhost | SHA256:J7gAdjg5NdxtD/pIzgPkwRNem4FtxkVhZblGQAfxxUs zuul-build-sshkey 2025-08-18 23:00:14.138419 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-18 23:00:14.138454 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-18 23:00:14.138475 | debian-bookworm -> localhost | | o+*o=X*+o. | 2025-08-18 23:00:14.138497 | debian-bookworm -> localhost | | =Bo*=++o.E | 2025-08-18 23:00:14.138516 | debian-bookworm -> localhost | | Boo=oo +.o . | 2025-08-18 23:00:14.138535 | debian-bookworm -> localhost | | . =o o. + . | 2025-08-18 23:00:14.138555 | debian-bookworm -> localhost | | .=.oS.. | 2025-08-18 23:00:14.138579 | debian-bookworm -> localhost | | .=..o | 2025-08-18 23:00:14.138600 | debian-bookworm -> localhost | | .. | 2025-08-18 23:00:14.138619 | debian-bookworm -> localhost | | | 2025-08-18 23:00:14.138639 | debian-bookworm -> localhost | | | 2025-08-18 23:00:14.138659 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-18 23:00:14.138721 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.311639 2025-08-18 23:00:14.145699 | 2025-08-18 23:00:14.145809 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-18 23:00:14.188507 | debian-bookworm | ok 2025-08-18 23:00:14.198435 | debian-bookworm | included: /var/lib/zuul/builds/30d8047ebeef48daaf44763a120e7da8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-18 23:00:14.207726 | 2025-08-18 23:00:14.207836 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-18 23:00:14.231790 | debian-bookworm | skipping: Conditional result was False 2025-08-18 23:00:14.237977 | 2025-08-18 23:00:14.238092 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-18 23:00:14.980201 | debian-bookworm | changed 2025-08-18 23:00:14.987976 | 2025-08-18 23:00:14.988103 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-18 23:00:15.327487 | debian-bookworm | ok 2025-08-18 23:00:15.336713 | 2025-08-18 23:00:15.336856 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-18 23:00:16.083339 | debian-bookworm | changed 2025-08-18 23:00:16.093325 | 2025-08-18 23:00:16.093482 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-18 23:00:16.800317 | debian-bookworm | changed 2025-08-18 23:00:16.806345 | 2025-08-18 23:00:16.806454 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-18 23:00:16.840638 | debian-bookworm | skipping: Conditional result was False 2025-08-18 23:00:16.854186 | 2025-08-18 23:00:16.854364 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-18 23:00:17.335059 | debian-bookworm -> localhost | changed 2025-08-18 23:00:17.346489 | 2025-08-18 23:00:17.346612 | TASK [add-build-sshkey : Add back temp key] 2025-08-18 23:00:17.728672 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/30d8047ebeef48daaf44763a120e7da8/work/30d8047ebeef48daaf44763a120e7da8_id_rsa (zuul-build-sshkey) 2025-08-18 23:00:17.729135 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012963 2025-08-18 23:00:17.743012 | 2025-08-18 23:00:17.743137 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-18 23:00:18.190195 | debian-bookworm | ok 2025-08-18 23:00:18.196798 | 2025-08-18 23:00:18.196934 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-18 23:00:18.231347 | debian-bookworm | skipping: Conditional result was False 2025-08-18 23:00:18.247792 | 2025-08-18 23:00:18.247962 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-18 23:00:18.708440 | debian-bookworm | ok 2025-08-18 23:00:18.720441 | 2025-08-18 23:00:18.720559 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-18 23:00:18.752280 | debian-bookworm | ok 2025-08-18 23:00:18.758469 | 2025-08-18 23:00:18.758586 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-18 23:00:19.058864 | debian-bookworm -> localhost | ok 2025-08-18 23:00:19.070644 | 2025-08-18 23:00:19.070899 | TASK [validate-host : Collect information about the host] 2025-08-18 23:00:20.262661 | debian-bookworm | ok 2025-08-18 23:00:20.273762 | 2025-08-18 23:00:20.273882 | TASK [validate-host : Sanitize hostname] 2025-08-18 23:00:20.395369 | debian-bookworm | ok 2025-08-18 23:00:20.436241 | 2025-08-18 23:00:20.436417 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-18 23:00:20.986220 | debian-bookworm -> localhost | changed 2025-08-18 23:00:20.992352 | 2025-08-18 23:00:20.992471 | TASK [validate-host : Collect information about zuul worker] 2025-08-18 23:00:21.415724 | debian-bookworm | ok 2025-08-18 23:00:21.424137 | 2025-08-18 23:00:21.424289 | TASK [validate-host : Write out all zuul information for each host] 2025-08-18 23:00:22.011040 | debian-bookworm -> localhost | changed 2025-08-18 23:00:22.023754 | 2025-08-18 23:00:22.023877 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-18 23:00:22.302497 | debian-bookworm | ok 2025-08-18 23:00:22.311541 | 2025-08-18 23:00:22.311667 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-18 23:00:23.198502 | debian-bookworm | changed: 2025-08-18 23:00:23.198708 | debian-bookworm | cd+++++++++ src/ 2025-08-18 23:00:23.198743 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-18 23:00:23.198767 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-18 23:00:23.198789 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-project-manager/ 2025-08-18 23:00:23.198809 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005152 2025-08-18 23:00:48.570034 | 2025-08-18 23:00:48.570217 | TASK [upload-logs : Upload logs to log server] 2025-08-18 23:00:49.177959 | localhost | Output suppressed because no_log was given 2025-08-18 23:00:49.182049 | 2025-08-18 23:00:49.182229 | LOOP [upload-logs : Compress console log and json output] 2025-08-18 23:00:49.240778 | localhost | skipping: Conditional result was False 2025-08-18 23:00:49.245937 | localhost | skipping: Conditional result was False 2025-08-18 23:00:49.257955 | 2025-08-18 23:00:49.258134 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-18 23:00:49.314694 | localhost | skipping: Conditional result was False 2025-08-18 23:00:49.315370 | 2025-08-18 23:00:49.318639 | localhost | skipping: Conditional result was False 2025-08-18 23:00:49.332450 | 2025-08-18 23:00:49.332662 | LOOP [upload-logs : Upload console log and json output]