2026-01-29 18:06:10.959239 | Job console starting 2026-01-29 18:06:10.984169 | Updating git repos 2026-01-29 18:06:11.010156 | Cloning repos into workspace 2026-01-29 18:06:11.070390 | Restoring repo states 2026-01-29 18:06:11.078799 | Merging changes 2026-01-29 18:06:11.593639 | Checking out repos 2026-01-29 18:06:11.659939 | Preparing playbooks 2026-01-29 18:06:12.468423 | Running Ansible setup 2026-01-29 18:06:16.801416 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 18:06:17.576032 | 2026-01-29 18:06:17.576187 | PLAY [Base pre] 2026-01-29 18:06:17.592232 | 2026-01-29 18:06:17.592376 | TASK [Setup log path fact] 2026-01-29 18:06:17.619401 | debian-bookworm | ok 2026-01-29 18:06:17.636114 | 2026-01-29 18:06:17.636280 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 18:06:17.678377 | debian-bookworm | ok 2026-01-29 18:06:17.688365 | 2026-01-29 18:06:17.688495 | TASK [emit-job-header : Print job information] 2026-01-29 18:06:17.733900 | # Job Information 2026-01-29 18:06:17.734092 | Ansible Version: 2.16.14 2026-01-29 18:06:17.734128 | Job: python-black 2026-01-29 18:06:17.734160 | Pipeline: check 2026-01-29 18:06:17.734184 | Executor: 521e9411259a 2026-01-29 18:06:17.734205 | Triggered by: https://github.com/osism/testbed/pull/2840 2026-01-29 18:06:17.734227 | Event ID: 2c9378e0-fd3d-11f0-9b0e-0dcee1b667d0 2026-01-29 18:06:17.739882 | 2026-01-29 18:06:17.740018 | LOOP [emit-job-header : Print node information] 2026-01-29 18:06:17.855432 | debian-bookworm | ok: 2026-01-29 18:06:17.855629 | debian-bookworm | # Node Information 2026-01-29 18:06:17.855663 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 18:06:17.855687 | debian-bookworm | Hostname: debian 2026-01-29 18:06:17.855725 | debian-bookworm | Username: zuul 2026-01-29 18:06:17.855747 | debian-bookworm | Distro: Debian 12.13 2026-01-29 18:06:17.855771 | debian-bookworm | Provider: regiocloud-a 2026-01-29 18:06:17.855792 | debian-bookworm | Region: 2026-01-29 18:06:17.855812 | debian-bookworm | Label: debian-bookworm 2026-01-29 18:06:17.855832 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 18:06:17.855850 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe0e:c967 2026-01-29 18:06:17.867950 | 2026-01-29 18:06:17.868098 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 18:06:18.471347 | debian-bookworm -> localhost | changed 2026-01-29 18:06:18.478798 | 2026-01-29 18:06:18.478960 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 18:06:19.553046 | debian-bookworm -> localhost | changed 2026-01-29 18:06:19.572869 | 2026-01-29 18:06:19.573014 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 18:06:19.945980 | debian-bookworm -> localhost | ok 2026-01-29 18:06:19.952393 | 2026-01-29 18:06:19.952522 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 18:06:19.980765 | debian-bookworm | ok 2026-01-29 18:06:19.998043 | debian-bookworm | included: /var/lib/zuul/builds/1f3b07cd07a049d58d855592d4f49ceb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 18:06:20.004323 | 2026-01-29 18:06:20.004431 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 18:06:21.691332 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 18:06:21.691562 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1f3b07cd07a049d58d855592d4f49ceb/work/1f3b07cd07a049d58d855592d4f49ceb_id_rsa 2026-01-29 18:06:21.691600 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1f3b07cd07a049d58d855592d4f49ceb/work/1f3b07cd07a049d58d855592d4f49ceb_id_rsa.pub 2026-01-29 18:06:21.691628 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 18:06:21.691652 | debian-bookworm -> localhost | SHA256:dDB/TnHHYLCCLhyTPHbrFdcipgfWkTp2MOOth0OPiKQ zuul-build-sshkey 2026-01-29 18:06:21.691674 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 18:06:21.691727 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 18:06:21.691751 | debian-bookworm -> localhost | | o ..o.+o.| 2026-01-29 18:06:21.691773 | debian-bookworm -> localhost | | . .+*.. * ..| 2026-01-29 18:06:21.691793 | debian-bookworm -> localhost | | B.**O * . | 2026-01-29 18:06:21.691812 | debian-bookworm -> localhost | | .o O**oO . | 2026-01-29 18:06:21.691832 | debian-bookworm -> localhost | | o .o+SBo . | 2026-01-29 18:06:21.691859 | debian-bookworm -> localhost | | E . .o=oo | 2026-01-29 18:06:21.691880 | debian-bookworm -> localhost | | .o | 2026-01-29 18:06:21.691900 | debian-bookworm -> localhost | | | 2026-01-29 18:06:21.691921 | debian-bookworm -> localhost | | | 2026-01-29 18:06:21.691941 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 18:06:21.691999 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.216192 2026-01-29 18:06:21.698535 | 2026-01-29 18:06:21.698641 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 18:06:21.727239 | debian-bookworm | ok 2026-01-29 18:06:21.736665 | debian-bookworm | included: /var/lib/zuul/builds/1f3b07cd07a049d58d855592d4f49ceb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 18:06:21.745494 | 2026-01-29 18:06:21.745592 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 18:06:21.768968 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:06:21.774911 | 2026-01-29 18:06:21.775013 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 18:06:22.431902 | debian-bookworm | changed 2026-01-29 18:06:22.438998 | 2026-01-29 18:06:22.439119 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 18:06:22.691380 | debian-bookworm | ok 2026-01-29 18:06:22.702509 | 2026-01-29 18:06:22.702671 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 18:06:23.356514 | debian-bookworm | changed 2026-01-29 18:06:23.366274 | 2026-01-29 18:06:23.366405 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 18:06:24.045945 | debian-bookworm | changed 2026-01-29 18:06:24.051626 | 2026-01-29 18:06:24.051750 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 18:06:24.085628 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:06:24.098071 | 2026-01-29 18:06:24.098234 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 18:06:24.654014 | debian-bookworm -> localhost | changed 2026-01-29 18:06:24.675557 | 2026-01-29 18:06:24.675727 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 18:06:25.047910 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1f3b07cd07a049d58d855592d4f49ceb/work/1f3b07cd07a049d58d855592d4f49ceb_id_rsa (zuul-build-sshkey) 2026-01-29 18:06:25.048160 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015544 2026-01-29 18:06:25.057547 | 2026-01-29 18:06:25.057679 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 18:06:25.471185 | debian-bookworm | ok 2026-01-29 18:06:25.476684 | 2026-01-29 18:06:25.476826 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 18:06:25.500756 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:06:25.511177 | 2026-01-29 18:06:25.511288 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 18:06:25.965806 | debian-bookworm | ok 2026-01-29 18:06:25.985082 | 2026-01-29 18:06:25.985229 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 18:06:26.035653 | debian-bookworm | ok 2026-01-29 18:06:26.040982 | 2026-01-29 18:06:26.041095 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 18:06:26.367935 | debian-bookworm -> localhost | ok 2026-01-29 18:06:26.374635 | 2026-01-29 18:06:26.374778 | TASK [validate-host : Collect information about the host] 2026-01-29 18:06:27.510568 | debian-bookworm | ok 2026-01-29 18:06:27.523730 | 2026-01-29 18:06:27.523858 | TASK [validate-host : Sanitize hostname] 2026-01-29 18:06:27.635364 | debian-bookworm | ok 2026-01-29 18:06:27.677341 | 2026-01-29 18:06:27.677463 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 18:06:28.239192 | debian-bookworm -> localhost | changed 2026-01-29 18:06:28.245916 | 2026-01-29 18:06:28.246029 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 18:06:28.671677 | debian-bookworm | ok 2026-01-29 18:06:28.676861 | 2026-01-29 18:06:28.677000 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 18:06:29.234943 | debian-bookworm -> localhost | changed 2026-01-29 18:06:29.244629 | 2026-01-29 18:06:29.244799 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 18:06:29.533166 | debian-bookworm | ok 2026-01-29 18:06:29.542153 | 2026-01-29 18:06:29.542291 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 18:06:30.748868 | debian-bookworm | changed: 2026-01-29 18:06:30.749084 | debian-bookworm | cd+++++++++ src/ 2026-01-29 18:06:30.749119 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 18:06:30.749143 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 18:06:30.749164 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-29 18:06:30.749184 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011196 2026-01-29 18:06:55.868593 | 2026-01-29 18:06:55.868724 | TASK [upload-logs : Upload logs to log server] 2026-01-29 18:06:56.420563 | localhost | Output suppressed because no_log was given 2026-01-29 18:06:56.422388 | 2026-01-29 18:06:56.422485 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 18:06:56.479856 | localhost | skipping: Conditional result was False 2026-01-29 18:06:56.487869 | localhost | skipping: Conditional result was False 2026-01-29 18:06:56.502410 | 2026-01-29 18:06:56.502879 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 18:06:56.561937 | localhost | skipping: Conditional result was False 2026-01-29 18:06:56.562574 | 2026-01-29 18:06:56.565886 | localhost | skipping: Conditional result was False 2026-01-29 18:06:56.571733 | 2026-01-29 18:06:56.571849 | LOOP [upload-logs : Upload console log and json output]