2026-01-29 18:28:14.271464 | Job console starting 2026-01-29 18:28:14.291678 | Updating git repos 2026-01-29 18:28:14.330770 | Cloning repos into workspace 2026-01-29 18:28:14.394547 | Restoring repo states 2026-01-29 18:28:14.400217 | Merging changes 2026-01-29 18:28:14.960059 | Checking out repos 2026-01-29 18:28:15.070797 | Preparing playbooks 2026-01-29 18:28:15.747890 | Running Ansible setup 2026-01-29 18:28:20.124618 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 18:28:20.850500 | 2026-01-29 18:28:20.850666 | PLAY [Base pre] 2026-01-29 18:28:20.875289 | 2026-01-29 18:28:20.875477 | TASK [Setup log path fact] 2026-01-29 18:28:20.915641 | debian-bookworm | ok 2026-01-29 18:28:20.931710 | 2026-01-29 18:28:20.931879 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 18:28:20.962228 | debian-bookworm | ok 2026-01-29 18:28:20.972487 | 2026-01-29 18:28:20.972615 | TASK [emit-job-header : Print job information] 2026-01-29 18:28:21.012147 | # Job Information 2026-01-29 18:28:21.012380 | Ansible Version: 2.16.14 2026-01-29 18:28:21.012420 | Job: python-black 2026-01-29 18:28:21.012454 | Pipeline: check 2026-01-29 18:28:21.012478 | Executor: 521e9411259a 2026-01-29 18:28:21.012499 | Triggered by: https://github.com/osism/testbed/pull/2841 2026-01-29 18:28:21.012522 | Event ID: 410eab20-fd40-11f0-8885-a186c52ed147 2026-01-29 18:28:21.025054 | 2026-01-29 18:28:21.025193 | LOOP [emit-job-header : Print node information] 2026-01-29 18:28:21.220413 | debian-bookworm | ok: 2026-01-29 18:28:21.220724 | debian-bookworm | # Node Information 2026-01-29 18:28:21.220769 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 18:28:21.220800 | debian-bookworm | Hostname: debian 2026-01-29 18:28:21.220826 | debian-bookworm | Username: zuul 2026-01-29 18:28:21.220851 | debian-bookworm | Distro: Debian 12.13 2026-01-29 18:28:21.220880 | debian-bookworm | Provider: regiocloud-a 2026-01-29 18:28:21.220905 | debian-bookworm | Region: 2026-01-29 18:28:21.220930 | debian-bookworm | Label: debian-bookworm 2026-01-29 18:28:21.220954 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 18:28:21.220978 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec0:9547 2026-01-29 18:28:21.242674 | 2026-01-29 18:28:21.242826 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 18:28:21.711982 | debian-bookworm -> localhost | changed 2026-01-29 18:28:21.719375 | 2026-01-29 18:28:21.719498 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 18:28:22.887555 | debian-bookworm -> localhost | changed 2026-01-29 18:28:22.898654 | 2026-01-29 18:28:22.898787 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 18:28:23.165604 | debian-bookworm -> localhost | ok 2026-01-29 18:28:23.172769 | 2026-01-29 18:28:23.172903 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 18:28:23.202722 | debian-bookworm | ok 2026-01-29 18:28:23.222922 | debian-bookworm | included: /var/lib/zuul/builds/44ebd167fd5743e1982138d797262a10/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 18:28:23.229093 | 2026-01-29 18:28:23.229203 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 18:28:24.555433 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 18:28:24.555659 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/44ebd167fd5743e1982138d797262a10/work/44ebd167fd5743e1982138d797262a10_id_rsa 2026-01-29 18:28:24.555698 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/44ebd167fd5743e1982138d797262a10/work/44ebd167fd5743e1982138d797262a10_id_rsa.pub 2026-01-29 18:28:24.555725 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 18:28:24.555751 | debian-bookworm -> localhost | SHA256:/mNN5FkcQNBaiSkChGk1rWqCc6TJ6/RXpXZN1hvyA5Y zuul-build-sshkey 2026-01-29 18:28:24.555774 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 18:28:24.555812 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 18:28:24.555834 | debian-bookworm -> localhost | | ==o .*oo | 2026-01-29 18:28:24.555857 | debian-bookworm -> localhost | | + .o . o + . | 2026-01-29 18:28:24.555877 | debian-bookworm -> localhost | | . . . . oo. . | 2026-01-29 18:28:24.555897 | debian-bookworm -> localhost | | . . ..E.oo | 2026-01-29 18:28:24.555934 | debian-bookworm -> localhost | |o+ . S =o+oo | 2026-01-29 18:28:24.555964 | debian-bookworm -> localhost | |*.+ = . .++ | 2026-01-29 18:28:24.555985 | debian-bookworm -> localhost | | *. o o o . | 2026-01-29 18:28:24.556005 | debian-bookworm -> localhost | |... . .o . | 2026-01-29 18:28:24.556026 | debian-bookworm -> localhost | |.. .. ... | 2026-01-29 18:28:24.556045 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 18:28:24.556105 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.805794 2026-01-29 18:28:24.562817 | 2026-01-29 18:28:24.562960 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 18:28:24.591691 | debian-bookworm | ok 2026-01-29 18:28:24.601202 | debian-bookworm | included: /var/lib/zuul/builds/44ebd167fd5743e1982138d797262a10/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 18:28:24.610487 | 2026-01-29 18:28:24.610590 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 18:28:24.634174 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:28:24.641223 | 2026-01-29 18:28:24.641355 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 18:28:25.271023 | debian-bookworm | changed 2026-01-29 18:28:25.278860 | 2026-01-29 18:28:25.278990 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 18:28:25.583541 | debian-bookworm | ok 2026-01-29 18:28:25.590431 | 2026-01-29 18:28:25.590556 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 18:28:26.273995 | debian-bookworm | changed 2026-01-29 18:28:26.283405 | 2026-01-29 18:28:26.283539 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 18:28:26.987125 | debian-bookworm | changed 2026-01-29 18:28:26.996147 | 2026-01-29 18:28:26.996284 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 18:28:27.031040 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:28:27.040232 | 2026-01-29 18:28:27.040378 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 18:28:27.521550 | debian-bookworm -> localhost | changed 2026-01-29 18:28:27.533043 | 2026-01-29 18:28:27.533172 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 18:28:27.928771 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/44ebd167fd5743e1982138d797262a10/work/44ebd167fd5743e1982138d797262a10_id_rsa (zuul-build-sshkey) 2026-01-29 18:28:27.929020 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012264 2026-01-29 18:28:27.937054 | 2026-01-29 18:28:27.937167 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 18:28:28.357980 | debian-bookworm | ok 2026-01-29 18:28:28.365219 | 2026-01-29 18:28:28.365366 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 18:28:28.399534 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:28:28.417577 | 2026-01-29 18:28:28.417726 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 18:28:28.874687 | debian-bookworm | ok 2026-01-29 18:28:28.890296 | 2026-01-29 18:28:28.890461 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 18:28:28.935005 | debian-bookworm | ok 2026-01-29 18:28:28.942242 | 2026-01-29 18:28:28.942382 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 18:28:29.264777 | debian-bookworm -> localhost | ok 2026-01-29 18:28:29.297956 | 2026-01-29 18:28:29.298089 | TASK [validate-host : Collect information about the host] 2026-01-29 18:28:30.440863 | debian-bookworm | ok 2026-01-29 18:28:30.452238 | 2026-01-29 18:28:30.452396 | TASK [validate-host : Sanitize hostname] 2026-01-29 18:28:30.578697 | debian-bookworm | ok 2026-01-29 18:28:30.627027 | 2026-01-29 18:28:30.627178 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 18:28:31.193980 | debian-bookworm -> localhost | changed 2026-01-29 18:28:31.212714 | 2026-01-29 18:28:31.212862 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 18:28:31.646027 | debian-bookworm | ok 2026-01-29 18:28:31.655519 | 2026-01-29 18:28:31.655701 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 18:28:32.229694 | debian-bookworm -> localhost | changed 2026-01-29 18:28:32.240564 | 2026-01-29 18:28:32.240693 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 18:28:32.548921 | debian-bookworm | ok 2026-01-29 18:28:32.557587 | 2026-01-29 18:28:32.557726 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 18:28:33.799337 | debian-bookworm | changed: 2026-01-29 18:28:33.799562 | debian-bookworm | cd+++++++++ src/ 2026-01-29 18:28:33.799598 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 18:28:33.799622 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 18:28:33.799643 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-29 18:28:33.799663 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003794 2026-01-29 18:28:58.758111 | 2026-01-29 18:28:58.758226 | TASK [upload-logs : Upload logs to log server] 2026-01-29 18:28:59.312731 | localhost | Output suppressed because no_log was given 2026-01-29 18:28:59.314599 | 2026-01-29 18:28:59.314711 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 18:28:59.375685 | localhost | skipping: Conditional result was False 2026-01-29 18:28:59.381720 | localhost | skipping: Conditional result was False 2026-01-29 18:28:59.391502 | 2026-01-29 18:28:59.391629 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 18:28:59.441707 | localhost | skipping: Conditional result was False 2026-01-29 18:28:59.442009 | 2026-01-29 18:28:59.446867 | localhost | skipping: Conditional result was False 2026-01-29 18:28:59.457916 | 2026-01-29 18:28:59.458026 | LOOP [upload-logs : Upload console log and json output]