2025-08-23 21:50:10.319494 | Job console starting 2025-08-23 21:50:10.333025 | Updating git repos 2025-08-23 21:50:10.370109 | Cloning repos into workspace 2025-08-23 21:50:10.446654 | Restoring repo states 2025-08-23 21:50:10.459743 | Merging changes 2025-08-23 21:50:11.049604 | Checking out repos 2025-08-23 21:50:11.084963 | Preparing playbooks 2025-08-23 21:50:11.698825 | Running Ansible setup 2025-08-23 21:50:16.010459 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-23 21:50:16.793065 | 2025-08-23 21:50:16.793231 | PLAY [Base pre] 2025-08-23 21:50:16.813212 | 2025-08-23 21:50:16.813395 | TASK [Setup log path fact] 2025-08-23 21:50:16.833284 | debian-bookworm | ok 2025-08-23 21:50:16.851176 | 2025-08-23 21:50:16.851347 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-23 21:50:16.895270 | debian-bookworm | ok 2025-08-23 21:50:16.908970 | 2025-08-23 21:50:16.909107 | TASK [emit-job-header : Print job information] 2025-08-23 21:50:16.962412 | # Job Information 2025-08-23 21:50:16.962852 | Ansible Version: 2.16.14 2025-08-23 21:50:16.962912 | Job: python-black 2025-08-23 21:50:16.962950 | Pipeline: check 2025-08-23 21:50:16.962977 | Executor: 521e9411259a 2025-08-23 21:50:16.963000 | Triggered by: https://github.com/osism/python-osism/pull/1663 2025-08-23 21:50:16.963024 | Event ID: a7312570-806a-11f0-8403-cf1c167f850c 2025-08-23 21:50:16.970585 | 2025-08-23 21:50:16.970783 | LOOP [emit-job-header : Print node information] 2025-08-23 21:50:17.118133 | debian-bookworm | ok: 2025-08-23 21:50:17.118394 | debian-bookworm | # Node Information 2025-08-23 21:50:17.118432 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-23 21:50:17.118457 | debian-bookworm | Hostname: debian 2025-08-23 21:50:17.118479 | debian-bookworm | Username: zuul 2025-08-23 21:50:17.118500 | debian-bookworm | Distro: Debian 12.11 2025-08-23 21:50:17.118524 | debian-bookworm | Provider: regiocloud-a 2025-08-23 21:50:17.118545 | debian-bookworm | Region: 2025-08-23 21:50:17.118566 | debian-bookworm | Label: debian-bookworm 2025-08-23 21:50:17.118586 | debian-bookworm | Product Name: OpenStack Nova 2025-08-23 21:50:17.118652 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe13:fbbb 2025-08-23 21:50:17.136965 | 2025-08-23 21:50:17.137102 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-23 21:50:17.673391 | debian-bookworm -> localhost | changed 2025-08-23 21:50:17.681421 | 2025-08-23 21:50:17.681549 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-23 21:50:18.788396 | debian-bookworm -> localhost | changed 2025-08-23 21:50:18.799606 | 2025-08-23 21:50:18.799736 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-23 21:50:19.086506 | debian-bookworm -> localhost | ok 2025-08-23 21:50:19.092883 | 2025-08-23 21:50:19.093017 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-23 21:50:19.131200 | debian-bookworm | ok 2025-08-23 21:50:19.169850 | debian-bookworm | included: /var/lib/zuul/builds/4df4d7121aa04e28b06810e940213f0c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-23 21:50:19.178262 | 2025-08-23 21:50:19.178464 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-23 21:50:20.442653 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-23 21:50:20.442955 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4df4d7121aa04e28b06810e940213f0c/work/4df4d7121aa04e28b06810e940213f0c_id_rsa 2025-08-23 21:50:20.443002 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4df4d7121aa04e28b06810e940213f0c/work/4df4d7121aa04e28b06810e940213f0c_id_rsa.pub 2025-08-23 21:50:20.443030 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-23 21:50:20.443056 | debian-bookworm -> localhost | SHA256:nRDaNQEVEKDb6oV2oYSfKZxGhZnTW1+fzM67jNBa08w zuul-build-sshkey 2025-08-23 21:50:20.443088 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-23 21:50:20.443121 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-23 21:50:20.443144 | debian-bookworm -> localhost | | ..==*o | 2025-08-23 21:50:20.443165 | debian-bookworm -> localhost | | = . o o . | 2025-08-23 21:50:20.443186 | debian-bookworm -> localhost | | = + o o . | 2025-08-23 21:50:20.443206 | debian-bookworm -> localhost | | + = . + = . | 2025-08-23 21:50:20.443225 | debian-bookworm -> localhost | | o + o S o = | 2025-08-23 21:50:20.443258 | debian-bookworm -> localhost | | o + * . . * | 2025-08-23 21:50:20.443280 | debian-bookworm -> localhost | | = O o . + E | 2025-08-23 21:50:20.443320 | debian-bookworm -> localhost | | . + o + + . | 2025-08-23 21:50:20.443342 | debian-bookworm -> localhost | | . . . +. | 2025-08-23 21:50:20.443363 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-23 21:50:20.443434 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.645859 2025-08-23 21:50:20.450408 | 2025-08-23 21:50:20.450540 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-23 21:50:20.479179 | debian-bookworm | ok 2025-08-23 21:50:20.488783 | debian-bookworm | included: /var/lib/zuul/builds/4df4d7121aa04e28b06810e940213f0c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-23 21:50:20.498168 | 2025-08-23 21:50:20.498283 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-23 21:50:20.522103 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:50:20.528124 | 2025-08-23 21:50:20.528238 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-23 21:50:21.219819 | debian-bookworm | changed 2025-08-23 21:50:21.229089 | 2025-08-23 21:50:21.229862 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-23 21:50:21.494660 | debian-bookworm | ok 2025-08-23 21:50:21.504239 | 2025-08-23 21:50:21.504408 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-23 21:50:22.167187 | debian-bookworm | changed 2025-08-23 21:50:22.174775 | 2025-08-23 21:50:22.174924 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-23 21:50:22.809588 | debian-bookworm | changed 2025-08-23 21:50:22.815882 | 2025-08-23 21:50:22.816002 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-23 21:50:22.841039 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:50:22.856382 | 2025-08-23 21:50:22.856542 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-23 21:50:23.340006 | debian-bookworm -> localhost | changed 2025-08-23 21:50:23.361550 | 2025-08-23 21:50:23.361676 | TASK [add-build-sshkey : Add back temp key] 2025-08-23 21:50:23.721124 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4df4d7121aa04e28b06810e940213f0c/work/4df4d7121aa04e28b06810e940213f0c_id_rsa (zuul-build-sshkey) 2025-08-23 21:50:23.721721 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030121 2025-08-23 21:50:23.738572 | 2025-08-23 21:50:23.738749 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-23 21:50:24.178020 | debian-bookworm | ok 2025-08-23 21:50:24.186712 | 2025-08-23 21:50:24.186878 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-23 21:50:24.212250 | debian-bookworm | skipping: Conditional result was False 2025-08-23 21:50:24.234485 | 2025-08-23 21:50:24.234611 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-23 21:50:24.680913 | debian-bookworm | ok 2025-08-23 21:50:24.696552 | 2025-08-23 21:50:24.696692 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-23 21:50:24.737898 | debian-bookworm | ok 2025-08-23 21:50:24.745396 | 2025-08-23 21:50:24.745529 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-23 21:50:25.069037 | debian-bookworm -> localhost | ok 2025-08-23 21:50:25.090189 | 2025-08-23 21:50:25.091416 | TASK [validate-host : Collect information about the host] 2025-08-23 21:50:26.258137 | debian-bookworm | ok 2025-08-23 21:50:26.273649 | 2025-08-23 21:50:26.273775 | TASK [validate-host : Sanitize hostname] 2025-08-23 21:50:26.400314 | debian-bookworm | ok 2025-08-23 21:50:26.461666 | 2025-08-23 21:50:26.461906 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-23 21:50:27.067058 | debian-bookworm -> localhost | changed 2025-08-23 21:50:27.073096 | 2025-08-23 21:50:27.073209 | TASK [validate-host : Collect information about zuul worker] 2025-08-23 21:50:27.529363 | debian-bookworm | ok 2025-08-23 21:50:27.534528 | 2025-08-23 21:50:27.534645 | TASK [validate-host : Write out all zuul information for each host] 2025-08-23 21:50:28.069867 | debian-bookworm -> localhost | changed 2025-08-23 21:50:28.079852 | 2025-08-23 21:50:28.079964 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-23 21:50:28.355583 | debian-bookworm | ok 2025-08-23 21:50:28.364063 | 2025-08-23 21:50:28.364192 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-23 21:50:29.432988 | debian-bookworm | changed: 2025-08-23 21:50:29.433204 | debian-bookworm | cd+++++++++ src/ 2025-08-23 21:50:29.433241 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-23 21:50:29.433265 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-23 21:50:29.433286 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-08-23 21:50:29.433351 | debian-bookworm | Containerfile 2025-08-23 21:50:29.433467 | debian-bookworm | Containerfile 2025-08-23 21:50:29.465526 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007748 2025-08-23 21:50:56.620718 | 2025-08-23 21:50:56.620916 | TASK [upload-logs : Upload logs to log server] 2025-08-23 21:50:57.264761 | localhost | Output suppressed because no_log was given 2025-08-23 21:50:57.266666 | 2025-08-23 21:50:57.266779 | LOOP [upload-logs : Compress console log and json output] 2025-08-23 21:50:57.335655 | localhost | skipping: Conditional result was False 2025-08-23 21:50:57.343792 | localhost | skipping: Conditional result was False 2025-08-23 21:50:57.356804 | 2025-08-23 21:50:57.357009 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-23 21:50:57.403588 | localhost | skipping: Conditional result was False 2025-08-23 21:50:57.403906 | 2025-08-23 21:50:57.411372 | localhost | skipping: Conditional result was False 2025-08-23 21:50:57.418222 | 2025-08-23 21:50:57.418384 | LOOP [upload-logs : Upload console log and json output]