2025-05-16 03:10:04.412948 | Job console starting 2025-05-16 03:10:04.434332 | Updating git repos 2025-05-16 03:10:04.471171 | Cloning repos into workspace 2025-05-16 03:10:04.525306 | Restoring repo states 2025-05-16 03:10:04.537033 | Merging changes 2025-05-16 03:10:04.537063 | Checking out repos 2025-05-16 03:10:04.589880 | Preparing playbooks 2025-05-16 03:10:05.215331 | Running Ansible setup 2025-05-16 03:10:09.563121 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-16 03:10:10.316440 | 2025-05-16 03:10:10.316624 | PLAY [Base pre] 2025-05-16 03:10:10.334398 | 2025-05-16 03:10:10.334569 | TASK [Setup log path fact] 2025-05-16 03:10:10.377789 | debian-bookworm | ok 2025-05-16 03:10:10.397323 | 2025-05-16 03:10:10.397474 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-16 03:10:10.440665 | debian-bookworm | ok 2025-05-16 03:10:10.451921 | 2025-05-16 03:10:10.452050 | TASK [emit-job-header : Print job information] 2025-05-16 03:10:10.503191 | # Job Information 2025-05-16 03:10:10.503400 | Ansible Version: 2.16.14 2025-05-16 03:10:10.503442 | Job: python-black 2025-05-16 03:10:10.503480 | Pipeline: periodic-daily 2025-05-16 03:10:10.503507 | Executor: 521e9411259a 2025-05-16 03:10:10.503531 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2025-05-16 03:10:10.503557 | Event ID: 69d10d8e47b246a48f9b296db512e6c2 2025-05-16 03:10:10.509406 | 2025-05-16 03:10:10.509533 | LOOP [emit-job-header : Print node information] 2025-05-16 03:10:10.641976 | debian-bookworm | ok: 2025-05-16 03:10:10.642174 | debian-bookworm | # Node Information 2025-05-16 03:10:10.642218 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-16 03:10:10.642257 | debian-bookworm | Hostname: debian 2025-05-16 03:10:10.642282 | debian-bookworm | Username: zuul 2025-05-16 03:10:10.642302 | debian-bookworm | Distro: Debian 12.10 2025-05-16 03:10:10.642326 | debian-bookworm | Provider: regiocloud-a 2025-05-16 03:10:10.642347 | debian-bookworm | Region: 2025-05-16 03:10:10.642369 | debian-bookworm | Label: debian-bookworm 2025-05-16 03:10:10.642389 | debian-bookworm | Product Name: OpenStack Nova 2025-05-16 03:10:10.642408 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fece:d96f 2025-05-16 03:10:10.657627 | 2025-05-16 03:10:10.657767 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-16 03:10:11.111502 | debian-bookworm -> localhost | changed 2025-05-16 03:10:11.124409 | 2025-05-16 03:10:11.124567 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-16 03:10:12.149267 | debian-bookworm -> localhost | changed 2025-05-16 03:10:12.159831 | 2025-05-16 03:10:12.159952 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-16 03:10:12.508303 | debian-bookworm -> localhost | ok 2025-05-16 03:10:12.514348 | 2025-05-16 03:10:12.514462 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-16 03:10:12.556326 | debian-bookworm | ok 2025-05-16 03:10:12.580288 | debian-bookworm | included: /var/lib/zuul/builds/50b0eb846d9e4722b55da438a3ab9e53/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-16 03:10:12.586217 | 2025-05-16 03:10:12.586314 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-16 03:10:13.892496 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-16 03:10:13.892685 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/50b0eb846d9e4722b55da438a3ab9e53/work/50b0eb846d9e4722b55da438a3ab9e53_id_rsa 2025-05-16 03:10:13.892721 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/50b0eb846d9e4722b55da438a3ab9e53/work/50b0eb846d9e4722b55da438a3ab9e53_id_rsa.pub 2025-05-16 03:10:13.892747 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-16 03:10:13.892769 | debian-bookworm -> localhost | SHA256:wdNjS3Dd+K/H69DsNZq0Bgmuc88LMWgIvGsLwlvm24Q zuul-build-sshkey 2025-05-16 03:10:13.892790 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-16 03:10:13.892823 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-16 03:10:13.892860 | debian-bookworm -> localhost | | . .. o | 2025-05-16 03:10:13.892884 | debian-bookworm -> localhost | | . . + o . | 2025-05-16 03:10:13.892904 | debian-bookworm -> localhost | | o + = . | 2025-05-16 03:10:13.892923 | debian-bookworm -> localhost | | o . .* o . | 2025-05-16 03:10:13.892943 | debian-bookworm -> localhost | | . . oSoo . . | 2025-05-16 03:10:13.892967 | debian-bookworm -> localhost | |. o . .oo o .| 2025-05-16 03:10:13.892987 | debian-bookworm -> localhost | |.o E . .. .o *.| 2025-05-16 03:10:13.893006 | debian-bookworm -> localhost | |. B + o .o ..B =| 2025-05-16 03:10:13.893026 | debian-bookworm -> localhost | | . +.. o .+o+.=.| 2025-05-16 03:10:13.893046 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-16 03:10:13.893093 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.863782 2025-05-16 03:10:13.899198 | 2025-05-16 03:10:13.899291 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-16 03:10:13.916764 | debian-bookworm | ok 2025-05-16 03:10:13.925909 | debian-bookworm | included: /var/lib/zuul/builds/50b0eb846d9e4722b55da438a3ab9e53/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-16 03:10:13.934612 | 2025-05-16 03:10:13.934701 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-16 03:10:13.951053 | debian-bookworm | skipping: Conditional result was False 2025-05-16 03:10:13.956545 | 2025-05-16 03:10:13.956634 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-16 03:10:14.620103 | debian-bookworm | changed 2025-05-16 03:10:14.625391 | 2025-05-16 03:10:14.625486 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-16 03:10:14.864273 | debian-bookworm | ok 2025-05-16 03:10:14.873046 | 2025-05-16 03:10:14.873172 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-16 03:10:15.628272 | debian-bookworm | changed 2025-05-16 03:10:15.638956 | 2025-05-16 03:10:15.639079 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-16 03:10:16.272505 | debian-bookworm | changed 2025-05-16 03:10:16.281497 | 2025-05-16 03:10:16.281733 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-16 03:10:16.316874 | debian-bookworm | skipping: Conditional result was False 2025-05-16 03:10:16.333226 | 2025-05-16 03:10:16.333395 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-16 03:10:16.830157 | debian-bookworm -> localhost | changed 2025-05-16 03:10:16.853091 | 2025-05-16 03:10:16.853325 | TASK [add-build-sshkey : Add back temp key] 2025-05-16 03:10:17.213507 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/50b0eb846d9e4722b55da438a3ab9e53/work/50b0eb846d9e4722b55da438a3ab9e53_id_rsa (zuul-build-sshkey) 2025-05-16 03:10:17.213891 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018200 2025-05-16 03:10:17.227467 | 2025-05-16 03:10:17.227655 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-16 03:10:17.622901 | debian-bookworm | ok 2025-05-16 03:10:17.631561 | 2025-05-16 03:10:17.631797 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-16 03:10:17.657987 | debian-bookworm | skipping: Conditional result was False 2025-05-16 03:10:17.685900 | 2025-05-16 03:10:17.686198 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-16 03:10:18.212621 | debian-bookworm | ok 2025-05-16 03:10:18.225738 | 2025-05-16 03:10:18.225896 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-16 03:10:18.272555 | debian-bookworm | ok 2025-05-16 03:10:18.278306 | 2025-05-16 03:10:18.278424 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-16 03:10:18.638011 | debian-bookworm -> localhost | ok 2025-05-16 03:10:18.655653 | 2025-05-16 03:10:18.655942 | TASK [validate-host : Collect information about the host] 2025-05-16 03:10:19.804311 | debian-bookworm | ok 2025-05-16 03:10:19.817227 | 2025-05-16 03:10:19.817389 | TASK [validate-host : Sanitize hostname] 2025-05-16 03:10:19.947124 | debian-bookworm | ok 2025-05-16 03:10:20.000589 | 2025-05-16 03:10:20.000752 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-16 03:10:20.632286 | debian-bookworm -> localhost | changed 2025-05-16 03:10:20.644966 | 2025-05-16 03:10:20.645169 | TASK [validate-host : Collect information about zuul worker] 2025-05-16 03:10:21.132689 | debian-bookworm | ok 2025-05-16 03:10:21.138573 | 2025-05-16 03:10:21.138735 | TASK [validate-host : Write out all zuul information for each host] 2025-05-16 03:10:22.269886 | debian-bookworm -> localhost | changed 2025-05-16 03:10:22.290529 | 2025-05-16 03:10:22.290672 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-16 03:10:22.609773 | debian-bookworm | ok 2025-05-16 03:10:22.617459 | 2025-05-16 03:10:22.617616 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-16 03:10:23.574785 | debian-bookworm | changed: 2025-05-16 03:10:23.575227 | debian-bookworm | cd+++++++++ src/ 2025-05-16 03:10:23.575291 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-16 03:10:23.575334 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-16 03:10:23.575372 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-05-16 03:10:23.575407 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005504 2025-05-16 03:10:50.422033 | 2025-05-16 03:10:50.422158 | TASK [upload-logs : Upload logs to log server] 2025-05-16 03:10:51.422754 | localhost | Output suppressed because no_log was given 2025-05-16 03:10:51.430535 | 2025-05-16 03:10:51.430663 | LOOP [upload-logs : Compress console log and json output] 2025-05-16 03:10:51.557372 | localhost | skipping: Conditional result was False 2025-05-16 03:10:51.583291 | localhost | skipping: Conditional result was False 2025-05-16 03:10:51.602276 | 2025-05-16 03:10:51.602457 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-16 03:10:51.712594 | localhost | skipping: Conditional result was False 2025-05-16 03:10:51.712965 | 2025-05-16 03:10:51.724346 | localhost | skipping: Conditional result was False 2025-05-16 03:10:51.735294 | 2025-05-16 03:10:51.735431 | LOOP [upload-logs : Upload console log and json output]