2026-01-28 11:26:28.229230 | Job console starting 2026-01-28 11:26:28.307872 | Updating git repos 2026-01-28 11:26:28.397576 | Cloning repos into workspace 2026-01-28 11:26:28.462687 | Restoring repo states 2026-01-28 11:26:28.492212 | Merging changes 2026-01-28 11:26:29.216485 | Checking out repos 2026-01-28 11:26:29.294423 | Preparing playbooks 2026-01-28 11:26:30.274459 | Running Ansible setup 2026-01-28 11:26:36.844332 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-28 11:26:38.100790 | 2026-01-28 11:26:38.100914 | PLAY [Base pre] 2026-01-28 11:26:38.126108 | 2026-01-28 11:26:38.126228 | TASK [Setup log path fact] 2026-01-28 11:26:38.164202 | debian-bookworm | ok 2026-01-28 11:26:38.188713 | 2026-01-28 11:26:38.188849 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-28 11:26:38.264515 | debian-bookworm | ok 2026-01-28 11:26:38.280682 | 2026-01-28 11:26:38.280792 | TASK [emit-job-header : Print job information] 2026-01-28 11:26:38.333643 | # Job Information 2026-01-28 11:26:38.333800 | Ansible Version: 2.16.14 2026-01-28 11:26:38.333834 | Job: python-black 2026-01-28 11:26:38.333866 | Pipeline: check 2026-01-28 11:26:38.333888 | Executor: 521e9411259a 2026-01-28 11:26:38.333909 | Triggered by: https://github.com/osism/python-osism/pull/1972 2026-01-28 11:26:38.333931 | Event ID: 2a731db0-fc3c-11f0-83c9-209310621333 2026-01-28 11:26:38.339273 | 2026-01-28 11:26:38.339367 | LOOP [emit-job-header : Print node information] 2026-01-28 11:26:38.437603 | debian-bookworm | ok: 2026-01-28 11:26:38.437838 | debian-bookworm | # Node Information 2026-01-28 11:26:38.437875 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-28 11:26:38.437900 | debian-bookworm | Hostname: debian 2026-01-28 11:26:38.437922 | debian-bookworm | Username: zuul 2026-01-28 11:26:38.437942 | debian-bookworm | Distro: Debian 12.13 2026-01-28 11:26:38.437966 | debian-bookworm | Provider: regiocloud-a 2026-01-28 11:26:38.437998 | debian-bookworm | Region: 2026-01-28 11:26:38.438019 | debian-bookworm | Label: debian-bookworm 2026-01-28 11:26:38.438038 | debian-bookworm | Product Name: OpenStack Nova 2026-01-28 11:26:38.438058 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe40:6877 2026-01-28 11:26:38.453937 | 2026-01-28 11:26:38.454058 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-28 11:26:39.095124 | debian-bookworm -> localhost | changed 2026-01-28 11:26:39.101939 | 2026-01-28 11:26:39.102083 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-28 11:26:40.467425 | debian-bookworm -> localhost | changed 2026-01-28 11:26:40.476335 | 2026-01-28 11:26:40.476425 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-28 11:26:40.865102 | debian-bookworm -> localhost | ok 2026-01-28 11:26:40.870134 | 2026-01-28 11:26:40.870222 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-28 11:26:40.907755 | debian-bookworm | ok 2026-01-28 11:26:40.947525 | debian-bookworm | included: /var/lib/zuul/builds/27dd2f07d7234110b782803334f9caea/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-28 11:26:40.954590 | 2026-01-28 11:26:40.954671 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-28 11:26:42.833601 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-28 11:26:42.833772 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/27dd2f07d7234110b782803334f9caea/work/27dd2f07d7234110b782803334f9caea_id_rsa 2026-01-28 11:26:42.833804 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/27dd2f07d7234110b782803334f9caea/work/27dd2f07d7234110b782803334f9caea_id_rsa.pub 2026-01-28 11:26:42.833826 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-28 11:26:42.833845 | debian-bookworm -> localhost | SHA256:lUe80cWEZsO9zzeSm86N6FfHcEc4zNs5/brJaEyqPBQ zuul-build-sshkey 2026-01-28 11:26:42.833863 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-28 11:26:42.833889 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-28 11:26:42.833907 | debian-bookworm -> localhost | | ..= Bo| 2026-01-28 11:26:42.833924 | debian-bookworm -> localhost | | oo % +| 2026-01-28 11:26:42.833941 | debian-bookworm -> localhost | | o .= *+| 2026-01-28 11:26:42.833957 | debian-bookworm -> localhost | | E. .. o+=| 2026-01-28 11:26:42.833973 | debian-bookworm -> localhost | | S. .==| 2026-01-28 11:26:42.834005 | debian-bookworm -> localhost | | . .o oB| 2026-01-28 11:26:42.834023 | debian-bookworm -> localhost | | . + =.+| 2026-01-28 11:26:42.834041 | debian-bookworm -> localhost | | .. . =*+. | 2026-01-28 11:26:42.834058 | debian-bookworm -> localhost | | oo.++++o | 2026-01-28 11:26:42.834075 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-28 11:26:42.834113 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.973766 2026-01-28 11:26:42.839244 | 2026-01-28 11:26:42.839325 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-28 11:26:42.875478 | debian-bookworm | ok 2026-01-28 11:26:42.883828 | debian-bookworm | included: /var/lib/zuul/builds/27dd2f07d7234110b782803334f9caea/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-28 11:26:42.901900 | 2026-01-28 11:26:42.901993 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-28 11:26:42.924654 | debian-bookworm | skipping: Conditional result was False 2026-01-28 11:26:42.930394 | 2026-01-28 11:26:42.930490 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-28 11:26:43.612750 | debian-bookworm | changed 2026-01-28 11:26:43.617541 | 2026-01-28 11:26:43.617618 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-28 11:26:43.903245 | debian-bookworm | ok 2026-01-28 11:26:43.908531 | 2026-01-28 11:26:43.908622 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-28 11:26:44.616158 | debian-bookworm | changed 2026-01-28 11:26:44.622895 | 2026-01-28 11:26:44.622977 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-28 11:26:45.247325 | debian-bookworm | changed 2026-01-28 11:26:45.257545 | 2026-01-28 11:26:45.257802 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-28 11:26:45.278184 | debian-bookworm | skipping: Conditional result was False 2026-01-28 11:26:45.287136 | 2026-01-28 11:26:45.287250 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-28 11:26:45.734347 | debian-bookworm -> localhost | changed 2026-01-28 11:26:45.744821 | 2026-01-28 11:26:45.744919 | TASK [add-build-sshkey : Add back temp key] 2026-01-28 11:26:46.070776 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/27dd2f07d7234110b782803334f9caea/work/27dd2f07d7234110b782803334f9caea_id_rsa (zuul-build-sshkey) 2026-01-28 11:26:46.071012 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009856 2026-01-28 11:26:46.078200 | 2026-01-28 11:26:46.078286 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-28 11:26:46.520965 | debian-bookworm | ok 2026-01-28 11:26:46.526767 | 2026-01-28 11:26:46.527002 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-28 11:26:46.549810 | debian-bookworm | skipping: Conditional result was False 2026-01-28 11:26:46.560601 | 2026-01-28 11:26:46.560707 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-28 11:26:46.994247 | debian-bookworm | ok 2026-01-28 11:26:47.019447 | 2026-01-28 11:26:47.019615 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-28 11:26:47.048076 | debian-bookworm | ok 2026-01-28 11:26:47.053105 | 2026-01-28 11:26:47.053197 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-28 11:26:47.388532 | debian-bookworm -> localhost | ok 2026-01-28 11:26:47.394485 | 2026-01-28 11:26:47.394574 | TASK [validate-host : Collect information about the host] 2026-01-28 11:26:48.608181 | debian-bookworm | ok 2026-01-28 11:26:48.619180 | 2026-01-28 11:26:48.619269 | TASK [validate-host : Sanitize hostname] 2026-01-28 11:26:48.726091 | debian-bookworm | ok 2026-01-28 11:26:48.760656 | 2026-01-28 11:26:48.760758 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-28 11:26:49.344304 | debian-bookworm -> localhost | changed 2026-01-28 11:26:49.350180 | 2026-01-28 11:26:49.350269 | TASK [validate-host : Collect information about zuul worker] 2026-01-28 11:26:49.834955 | debian-bookworm | ok 2026-01-28 11:26:49.841278 | 2026-01-28 11:26:49.841383 | TASK [validate-host : Write out all zuul information for each host] 2026-01-28 11:26:50.347148 | debian-bookworm -> localhost | changed 2026-01-28 11:26:50.354456 | 2026-01-28 11:26:50.354542 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-28 11:26:50.647375 | debian-bookworm | ok 2026-01-28 11:26:50.652416 | 2026-01-28 11:26:50.652502 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-28 11:26:51.979800 | debian-bookworm | changed: 2026-01-28 11:26:51.979963 | debian-bookworm | cd+++++++++ src/ 2026-01-28 11:26:51.979996 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-28 11:26:51.980031 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-28 11:26:51.980053 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-28 11:26:51.980073 | debian-bookworm | Containerfile 2026-01-28 11:26:51.980201 | debian-bookworm | Containerfile 2026-01-28 11:26:51.985168 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009421 2026-01-28 11:27:20.240135 | 2026-01-28 11:27:20.240321 | TASK [upload-logs : Upload logs to log server] 2026-01-28 11:27:20.823392 | localhost | Output suppressed because no_log was given 2026-01-28 11:27:20.828145 | 2026-01-28 11:27:20.828366 | LOOP [upload-logs : Compress console log and json output] 2026-01-28 11:27:20.919525 | localhost | skipping: Conditional result was False 2026-01-28 11:27:20.925894 | localhost | skipping: Conditional result was False 2026-01-28 11:27:20.929375 | 2026-01-28 11:27:20.929511 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-28 11:27:20.986015 | localhost | skipping: Conditional result was False 2026-01-28 11:27:20.986356 | 2026-01-28 11:27:20.992211 | localhost | skipping: Conditional result was False 2026-01-28 11:27:21.001794 | 2026-01-28 11:27:21.001972 | LOOP [upload-logs : Upload console log and json output]