2025-06-28 03:18:05.383030 | Job console starting 2025-06-28 03:18:05.400411 | Updating git repos 2025-06-28 03:18:05.430501 | Cloning repos into workspace 2025-06-28 03:18:05.489436 | Restoring repo states 2025-06-28 03:18:05.498030 | Merging changes 2025-06-28 03:18:05.498386 | Checking out repos 2025-06-28 03:18:05.599504 | Preparing playbooks 2025-06-28 03:18:06.169761 | Running Ansible setup 2025-06-28 03:18:10.429135 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-28 03:18:11.214250 | 2025-06-28 03:18:11.214408 | PLAY [Base pre] 2025-06-28 03:18:11.230957 | 2025-06-28 03:18:11.231088 | TASK [Setup log path fact] 2025-06-28 03:18:11.260792 | debian-bookworm | ok 2025-06-28 03:18:11.276232 | 2025-06-28 03:18:11.276378 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-28 03:18:11.306744 | debian-bookworm | ok 2025-06-28 03:18:11.316694 | 2025-06-28 03:18:11.316814 | TASK [emit-job-header : Print job information] 2025-06-28 03:18:11.355976 | # Job Information 2025-06-28 03:18:11.356163 | Ansible Version: 2.16.14 2025-06-28 03:18:11.356209 | Job: python-black 2025-06-28 03:18:11.356257 | Pipeline: periodic-daily 2025-06-28 03:18:11.356290 | Executor: 521e9411259a 2025-06-28 03:18:11.356320 | Triggered by: https://github.com/osism/testbed 2025-06-28 03:18:11.356351 | Event ID: a383c0065a3949bc8e18f8256bc7b0e2 2025-06-28 03:18:11.361823 | 2025-06-28 03:18:11.361947 | LOOP [emit-job-header : Print node information] 2025-06-28 03:18:11.482942 | debian-bookworm | ok: 2025-06-28 03:18:11.483194 | debian-bookworm | # Node Information 2025-06-28 03:18:11.483232 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-28 03:18:11.483258 | debian-bookworm | Hostname: debian 2025-06-28 03:18:11.483281 | debian-bookworm | Username: zuul 2025-06-28 03:18:11.483303 | debian-bookworm | Distro: Debian 12.11 2025-06-28 03:18:11.483328 | debian-bookworm | Provider: regiocloud-a 2025-06-28 03:18:11.483349 | debian-bookworm | Region: 2025-06-28 03:18:11.483370 | debian-bookworm | Label: debian-bookworm 2025-06-28 03:18:11.483389 | debian-bookworm | Product Name: OpenStack Nova 2025-06-28 03:18:11.483408 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe69:ddea 2025-06-28 03:18:11.531851 | 2025-06-28 03:18:11.532058 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-28 03:18:12.033696 | debian-bookworm -> localhost | changed 2025-06-28 03:18:12.041269 | 2025-06-28 03:18:12.041391 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-28 03:18:13.181005 | debian-bookworm -> localhost | changed 2025-06-28 03:18:13.198068 | 2025-06-28 03:18:13.198219 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-28 03:18:13.500428 | debian-bookworm -> localhost | ok 2025-06-28 03:18:13.510748 | 2025-06-28 03:18:13.510932 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-28 03:18:13.543473 | debian-bookworm | ok 2025-06-28 03:18:13.563156 | debian-bookworm | included: /var/lib/zuul/builds/9ea8c2cb319e482ebc91bd4ed91e6012/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-28 03:18:13.569372 | 2025-06-28 03:18:13.569480 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-28 03:18:14.750250 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-28 03:18:14.750540 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9ea8c2cb319e482ebc91bd4ed91e6012/work/9ea8c2cb319e482ebc91bd4ed91e6012_id_rsa 2025-06-28 03:18:14.750607 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9ea8c2cb319e482ebc91bd4ed91e6012/work/9ea8c2cb319e482ebc91bd4ed91e6012_id_rsa.pub 2025-06-28 03:18:14.750636 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-28 03:18:14.750661 | debian-bookworm -> localhost | SHA256:VwEOeUo5HrW8ZZ0DpRyUEi59scC512l0px7+19HmY9I zuul-build-sshkey 2025-06-28 03:18:14.750684 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-28 03:18:14.750716 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-28 03:18:14.750739 | debian-bookworm -> localhost | | .===*o. | 2025-06-28 03:18:14.750760 | debian-bookworm -> localhost | | **=+.O..o| 2025-06-28 03:18:14.750781 | debian-bookworm -> localhost | | o.=*oOo++.| 2025-06-28 03:18:14.750801 | debian-bookworm -> localhost | | o..*. *. | 2025-06-28 03:18:14.750820 | debian-bookworm -> localhost | | S o. + ..| 2025-06-28 03:18:14.750884 | debian-bookworm -> localhost | | . o.o| 2025-06-28 03:18:14.750906 | debian-bookworm -> localhost | | .+o| 2025-06-28 03:18:14.751371 | debian-bookworm -> localhost | | . E=| 2025-06-28 03:18:14.751408 | debian-bookworm -> localhost | | o o| 2025-06-28 03:18:14.751433 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-28 03:18:14.751494 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.697549 2025-06-28 03:18:14.758052 | 2025-06-28 03:18:14.758162 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-28 03:18:14.789010 | debian-bookworm | ok 2025-06-28 03:18:14.798808 | debian-bookworm | included: /var/lib/zuul/builds/9ea8c2cb319e482ebc91bd4ed91e6012/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-28 03:18:14.807996 | 2025-06-28 03:18:14.808099 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-28 03:18:14.831808 | debian-bookworm | skipping: Conditional result was False 2025-06-28 03:18:14.837851 | 2025-06-28 03:18:14.837962 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-28 03:18:15.482514 | debian-bookworm | changed 2025-06-28 03:18:15.489518 | 2025-06-28 03:18:15.489704 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-28 03:18:15.755150 | debian-bookworm | ok 2025-06-28 03:18:15.763966 | 2025-06-28 03:18:15.764123 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-28 03:18:16.472150 | debian-bookworm | changed 2025-06-28 03:18:16.483590 | 2025-06-28 03:18:16.483761 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-28 03:18:17.159234 | debian-bookworm | changed 2025-06-28 03:18:17.167110 | 2025-06-28 03:18:17.167258 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-28 03:18:17.191556 | debian-bookworm | skipping: Conditional result was False 2025-06-28 03:18:17.197763 | 2025-06-28 03:18:17.197877 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-28 03:18:17.646567 | debian-bookworm -> localhost | changed 2025-06-28 03:18:17.666476 | 2025-06-28 03:18:17.666666 | TASK [add-build-sshkey : Add back temp key] 2025-06-28 03:18:18.025229 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9ea8c2cb319e482ebc91bd4ed91e6012/work/9ea8c2cb319e482ebc91bd4ed91e6012_id_rsa (zuul-build-sshkey) 2025-06-28 03:18:18.025486 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017191 2025-06-28 03:18:18.034000 | 2025-06-28 03:18:18.034124 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-28 03:18:18.443354 | debian-bookworm | ok 2025-06-28 03:18:18.449663 | 2025-06-28 03:18:18.449793 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-28 03:18:18.474101 | debian-bookworm | skipping: Conditional result was False 2025-06-28 03:18:18.488779 | 2025-06-28 03:18:18.488904 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-28 03:18:18.918355 | debian-bookworm | ok 2025-06-28 03:18:18.935974 | 2025-06-28 03:18:18.936104 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-28 03:18:18.977079 | debian-bookworm | ok 2025-06-28 03:18:18.983252 | 2025-06-28 03:18:18.983503 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-28 03:18:19.324609 | debian-bookworm -> localhost | ok 2025-06-28 03:18:19.337004 | 2025-06-28 03:18:19.337166 | TASK [validate-host : Collect information about the host] 2025-06-28 03:18:20.503056 | debian-bookworm | ok 2025-06-28 03:18:20.514290 | 2025-06-28 03:18:20.514423 | TASK [validate-host : Sanitize hostname] 2025-06-28 03:18:20.626996 | debian-bookworm | ok 2025-06-28 03:18:20.687490 | 2025-06-28 03:18:20.687660 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-28 03:18:21.366020 | debian-bookworm -> localhost | changed 2025-06-28 03:18:21.382698 | 2025-06-28 03:18:21.383210 | TASK [validate-host : Collect information about zuul worker] 2025-06-28 03:18:21.872031 | debian-bookworm | ok 2025-06-28 03:18:21.889244 | 2025-06-28 03:18:21.889485 | TASK [validate-host : Write out all zuul information for each host] 2025-06-28 03:18:22.515859 | debian-bookworm -> localhost | changed 2025-06-28 03:18:22.535325 | 2025-06-28 03:18:22.535516 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-28 03:18:22.866988 | debian-bookworm | ok 2025-06-28 03:18:22.890099 | 2025-06-28 03:18:22.890238 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-28 03:18:24.066106 | debian-bookworm | changed: 2025-06-28 03:18:24.066358 | debian-bookworm | cd+++++++++ src/ 2025-06-28 03:18:24.066402 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-28 03:18:24.066432 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-28 03:18:24.066459 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-28 03:18:24.066485 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007093 2025-06-28 03:18:47.397277 | 2025-06-28 03:18:47.397394 | TASK [upload-logs : Upload logs to log server] 2025-06-28 03:18:48.002001 | localhost | Output suppressed because no_log was given 2025-06-28 03:18:48.005197 | 2025-06-28 03:18:48.005384 | LOOP [upload-logs : Compress console log and json output] 2025-06-28 03:18:48.065209 | localhost | skipping: Conditional result was False 2025-06-28 03:18:48.072172 | localhost | skipping: Conditional result was False 2025-06-28 03:18:48.080402 | 2025-06-28 03:18:48.080794 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-28 03:18:48.134375 | localhost | skipping: Conditional result was False 2025-06-28 03:18:48.135128 | 2025-06-28 03:18:48.138680 | localhost | skipping: Conditional result was False 2025-06-28 03:18:48.155738 | 2025-06-28 03:18:48.156063 | LOOP [upload-logs : Upload console log and json output]