2026-03-09 18:47:35.611879 | Job console starting 2026-03-09 18:47:35.654377 | Updating git repos 2026-03-09 18:47:35.736204 | Cloning repos into workspace 2026-03-09 18:47:35.809075 | Restoring repo states 2026-03-09 18:47:35.818480 | Merging changes 2026-03-09 18:47:36.359446 | Checking out repos 2026-03-09 18:47:36.418135 | Preparing playbooks 2026-03-09 18:47:37.281717 | Running Ansible setup 2026-03-09 18:47:42.619531 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-09 18:47:43.545485 | 2026-03-09 18:47:43.545685 | PLAY [Base pre] 2026-03-09 18:47:43.564259 | 2026-03-09 18:47:43.564420 | TASK [Setup log path fact] 2026-03-09 18:47:43.594338 | debian-bookworm | ok 2026-03-09 18:47:43.610259 | 2026-03-09 18:47:43.610417 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-09 18:47:43.641571 | debian-bookworm | ok 2026-03-09 18:47:43.654678 | 2026-03-09 18:47:43.654810 | TASK [emit-job-header : Print job information] 2026-03-09 18:47:43.717029 | # Job Information 2026-03-09 18:47:43.717229 | Ansible Version: 2.16.14 2026-03-09 18:47:43.717263 | Job: python-black 2026-03-09 18:47:43.717295 | Pipeline: check 2026-03-09 18:47:43.717319 | Executor: 521e9411259a 2026-03-09 18:47:43.717339 | Triggered by: https://github.com/osism/python-osism/pull/2101 2026-03-09 18:47:43.717361 | Event ID: 6b009940-1be8-11f1-854f-5892246f4e1f 2026-03-09 18:47:43.724850 | 2026-03-09 18:47:43.725012 | LOOP [emit-job-header : Print node information] 2026-03-09 18:47:43.945769 | debian-bookworm | ok: 2026-03-09 18:47:43.946066 | debian-bookworm | # Node Information 2026-03-09 18:47:43.946106 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-09 18:47:43.946131 | debian-bookworm | Hostname: debian 2026-03-09 18:47:43.946153 | debian-bookworm | Username: zuul 2026-03-09 18:47:43.946174 | debian-bookworm | Distro: Debian 12.13 2026-03-09 18:47:43.946197 | debian-bookworm | Provider: regiocloud-a 2026-03-09 18:47:43.946219 | debian-bookworm | Region: 2026-03-09 18:47:43.946240 | debian-bookworm | Label: debian-bookworm 2026-03-09 18:47:43.946260 | debian-bookworm | Product Name: OpenStack Nova 2026-03-09 18:47:43.946280 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feda:7c48 2026-03-09 18:47:43.958996 | 2026-03-09 18:47:43.959129 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-09 18:47:44.809339 | debian-bookworm -> localhost | changed 2026-03-09 18:47:44.816249 | 2026-03-09 18:47:44.816353 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-09 18:47:46.764786 | debian-bookworm -> localhost | changed 2026-03-09 18:47:46.775306 | 2026-03-09 18:47:46.775416 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-09 18:47:47.289996 | debian-bookworm -> localhost | ok 2026-03-09 18:47:47.295783 | 2026-03-09 18:47:47.295881 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-09 18:47:47.333852 | debian-bookworm | ok 2026-03-09 18:47:47.362585 | debian-bookworm | included: /var/lib/zuul/builds/494aeb3514e94b26bbd6d9431e22ea00/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-09 18:47:47.368401 | 2026-03-09 18:47:47.368497 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-09 18:47:50.566657 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-09 18:47:50.566885 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/494aeb3514e94b26bbd6d9431e22ea00/work/494aeb3514e94b26bbd6d9431e22ea00_id_rsa 2026-03-09 18:47:50.566925 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/494aeb3514e94b26bbd6d9431e22ea00/work/494aeb3514e94b26bbd6d9431e22ea00_id_rsa.pub 2026-03-09 18:47:50.566979 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-09 18:47:50.567006 | debian-bookworm -> localhost | SHA256:EmRW2EG/dv/j5JD+ziQi7g1302m1OUg/kTZYUy2w1Ps zuul-build-sshkey 2026-03-09 18:47:50.567029 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-09 18:47:50.567059 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-09 18:47:50.567082 | debian-bookworm -> localhost | | +=+. oo o| 2026-03-09 18:47:50.567103 | debian-bookworm -> localhost | | +. .. . .o o| 2026-03-09 18:47:50.567124 | debian-bookworm -> localhost | | . . . = | 2026-03-09 18:47:50.567143 | debian-bookworm -> localhost | | . . + o| 2026-03-09 18:47:50.567164 | debian-bookworm -> localhost | | . S o .o *.| 2026-03-09 18:47:50.567186 | debian-bookworm -> localhost | | . . ...* E| 2026-03-09 18:47:50.567207 | debian-bookworm -> localhost | | o o B.% | 2026-03-09 18:47:50.567226 | debian-bookworm -> localhost | | . = + Xoo| 2026-03-09 18:47:50.567247 | debian-bookworm -> localhost | | .o . .+*o| 2026-03-09 18:47:50.567267 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-09 18:47:50.567315 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.316227 2026-03-09 18:47:50.575568 | 2026-03-09 18:47:50.575666 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-09 18:47:50.597262 | debian-bookworm | ok 2026-03-09 18:47:50.606072 | debian-bookworm | included: /var/lib/zuul/builds/494aeb3514e94b26bbd6d9431e22ea00/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-09 18:47:50.614537 | 2026-03-09 18:47:50.614622 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-09 18:47:50.648014 | debian-bookworm | skipping: Conditional result was False 2026-03-09 18:47:50.653817 | 2026-03-09 18:47:50.653905 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-09 18:47:51.296854 | debian-bookworm | changed 2026-03-09 18:47:51.303365 | 2026-03-09 18:47:51.303461 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-09 18:47:51.543280 | debian-bookworm | ok 2026-03-09 18:47:51.549505 | 2026-03-09 18:47:51.549598 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-09 18:47:52.136595 | debian-bookworm | changed 2026-03-09 18:47:52.146671 | 2026-03-09 18:47:52.146963 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-09 18:47:52.799194 | debian-bookworm | changed 2026-03-09 18:47:52.808779 | 2026-03-09 18:47:52.808880 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-09 18:47:52.862095 | debian-bookworm | skipping: Conditional result was False 2026-03-09 18:47:52.869687 | 2026-03-09 18:47:52.869786 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-09 18:47:53.601229 | debian-bookworm -> localhost | changed 2026-03-09 18:47:53.612224 | 2026-03-09 18:47:53.612323 | TASK [add-build-sshkey : Add back temp key] 2026-03-09 18:47:54.094250 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/494aeb3514e94b26bbd6d9431e22ea00/work/494aeb3514e94b26bbd6d9431e22ea00_id_rsa (zuul-build-sshkey) 2026-03-09 18:47:54.094505 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011889 2026-03-09 18:47:54.102993 | 2026-03-09 18:47:54.103083 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-09 18:47:54.614160 | debian-bookworm | ok 2026-03-09 18:47:54.619072 | 2026-03-09 18:47:54.619168 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-09 18:47:54.643747 | debian-bookworm | skipping: Conditional result was False 2026-03-09 18:47:54.659747 | 2026-03-09 18:47:54.659853 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-09 18:47:55.101770 | debian-bookworm | ok 2026-03-09 18:47:55.117425 | 2026-03-09 18:47:55.117545 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-09 18:47:55.156963 | debian-bookworm | ok 2026-03-09 18:47:55.161989 | 2026-03-09 18:47:55.162097 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-09 18:47:55.486313 | debian-bookworm -> localhost | ok 2026-03-09 18:47:55.493538 | 2026-03-09 18:47:55.493661 | TASK [validate-host : Collect information about the host] 2026-03-09 18:47:56.709207 | debian-bookworm | ok 2026-03-09 18:47:56.777870 | 2026-03-09 18:47:56.778039 | TASK [validate-host : Sanitize hostname] 2026-03-09 18:47:56.917182 | debian-bookworm | ok 2026-03-09 18:47:56.986623 | 2026-03-09 18:47:56.986768 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-09 18:47:57.966265 | debian-bookworm -> localhost | changed 2026-03-09 18:47:57.972422 | 2026-03-09 18:47:57.972538 | TASK [validate-host : Collect information about zuul worker] 2026-03-09 18:47:58.461307 | debian-bookworm | ok 2026-03-09 18:47:58.475205 | 2026-03-09 18:47:58.475342 | TASK [validate-host : Write out all zuul information for each host] 2026-03-09 18:47:59.643819 | debian-bookworm -> localhost | changed 2026-03-09 18:47:59.654138 | 2026-03-09 18:47:59.654239 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-09 18:47:59.911980 | debian-bookworm | ok 2026-03-09 18:47:59.921415 | 2026-03-09 18:47:59.921529 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-09 18:48:01.111269 | debian-bookworm | changed: 2026-03-09 18:48:01.111460 | debian-bookworm | cd+++++++++ src/ 2026-03-09 18:48:01.111497 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-09 18:48:01.111522 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-09 18:48:01.111544 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-03-09 18:48:01.111564 | debian-bookworm | Containerfile 2026-03-09 18:48:01.111699 | debian-bookworm | Containerfile 2026-03-09 18:48:01.138910 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007183 2026-03-09 18:48:26.859180 | 2026-03-09 18:48:26.859383 | TASK [upload-logs : Upload logs to log server] 2026-03-09 18:48:27.440524 | localhost | Output suppressed because no_log was given 2026-03-09 18:48:27.443693 | 2026-03-09 18:48:27.443864 | LOOP [upload-logs : Compress console log and json output] 2026-03-09 18:48:27.497563 | localhost | skipping: Conditional result was False 2026-03-09 18:48:27.509923 | localhost | skipping: Conditional result was False 2026-03-09 18:48:27.514259 | 2026-03-09 18:48:27.514427 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-09 18:48:27.581494 | localhost | skipping: Conditional result was False 2026-03-09 18:48:27.582119 | 2026-03-09 18:48:27.586776 | localhost | skipping: Conditional result was False 2026-03-09 18:48:27.597575 | 2026-03-09 18:48:27.597755 | LOOP [upload-logs : Upload console log and json output]