2025-12-17 09:21:19.588607 | Job console starting 2025-12-17 09:21:19.600129 | Updating git repos 2025-12-17 09:21:20.538037 | Cloning repos into workspace 2025-12-17 09:21:20.663107 | Restoring repo states 2025-12-17 09:21:20.732181 | Merging changes 2025-12-17 09:21:21.492751 | Checking out repos 2025-12-17 09:21:21.633578 | Preparing playbooks 2025-12-17 09:21:23.527557 | Running Ansible setup 2025-12-17 09:21:31.765118 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-17 09:21:33.265008 | 2025-12-17 09:21:33.265551 | PLAY [Base pre] 2025-12-17 09:21:33.313319 | 2025-12-17 09:21:33.313523 | TASK [Setup log path fact] 2025-12-17 09:21:33.347285 | debian-bookworm | ok 2025-12-17 09:21:33.369066 | 2025-12-17 09:21:33.369243 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-17 09:21:33.410558 | debian-bookworm | ok 2025-12-17 09:21:33.432789 | 2025-12-17 09:21:33.432974 | TASK [emit-job-header : Print job information] 2025-12-17 09:21:33.525895 | # Job Information 2025-12-17 09:21:33.526096 | Ansible Version: 2.16.14 2025-12-17 09:21:33.526130 | Job: python-black 2025-12-17 09:21:33.526164 | Pipeline: check 2025-12-17 09:21:33.526187 | Executor: 521e9411259a 2025-12-17 09:21:33.526208 | Triggered by: https://github.com/osism/python-osism/pull/1892 2025-12-17 09:21:33.526233 | Event ID: b99076c0-db29-11f0-9218-621e35bb077b 2025-12-17 09:21:33.535783 | 2025-12-17 09:21:33.535974 | LOOP [emit-job-header : Print node information] 2025-12-17 09:21:33.901932 | debian-bookworm | ok: 2025-12-17 09:21:33.902167 | debian-bookworm | # Node Information 2025-12-17 09:21:33.902205 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-17 09:21:33.902231 | debian-bookworm | Hostname: debian 2025-12-17 09:21:33.902255 | debian-bookworm | Username: zuul 2025-12-17 09:21:33.902388 | debian-bookworm | Distro: Debian 12.12 2025-12-17 09:21:33.902420 | debian-bookworm | Provider: regiocloud-a 2025-12-17 09:21:33.902443 | debian-bookworm | Region: 2025-12-17 09:21:33.902466 | debian-bookworm | Label: debian-bookworm 2025-12-17 09:21:33.902486 | debian-bookworm | Product Name: OpenStack Nova 2025-12-17 09:21:33.902528 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb0:93d1 2025-12-17 09:21:34.031767 | 2025-12-17 09:21:34.031978 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-17 09:21:36.481680 | debian-bookworm -> localhost | changed 2025-12-17 09:21:36.489879 | 2025-12-17 09:21:36.490185 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-17 09:21:40.651364 | debian-bookworm -> localhost | changed 2025-12-17 09:21:40.667918 | 2025-12-17 09:21:40.668057 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-17 09:21:41.481203 | debian-bookworm -> localhost | ok 2025-12-17 09:21:41.489190 | 2025-12-17 09:21:41.489334 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-17 09:21:41.554773 | debian-bookworm | ok 2025-12-17 09:21:41.604172 | debian-bookworm | included: /var/lib/zuul/builds/c688a558be524fb9ab8f9e455323b88a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-17 09:21:41.618913 | 2025-12-17 09:21:41.619053 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-17 09:21:45.542201 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-17 09:21:45.542517 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c688a558be524fb9ab8f9e455323b88a/work/c688a558be524fb9ab8f9e455323b88a_id_rsa 2025-12-17 09:21:45.542561 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c688a558be524fb9ab8f9e455323b88a/work/c688a558be524fb9ab8f9e455323b88a_id_rsa.pub 2025-12-17 09:21:45.542587 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-17 09:21:45.542614 | debian-bookworm -> localhost | SHA256:FMqf28fhr17EiMG9yTWrd0+IR937aPybuM4tfxQLD54 zuul-build-sshkey 2025-12-17 09:21:45.542637 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-17 09:21:45.542670 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-17 09:21:45.542692 | debian-bookworm -> localhost | | . | 2025-12-17 09:21:45.542713 | debian-bookworm -> localhost | | . . o . | 2025-12-17 09:21:45.542733 | debian-bookworm -> localhost | | o . o . o | 2025-12-17 09:21:45.542753 | debian-bookworm -> localhost | | o . + O =.| 2025-12-17 09:21:45.542773 | debian-bookworm -> localhost | | S . B X =| 2025-12-17 09:21:45.542794 | debian-bookworm -> localhost | | o o E +o| 2025-12-17 09:21:45.542813 | debian-bookworm -> localhost | | . . *.=oo| 2025-12-17 09:21:45.542864 | debian-bookworm -> localhost | | ..*=+=| 2025-12-17 09:21:45.543019 | debian-bookworm -> localhost | | .+B***| 2025-12-17 09:21:45.543044 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-17 09:21:45.543104 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.119397 2025-12-17 09:21:45.549967 | 2025-12-17 09:21:45.550093 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-17 09:21:45.613628 | debian-bookworm | ok 2025-12-17 09:21:45.648373 | debian-bookworm | included: /var/lib/zuul/builds/c688a558be524fb9ab8f9e455323b88a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-17 09:21:45.686556 | 2025-12-17 09:21:45.686701 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-17 09:21:45.754725 | debian-bookworm | skipping: Conditional result was False 2025-12-17 09:21:45.761924 | 2025-12-17 09:21:45.762104 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-17 09:21:46.729198 | debian-bookworm | changed 2025-12-17 09:21:46.738008 | 2025-12-17 09:21:46.738143 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-17 09:21:47.132757 | debian-bookworm | ok 2025-12-17 09:21:47.140239 | 2025-12-17 09:21:47.140377 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-17 09:21:48.209595 | debian-bookworm | changed 2025-12-17 09:21:48.226153 | 2025-12-17 09:21:48.226305 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-17 09:21:49.174102 | debian-bookworm | changed 2025-12-17 09:21:49.189810 | 2025-12-17 09:21:49.189989 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-17 09:21:49.248430 | debian-bookworm | skipping: Conditional result was False 2025-12-17 09:21:49.256663 | 2025-12-17 09:21:49.256811 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-17 09:21:50.787594 | debian-bookworm -> localhost | changed 2025-12-17 09:21:50.819356 | 2025-12-17 09:21:50.819512 | TASK [add-build-sshkey : Add back temp key] 2025-12-17 09:21:51.790257 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c688a558be524fb9ab8f9e455323b88a/work/c688a558be524fb9ab8f9e455323b88a_id_rsa (zuul-build-sshkey) 2025-12-17 09:21:51.790525 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.060380 2025-12-17 09:21:51.801077 | 2025-12-17 09:21:51.801238 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-17 09:21:52.328633 | debian-bookworm | ok 2025-12-17 09:21:52.343257 | 2025-12-17 09:21:52.344078 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-17 09:21:52.395452 | debian-bookworm | skipping: Conditional result was False 2025-12-17 09:21:52.417305 | 2025-12-17 09:21:52.417909 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-17 09:21:53.411399 | debian-bookworm | ok 2025-12-17 09:21:53.513207 | 2025-12-17 09:21:53.515128 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-17 09:21:53.617558 | debian-bookworm | ok 2025-12-17 09:21:53.686759 | 2025-12-17 09:21:53.688477 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-17 09:21:55.151508 | debian-bookworm -> localhost | ok 2025-12-17 09:21:55.166501 | 2025-12-17 09:21:55.166634 | TASK [validate-host : Collect information about the host] 2025-12-17 09:21:57.556123 | debian-bookworm | ok 2025-12-17 09:21:57.621360 | 2025-12-17 09:21:57.621515 | TASK [validate-host : Sanitize hostname] 2025-12-17 09:21:58.431701 | debian-bookworm | ok 2025-12-17 09:21:58.716185 | 2025-12-17 09:21:58.716336 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-17 09:22:01.004118 | debian-bookworm -> localhost | changed 2025-12-17 09:22:01.010749 | 2025-12-17 09:22:01.011012 | TASK [validate-host : Collect information about zuul worker] 2025-12-17 09:22:01.937634 | debian-bookworm | ok 2025-12-17 09:22:01.942889 | 2025-12-17 09:22:01.943023 | TASK [validate-host : Write out all zuul information for each host] 2025-12-17 09:22:03.844398 | debian-bookworm -> localhost | changed 2025-12-17 09:22:03.870816 | 2025-12-17 09:22:03.871045 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-17 09:22:04.209094 | debian-bookworm | ok 2025-12-17 09:22:04.220327 | 2025-12-17 09:22:04.221243 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-17 09:22:06.024961 | debian-bookworm | changed: 2025-12-17 09:22:06.025229 | debian-bookworm | cd+++++++++ src/ 2025-12-17 09:22:06.025266 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-17 09:22:06.025291 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-17 09:22:06.025314 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-17 09:22:06.025335 | debian-bookworm | Containerfile 2025-12-17 09:22:06.025464 | debian-bookworm | Containerfile 2025-12-17 09:22:06.036702 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004144 2025-12-17 09:22:43.903541 | 2025-12-17 09:22:43.903641 | TASK [upload-logs : Upload logs to log server] 2025-12-17 09:22:44.479513 | localhost | Output suppressed because no_log was given 2025-12-17 09:22:44.481197 | 2025-12-17 09:22:44.481291 | LOOP [upload-logs : Compress console log and json output] 2025-12-17 09:22:44.552629 | localhost | skipping: Conditional result was False 2025-12-17 09:22:44.557426 | localhost | skipping: Conditional result was False 2025-12-17 09:22:44.567278 | 2025-12-17 09:22:44.567381 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-17 09:22:44.624304 | localhost | skipping: Conditional result was False 2025-12-17 09:22:44.624548 | 2025-12-17 09:22:44.628298 | localhost | skipping: Conditional result was False 2025-12-17 09:22:44.633128 | 2025-12-17 09:22:44.633219 | LOOP [upload-logs : Upload console log and json output]