2025-08-30 03:12:06.480048 | Job console starting 2025-08-30 03:12:06.502195 | Updating git repos 2025-08-30 03:12:06.541277 | Cloning repos into workspace 2025-08-30 03:12:06.635684 | Restoring repo states 2025-08-30 03:12:06.646148 | Merging changes 2025-08-30 03:12:06.646167 | Checking out repos 2025-08-30 03:12:06.784659 | Preparing playbooks 2025-08-30 03:12:07.676970 | Running Ansible setup 2025-08-30 03:12:12.341691 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-30 03:12:13.157835 | 2025-08-30 03:12:13.157989 | PLAY [Base pre] 2025-08-30 03:12:13.177528 | 2025-08-30 03:12:13.177702 | TASK [Setup log path fact] 2025-08-30 03:12:13.196720 | debian-bookworm | ok 2025-08-30 03:12:13.213272 | 2025-08-30 03:12:13.213411 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-30 03:12:13.243644 | debian-bookworm | ok 2025-08-30 03:12:13.259615 | 2025-08-30 03:12:13.259909 | TASK [emit-job-header : Print job information] 2025-08-30 03:12:13.311101 | # Job Information 2025-08-30 03:12:13.311289 | Ansible Version: 2.16.14 2025-08-30 03:12:13.311325 | Job: python-black 2025-08-30 03:12:13.311357 | Pipeline: periodic-daily 2025-08-30 03:12:13.311381 | Executor: 521e9411259a 2025-08-30 03:12:13.311402 | Triggered by: https://github.com/osism/testbed 2025-08-30 03:12:13.311424 | Event ID: 39290479d6fa43f49bde887fc2f4c4f3 2025-08-30 03:12:13.316940 | 2025-08-30 03:12:13.317055 | LOOP [emit-job-header : Print node information] 2025-08-30 03:12:13.431018 | debian-bookworm | ok: 2025-08-30 03:12:13.431221 | debian-bookworm | # Node Information 2025-08-30 03:12:13.431255 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-30 03:12:13.431280 | debian-bookworm | Hostname: debian 2025-08-30 03:12:13.431303 | debian-bookworm | Username: zuul 2025-08-30 03:12:13.431324 | debian-bookworm | Distro: Debian 12.11 2025-08-30 03:12:13.431348 | debian-bookworm | Provider: regiocloud-a 2025-08-30 03:12:13.431368 | debian-bookworm | Region: 2025-08-30 03:12:13.431389 | debian-bookworm | Label: debian-bookworm 2025-08-30 03:12:13.431409 | debian-bookworm | Product Name: OpenStack Nova 2025-08-30 03:12:13.431428 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefd:b6a0 2025-08-30 03:12:13.443731 | 2025-08-30 03:12:13.443869 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-30 03:12:13.953440 | debian-bookworm -> localhost | changed 2025-08-30 03:12:13.961135 | 2025-08-30 03:12:13.961272 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-30 03:12:15.122733 | debian-bookworm -> localhost | changed 2025-08-30 03:12:15.134876 | 2025-08-30 03:12:15.135005 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-30 03:12:15.421872 | debian-bookworm -> localhost | ok 2025-08-30 03:12:15.428444 | 2025-08-30 03:12:15.428608 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-30 03:12:15.469566 | debian-bookworm | ok 2025-08-30 03:12:15.488967 | debian-bookworm | included: /var/lib/zuul/builds/a06953af82e94571b95e6e198bfb1023/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-30 03:12:15.495467 | 2025-08-30 03:12:15.495621 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-30 03:12:16.809080 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-30 03:12:16.809324 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a06953af82e94571b95e6e198bfb1023/work/a06953af82e94571b95e6e198bfb1023_id_rsa 2025-08-30 03:12:16.809364 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a06953af82e94571b95e6e198bfb1023/work/a06953af82e94571b95e6e198bfb1023_id_rsa.pub 2025-08-30 03:12:16.809391 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-30 03:12:16.809415 | debian-bookworm -> localhost | SHA256:tPMayMSOQvRlgViNZ+978NbF7Vylz1EB3uN8hgZ9WG0 zuul-build-sshkey 2025-08-30 03:12:16.809437 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-30 03:12:16.809468 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-30 03:12:16.809491 | debian-bookworm -> localhost | | o.+. .. o| 2025-08-30 03:12:16.809512 | debian-bookworm -> localhost | | . o +. ...+E| 2025-08-30 03:12:16.809574 | debian-bookworm -> localhost | | . oo.. ..o+o| 2025-08-30 03:12:16.809598 | debian-bookworm -> localhost | | . . + ... .oo+| 2025-08-30 03:12:16.809618 | debian-bookworm -> localhost | | . . o.S .o==| 2025-08-30 03:12:16.809646 | debian-bookworm -> localhost | | . = .oo .+o+| 2025-08-30 03:12:16.809667 | debian-bookworm -> localhost | | . . + .+.. . =o| 2025-08-30 03:12:16.809696 | debian-bookworm -> localhost | | . .o+ . =| 2025-08-30 03:12:16.809717 | debian-bookworm -> localhost | | .o | 2025-08-30 03:12:16.809736 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-30 03:12:16.809798 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.816816 2025-08-30 03:12:16.816634 | 2025-08-30 03:12:16.816749 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-30 03:12:16.851714 | debian-bookworm | ok 2025-08-30 03:12:16.865358 | debian-bookworm | included: /var/lib/zuul/builds/a06953af82e94571b95e6e198bfb1023/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-30 03:12:16.875085 | 2025-08-30 03:12:16.875187 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-30 03:12:16.899656 | debian-bookworm | skipping: Conditional result was False 2025-08-30 03:12:16.907404 | 2025-08-30 03:12:16.907518 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-30 03:12:17.597174 | debian-bookworm | changed 2025-08-30 03:12:17.607950 | 2025-08-30 03:12:17.608329 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-30 03:12:17.876328 | debian-bookworm | ok 2025-08-30 03:12:17.882050 | 2025-08-30 03:12:17.882161 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-30 03:12:18.589930 | debian-bookworm | changed 2025-08-30 03:12:18.598338 | 2025-08-30 03:12:18.598463 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-30 03:12:19.281156 | debian-bookworm | changed 2025-08-30 03:12:19.289676 | 2025-08-30 03:12:19.289815 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-30 03:12:19.313983 | debian-bookworm | skipping: Conditional result was False 2025-08-30 03:12:19.319975 | 2025-08-30 03:12:19.320084 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-30 03:12:19.779676 | debian-bookworm -> localhost | changed 2025-08-30 03:12:19.792632 | 2025-08-30 03:12:19.792757 | TASK [add-build-sshkey : Add back temp key] 2025-08-30 03:12:20.130263 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a06953af82e94571b95e6e198bfb1023/work/a06953af82e94571b95e6e198bfb1023_id_rsa (zuul-build-sshkey) 2025-08-30 03:12:20.130808 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021419 2025-08-30 03:12:20.147047 | 2025-08-30 03:12:20.147191 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-30 03:12:20.617045 | debian-bookworm | ok 2025-08-30 03:12:20.624673 | 2025-08-30 03:12:20.624806 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-30 03:12:20.659331 | debian-bookworm | skipping: Conditional result was False 2025-08-30 03:12:20.680935 | 2025-08-30 03:12:20.681083 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-30 03:12:21.158151 | debian-bookworm | ok 2025-08-30 03:12:21.173850 | 2025-08-30 03:12:21.174131 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-30 03:12:21.217566 | debian-bookworm | ok 2025-08-30 03:12:21.223194 | 2025-08-30 03:12:21.223309 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-30 03:12:21.531971 | debian-bookworm -> localhost | ok 2025-08-30 03:12:21.541569 | 2025-08-30 03:12:21.541719 | TASK [validate-host : Collect information about the host] 2025-08-30 03:12:22.745266 | debian-bookworm | ok 2025-08-30 03:12:22.773820 | 2025-08-30 03:12:22.774319 | TASK [validate-host : Sanitize hostname] 2025-08-30 03:12:22.970285 | debian-bookworm | ok 2025-08-30 03:12:23.035298 | 2025-08-30 03:12:23.035437 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-30 03:12:24.217218 | debian-bookworm -> localhost | changed 2025-08-30 03:12:24.223269 | 2025-08-30 03:12:24.223389 | TASK [validate-host : Collect information about zuul worker] 2025-08-30 03:12:24.709554 | debian-bookworm | ok 2025-08-30 03:12:24.714651 | 2025-08-30 03:12:24.714751 | TASK [validate-host : Write out all zuul information for each host] 2025-08-30 03:12:25.217659 | debian-bookworm -> localhost | changed 2025-08-30 03:12:25.234498 | 2025-08-30 03:12:25.234695 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-30 03:12:25.508497 | debian-bookworm | ok 2025-08-30 03:12:25.516535 | 2025-08-30 03:12:25.516648 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-30 03:12:26.715176 | debian-bookworm | changed: 2025-08-30 03:12:26.715338 | debian-bookworm | cd+++++++++ src/ 2025-08-30 03:12:26.715373 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-30 03:12:26.715397 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-30 03:12:26.715419 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-08-30 03:12:26.715439 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008251 2025-08-30 03:12:51.532195 | 2025-08-30 03:12:51.532283 | TASK [upload-logs : Upload logs to log server] 2025-08-30 03:12:52.083802 | localhost | Output suppressed because no_log was given 2025-08-30 03:12:52.085407 | 2025-08-30 03:12:52.085507 | LOOP [upload-logs : Compress console log and json output] 2025-08-30 03:12:52.126218 | localhost | skipping: Conditional result was False 2025-08-30 03:12:52.134383 | localhost | skipping: Conditional result was False 2025-08-30 03:12:52.140970 | 2025-08-30 03:12:52.141060 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-30 03:12:52.196193 | localhost | skipping: Conditional result was False 2025-08-30 03:12:52.196429 | 2025-08-30 03:12:52.202547 | localhost | skipping: Conditional result was False 2025-08-30 03:12:52.206792 | 2025-08-30 03:12:52.206914 | LOOP [upload-logs : Upload console log and json output]