2025-11-20 03:12:57.058199 | Job console starting 2025-11-20 03:12:57.075353 | Updating git repos 2025-11-20 03:12:57.103424 | Cloning repos into workspace 2025-11-20 03:12:57.152569 | Restoring repo states 2025-11-20 03:12:57.159828 | Merging changes 2025-11-20 03:12:57.159849 | Checking out repos 2025-11-20 03:12:57.270239 | Preparing playbooks 2025-11-20 03:12:58.198209 | Running Ansible setup 2025-11-20 03:13:03.662298 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-20 03:13:04.481035 | 2025-11-20 03:13:04.481212 | PLAY [Base pre] 2025-11-20 03:13:04.498493 | 2025-11-20 03:13:04.498694 | TASK [Setup log path fact] 2025-11-20 03:13:04.530138 | debian-bookworm | ok 2025-11-20 03:13:04.545370 | 2025-11-20 03:13:04.545524 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 03:13:04.590209 | debian-bookworm | ok 2025-11-20 03:13:04.601926 | 2025-11-20 03:13:04.602064 | TASK [emit-job-header : Print job information] 2025-11-20 03:13:04.651170 | # Job Information 2025-11-20 03:13:04.651462 | Ansible Version: 2.16.14 2025-11-20 03:13:04.651527 | Job: python-black 2025-11-20 03:13:04.651586 | Pipeline: periodic-daily 2025-11-20 03:13:04.651628 | Executor: 521e9411259a 2025-11-20 03:13:04.651682 | Triggered by: https://github.com/osism/testbed 2025-11-20 03:13:04.651723 | Event ID: eac1da75a5074457a695c7bb838c0df0 2025-11-20 03:13:04.660651 | 2025-11-20 03:13:04.660816 | LOOP [emit-job-header : Print node information] 2025-11-20 03:13:04.780574 | debian-bookworm | ok: 2025-11-20 03:13:04.780835 | debian-bookworm | # Node Information 2025-11-20 03:13:04.781094 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-20 03:13:04.781333 | debian-bookworm | Hostname: debian 2025-11-20 03:13:04.781425 | debian-bookworm | Username: zuul 2025-11-20 03:13:04.781495 | debian-bookworm | Distro: Debian 12.12 2025-11-20 03:13:04.781572 | debian-bookworm | Provider: regiocloud-a 2025-11-20 03:13:04.781689 | debian-bookworm | Region: 2025-11-20 03:13:04.781766 | debian-bookworm | Label: debian-bookworm 2025-11-20 03:13:04.781826 | debian-bookworm | Product Name: OpenStack Nova 2025-11-20 03:13:04.781885 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe09:8629 2025-11-20 03:13:04.802483 | 2025-11-20 03:13:04.802628 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-20 03:13:05.319469 | debian-bookworm -> localhost | changed 2025-11-20 03:13:05.326956 | 2025-11-20 03:13:05.327093 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-20 03:13:06.450483 | debian-bookworm -> localhost | changed 2025-11-20 03:13:06.462472 | 2025-11-20 03:13:06.462590 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-20 03:13:06.792768 | debian-bookworm -> localhost | ok 2025-11-20 03:13:06.803110 | 2025-11-20 03:13:06.804547 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-20 03:13:06.861120 | debian-bookworm | ok 2025-11-20 03:13:06.889049 | debian-bookworm | included: /var/lib/zuul/builds/0752127266354a7db69002b829d7f473/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-20 03:13:06.895924 | 2025-11-20 03:13:06.896043 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-20 03:13:07.884039 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-20 03:13:07.884271 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0752127266354a7db69002b829d7f473/work/0752127266354a7db69002b829d7f473_id_rsa 2025-11-20 03:13:07.884311 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0752127266354a7db69002b829d7f473/work/0752127266354a7db69002b829d7f473_id_rsa.pub 2025-11-20 03:13:07.884336 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-20 03:13:07.884362 | debian-bookworm -> localhost | SHA256:h6H8NiJNsWgHU+uwI143S3YfjgEWMlTuCVPr+M0mpG4 zuul-build-sshkey 2025-11-20 03:13:07.884384 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-20 03:13:07.884419 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-20 03:13:07.884442 | debian-bookworm -> localhost | | .+.= | 2025-11-20 03:13:07.884463 | debian-bookworm -> localhost | | * + | 2025-11-20 03:13:07.884483 | debian-bookworm -> localhost | | * B . | 2025-11-20 03:13:07.884502 | debian-bookworm -> localhost | | / * o | 2025-11-20 03:13:07.884522 | debian-bookworm -> localhost | | . B ^ S o | 2025-11-20 03:13:07.884546 | debian-bookworm -> localhost | | . + % B * . | 2025-11-20 03:13:07.884567 | debian-bookworm -> localhost | | . o * O o | 2025-11-20 03:13:07.884586 | debian-bookworm -> localhost | | .E. = . | 2025-11-20 03:13:07.884606 | debian-bookworm -> localhost | | .. | 2025-11-20 03:13:07.884625 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-20 03:13:07.884701 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.438337 2025-11-20 03:13:07.891506 | 2025-11-20 03:13:07.891652 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-20 03:13:07.926990 | debian-bookworm | ok 2025-11-20 03:13:07.941176 | debian-bookworm | included: /var/lib/zuul/builds/0752127266354a7db69002b829d7f473/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-20 03:13:07.951230 | 2025-11-20 03:13:07.951344 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-20 03:13:07.975554 | debian-bookworm | skipping: Conditional result was False 2025-11-20 03:13:07.985874 | 2025-11-20 03:13:07.986033 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-20 03:13:08.699187 | debian-bookworm | changed 2025-11-20 03:13:08.709799 | 2025-11-20 03:13:08.709925 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-20 03:13:08.972102 | debian-bookworm | ok 2025-11-20 03:13:08.982413 | 2025-11-20 03:13:08.982589 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-20 03:13:09.712626 | debian-bookworm | changed 2025-11-20 03:13:09.721908 | 2025-11-20 03:13:09.722052 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-20 03:13:10.420102 | debian-bookworm | changed 2025-11-20 03:13:10.428390 | 2025-11-20 03:13:10.428533 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-20 03:13:10.453673 | debian-bookworm | skipping: Conditional result was False 2025-11-20 03:13:10.461091 | 2025-11-20 03:13:10.461226 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-20 03:13:11.067111 | debian-bookworm -> localhost | changed 2025-11-20 03:13:11.079240 | 2025-11-20 03:13:11.079386 | TASK [add-build-sshkey : Add back temp key] 2025-11-20 03:13:11.478890 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0752127266354a7db69002b829d7f473/work/0752127266354a7db69002b829d7f473_id_rsa (zuul-build-sshkey) 2025-11-20 03:13:11.479144 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020954 2025-11-20 03:13:11.494751 | 2025-11-20 03:13:11.494914 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-20 03:13:11.923285 | debian-bookworm | ok 2025-11-20 03:13:11.931264 | 2025-11-20 03:13:11.931452 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-20 03:13:11.975864 | debian-bookworm | skipping: Conditional result was False 2025-11-20 03:13:11.987482 | 2025-11-20 03:13:11.987621 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-20 03:13:12.471839 | debian-bookworm | ok 2025-11-20 03:13:12.484168 | 2025-11-20 03:13:12.484313 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-20 03:13:12.513891 | debian-bookworm | ok 2025-11-20 03:13:12.519571 | 2025-11-20 03:13:12.519715 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-20 03:13:12.871643 | debian-bookworm -> localhost | ok 2025-11-20 03:13:12.878423 | 2025-11-20 03:13:12.878549 | TASK [validate-host : Collect information about the host] 2025-11-20 03:13:14.084906 | debian-bookworm | ok 2025-11-20 03:13:14.107325 | 2025-11-20 03:13:14.107476 | TASK [validate-host : Sanitize hostname] 2025-11-20 03:13:14.226974 | debian-bookworm | ok 2025-11-20 03:13:14.275011 | 2025-11-20 03:13:14.275160 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-20 03:13:14.872569 | debian-bookworm -> localhost | changed 2025-11-20 03:13:14.878764 | 2025-11-20 03:13:14.878901 | TASK [validate-host : Collect information about zuul worker] 2025-11-20 03:13:15.334554 | debian-bookworm | ok 2025-11-20 03:13:15.367153 | 2025-11-20 03:13:15.367401 | TASK [validate-host : Write out all zuul information for each host] 2025-11-20 03:13:16.077344 | debian-bookworm -> localhost | changed 2025-11-20 03:13:16.088263 | 2025-11-20 03:13:16.088392 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-20 03:13:16.376180 | debian-bookworm | ok 2025-11-20 03:13:16.389062 | 2025-11-20 03:13:16.389214 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-20 03:13:17.609132 | debian-bookworm | changed: 2025-11-20 03:13:17.609657 | debian-bookworm | cd+++++++++ src/ 2025-11-20 03:13:17.609803 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-20 03:13:17.609903 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-20 03:13:17.610002 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-20 03:13:17.610087 | debian-bookworm | localhost | ok: Runtime: 0:00:00.010273 2025-11-20 03:13:43.606041 | 2025-11-20 03:13:43.606136 | TASK [upload-logs : Upload logs to log server] 2025-11-20 03:13:44.240380 | localhost | Output suppressed because no_log was given 2025-11-20 03:13:44.246944 | 2025-11-20 03:13:44.248073 | LOOP [upload-logs : Compress console log and json output] 2025-11-20 03:13:44.332477 | localhost | skipping: Conditional result was False 2025-11-20 03:13:44.341983 | localhost | skipping: Conditional result was False 2025-11-20 03:13:44.350631 | 2025-11-20 03:13:44.350731 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-20 03:13:44.428399 | localhost | skipping: Conditional result was False 2025-11-20 03:13:44.428922 | 2025-11-20 03:13:44.437057 | localhost | skipping: Conditional result was False 2025-11-20 03:13:44.456509 | 2025-11-20 03:13:44.456802 | LOOP [upload-logs : Upload console log and json output]