2025-05-15 03:22:59.400098 | Job console starting 2025-05-15 03:22:59.420646 | Updating git repos 2025-05-15 03:22:59.465418 | Cloning repos into workspace 2025-05-15 03:22:59.533624 | Restoring repo states 2025-05-15 03:22:59.541418 | Merging changes 2025-05-15 03:22:59.541613 | Checking out repos 2025-05-15 03:22:59.651983 | Preparing playbooks 2025-05-15 03:23:00.436615 | Running Ansible setup 2025-05-15 03:23:05.534500 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-15 03:23:06.471698 | 2025-05-15 03:23:06.471867 | PLAY [Base pre] 2025-05-15 03:23:06.489219 | 2025-05-15 03:23:06.489710 | TASK [Setup log path fact] 2025-05-15 03:23:06.509157 | debian-bookworm | ok 2025-05-15 03:23:06.526099 | 2025-05-15 03:23:06.526249 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-15 03:23:06.573893 | debian-bookworm | ok 2025-05-15 03:23:06.586976 | 2025-05-15 03:23:06.587118 | TASK [emit-job-header : Print job information] 2025-05-15 03:23:06.640590 | # Job Information 2025-05-15 03:23:06.640862 | Ansible Version: 2.16.14 2025-05-15 03:23:06.640920 | Job: python-black 2025-05-15 03:23:06.640973 | Pipeline: periodic-daily 2025-05-15 03:23:06.641011 | Executor: 521e9411259a 2025-05-15 03:23:06.641044 | Triggered by: https://github.com/osism/testbed 2025-05-15 03:23:06.641082 | Event ID: cae9f980d4cd438aa31b3e3016900e77 2025-05-15 03:23:06.648087 | 2025-05-15 03:23:06.648225 | LOOP [emit-job-header : Print node information] 2025-05-15 03:23:06.770921 | debian-bookworm | ok: 2025-05-15 03:23:06.771272 | debian-bookworm | # Node Information 2025-05-15 03:23:06.771312 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-15 03:23:06.771338 | debian-bookworm | Hostname: debian 2025-05-15 03:23:06.771362 | debian-bookworm | Username: zuul 2025-05-15 03:23:06.771383 | debian-bookworm | Distro: Debian 12.10 2025-05-15 03:23:06.771407 | debian-bookworm | Provider: regiocloud-a 2025-05-15 03:23:06.771429 | debian-bookworm | Region: 2025-05-15 03:23:06.771451 | debian-bookworm | Label: debian-bookworm 2025-05-15 03:23:06.771471 | debian-bookworm | Product Name: OpenStack Nova 2025-05-15 03:23:06.771491 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe86:f032 2025-05-15 03:23:06.792427 | 2025-05-15 03:23:06.792632 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-15 03:23:07.365359 | debian-bookworm -> localhost | changed 2025-05-15 03:23:07.383382 | 2025-05-15 03:23:07.383611 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-15 03:23:08.651907 | debian-bookworm -> localhost | changed 2025-05-15 03:23:08.671667 | 2025-05-15 03:23:08.671809 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-15 03:23:08.970157 | debian-bookworm -> localhost | ok 2025-05-15 03:23:08.977046 | 2025-05-15 03:23:08.977174 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-15 03:23:09.017515 | debian-bookworm | ok 2025-05-15 03:23:09.039526 | debian-bookworm | included: /var/lib/zuul/builds/9c098cd45fa545caa761a01043008c01/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-15 03:23:09.046036 | 2025-05-15 03:23:09.046150 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-15 03:23:09.993490 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-15 03:23:09.993938 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9c098cd45fa545caa761a01043008c01/work/9c098cd45fa545caa761a01043008c01_id_rsa 2025-05-15 03:23:09.993992 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9c098cd45fa545caa761a01043008c01/work/9c098cd45fa545caa761a01043008c01_id_rsa.pub 2025-05-15 03:23:09.994022 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-15 03:23:09.994050 | debian-bookworm -> localhost | SHA256:Io9AMetFOWp8qEsN7IowJ/gywDIslL5o9BnPTErbbuk zuul-build-sshkey 2025-05-15 03:23:09.994075 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-15 03:23:09.994113 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-15 03:23:09.994138 | debian-bookworm -> localhost | | o .. | 2025-05-15 03:23:09.994162 | debian-bookworm -> localhost | | =o | 2025-05-15 03:23:09.994183 | debian-bookworm -> localhost | |..+o.. | 2025-05-15 03:23:09.994205 | debian-bookworm -> localhost | | B=.. | 2025-05-15 03:23:09.994227 | debian-bookworm -> localhost | |Bo=.. . S | 2025-05-15 03:23:09.994251 | debian-bookworm -> localhost | |@B.= = . | 2025-05-15 03:23:09.994275 | debian-bookworm -> localhost | |@B+ % o | 2025-05-15 03:23:09.994296 | debian-bookworm -> localhost | |Bo.= B | 2025-05-15 03:23:09.994320 | debian-bookworm -> localhost | |.o +E | 2025-05-15 03:23:09.994342 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-15 03:23:09.994399 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.356771 2025-05-15 03:23:10.006243 | 2025-05-15 03:23:10.007451 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-15 03:23:10.055174 | debian-bookworm | ok 2025-05-15 03:23:10.065731 | debian-bookworm | included: /var/lib/zuul/builds/9c098cd45fa545caa761a01043008c01/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-15 03:23:10.075327 | 2025-05-15 03:23:10.075428 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-15 03:23:10.110429 | debian-bookworm | skipping: Conditional result was False 2025-05-15 03:23:10.123441 | 2025-05-15 03:23:10.123659 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-15 03:23:10.833821 | debian-bookworm | changed 2025-05-15 03:23:10.841736 | 2025-05-15 03:23:10.841854 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-15 03:23:11.123795 | debian-bookworm | ok 2025-05-15 03:23:11.132605 | 2025-05-15 03:23:11.132744 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-15 03:23:11.820967 | debian-bookworm | changed 2025-05-15 03:23:11.833880 | 2025-05-15 03:23:11.834009 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-15 03:23:12.510309 | debian-bookworm | changed 2025-05-15 03:23:12.518043 | 2025-05-15 03:23:12.518212 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-15 03:23:12.553949 | debian-bookworm | skipping: Conditional result was False 2025-05-15 03:23:12.566766 | 2025-05-15 03:23:12.566985 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-15 03:23:13.049215 | debian-bookworm -> localhost | changed 2025-05-15 03:23:13.061773 | 2025-05-15 03:23:13.061921 | TASK [add-build-sshkey : Add back temp key] 2025-05-15 03:23:13.470204 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9c098cd45fa545caa761a01043008c01/work/9c098cd45fa545caa761a01043008c01_id_rsa (zuul-build-sshkey) 2025-05-15 03:23:13.470530 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020885 2025-05-15 03:23:13.480977 | 2025-05-15 03:23:13.481122 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-15 03:23:13.894679 | debian-bookworm | ok 2025-05-15 03:23:13.903705 | 2025-05-15 03:23:13.903858 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-15 03:23:13.929717 | debian-bookworm | skipping: Conditional result was False 2025-05-15 03:23:13.950354 | 2025-05-15 03:23:13.950479 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-15 03:23:14.401021 | debian-bookworm | ok 2025-05-15 03:23:14.415060 | 2025-05-15 03:23:14.415174 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-15 03:23:14.456476 | debian-bookworm | ok 2025-05-15 03:23:14.462542 | 2025-05-15 03:23:14.462700 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-15 03:23:14.763883 | debian-bookworm -> localhost | ok 2025-05-15 03:23:14.775505 | 2025-05-15 03:23:14.775668 | TASK [validate-host : Collect information about the host] 2025-05-15 03:23:15.952772 | debian-bookworm | ok 2025-05-15 03:23:15.977861 | 2025-05-15 03:23:15.978170 | TASK [validate-host : Sanitize hostname] 2025-05-15 03:23:16.111257 | debian-bookworm | ok 2025-05-15 03:23:16.168155 | 2025-05-15 03:23:16.168294 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-15 03:23:16.785841 | debian-bookworm -> localhost | changed 2025-05-15 03:23:16.794379 | 2025-05-15 03:23:16.794509 | TASK [validate-host : Collect information about zuul worker] 2025-05-15 03:23:17.233914 | debian-bookworm | ok 2025-05-15 03:23:17.241155 | 2025-05-15 03:23:17.241436 | TASK [validate-host : Write out all zuul information for each host] 2025-05-15 03:23:17.858121 | debian-bookworm -> localhost | changed 2025-05-15 03:23:17.868806 | 2025-05-15 03:23:17.868931 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-15 03:23:18.144304 | debian-bookworm | ok 2025-05-15 03:23:18.150527 | 2025-05-15 03:23:18.150667 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-15 03:23:19.267545 | debian-bookworm | changed: 2025-05-15 03:23:19.267985 | debian-bookworm | cd+++++++++ src/ 2025-05-15 03:23:19.268153 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-15 03:23:19.268192 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-15 03:23:19.268216 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-05-15 03:23:19.268238 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011328 2025-05-15 03:23:44.652411 | 2025-05-15 03:23:44.652522 | TASK [upload-logs : Upload logs to log server] 2025-05-15 03:23:45.236336 | localhost | Output suppressed because no_log was given 2025-05-15 03:23:45.239672 | 2025-05-15 03:23:45.239822 | LOOP [upload-logs : Compress console log and json output] 2025-05-15 03:23:45.301371 | localhost | skipping: Conditional result was False 2025-05-15 03:23:45.305465 | localhost | skipping: Conditional result was False 2025-05-15 03:23:45.314070 | 2025-05-15 03:23:45.314353 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-15 03:23:45.383783 | localhost | skipping: Conditional result was False 2025-05-15 03:23:45.384733 | 2025-05-15 03:23:45.386805 | localhost | skipping: Conditional result was False 2025-05-15 03:23:45.401536 | 2025-05-15 03:23:45.401901 | LOOP [upload-logs : Upload console log and json output]