2026-01-23 21:59:24.620533 | Job console starting 2026-01-23 21:59:24.669755 | Updating git repos 2026-01-23 21:59:24.750985 | Cloning repos into workspace 2026-01-23 21:59:24.924200 | Restoring repo states 2026-01-23 21:59:24.980517 | Merging changes 2026-01-23 21:59:25.848699 | Checking out repos 2026-01-23 21:59:25.962725 | Preparing playbooks 2026-01-23 21:59:27.112342 | Running Ansible setup 2026-01-23 21:59:32.511971 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-23 21:59:33.407367 | 2026-01-23 21:59:33.407517 | PLAY [Base pre] 2026-01-23 21:59:33.443508 | 2026-01-23 21:59:33.443648 | TASK [Setup log path fact] 2026-01-23 21:59:33.480735 | debian-bookworm | ok 2026-01-23 21:59:33.496403 | 2026-01-23 21:59:33.496546 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-23 21:59:33.535769 | debian-bookworm | ok 2026-01-23 21:59:33.554700 | 2026-01-23 21:59:33.554843 | TASK [emit-job-header : Print job information] 2026-01-23 21:59:33.603878 | # Job Information 2026-01-23 21:59:33.604052 | Ansible Version: 2.16.14 2026-01-23 21:59:33.604086 | Job: python-black 2026-01-23 21:59:33.604119 | Pipeline: check 2026-01-23 21:59:33.604143 | Executor: 521e9411259a 2026-01-23 21:59:33.604173 | Triggered by: https://github.com/osism/python-osism/pull/1956 2026-01-23 21:59:33.604196 | Event ID: c09e3a20-f8a6-11f0-92ea-acdb852598b3 2026-01-23 21:59:33.609509 | 2026-01-23 21:59:33.609607 | LOOP [emit-job-header : Print node information] 2026-01-23 21:59:33.758730 | debian-bookworm | ok: 2026-01-23 21:59:33.758953 | debian-bookworm | # Node Information 2026-01-23 21:59:33.758989 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-23 21:59:33.759015 | debian-bookworm | Hostname: debian 2026-01-23 21:59:33.759037 | debian-bookworm | Username: zuul 2026-01-23 21:59:33.759057 | debian-bookworm | Distro: Debian 12.13 2026-01-23 21:59:33.759081 | debian-bookworm | Provider: regiocloud-a 2026-01-23 21:59:33.759102 | debian-bookworm | Region: 2026-01-23 21:59:33.759123 | debian-bookworm | Label: debian-bookworm 2026-01-23 21:59:33.759142 | debian-bookworm | Product Name: OpenStack Nova 2026-01-23 21:59:33.759161 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec8:da7c 2026-01-23 21:59:33.770110 | 2026-01-23 21:59:33.770262 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-23 21:59:34.631605 | debian-bookworm -> localhost | changed 2026-01-23 21:59:34.644986 | 2026-01-23 21:59:34.645159 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-23 21:59:35.974430 | debian-bookworm -> localhost | changed 2026-01-23 21:59:35.984885 | 2026-01-23 21:59:35.984991 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-23 21:59:36.602661 | debian-bookworm -> localhost | ok 2026-01-23 21:59:36.609061 | 2026-01-23 21:59:36.609191 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-23 21:59:36.630684 | debian-bookworm | ok 2026-01-23 21:59:36.663362 | debian-bookworm | included: /var/lib/zuul/builds/ccb24a5b5c48463285fc30d3563fbcbe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-23 21:59:36.669432 | 2026-01-23 21:59:36.669529 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-23 21:59:38.040356 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-23 21:59:38.040539 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ccb24a5b5c48463285fc30d3563fbcbe/work/ccb24a5b5c48463285fc30d3563fbcbe_id_rsa 2026-01-23 21:59:38.040571 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ccb24a5b5c48463285fc30d3563fbcbe/work/ccb24a5b5c48463285fc30d3563fbcbe_id_rsa.pub 2026-01-23 21:59:38.040593 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-23 21:59:38.040615 | debian-bookworm -> localhost | SHA256:651yI3ao80YfLbIcz7kfw5Yi2EoT3gMyN8GIaHhMlQQ zuul-build-sshkey 2026-01-23 21:59:38.040633 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-23 21:59:38.040659 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-23 21:59:38.040677 | debian-bookworm -> localhost | | E+o. | 2026-01-23 21:59:38.040695 | debian-bookworm -> localhost | |.+ ..o | 2026-01-23 21:59:38.040711 | debian-bookworm -> localhost | |o.+ . o | 2026-01-23 21:59:38.040728 | debian-bookworm -> localhost | |.. . | 2026-01-23 21:59:38.040744 | debian-bookworm -> localhost | | o = S . | 2026-01-23 21:59:38.040763 | debian-bookworm -> localhost | | = B+.o... | 2026-01-23 21:59:38.040781 | debian-bookworm -> localhost | | =o*O.+* | 2026-01-23 21:59:38.040797 | debian-bookworm -> localhost | | ..+O+O+ o | 2026-01-23 21:59:38.040814 | debian-bookworm -> localhost | | o*o=++. | 2026-01-23 21:59:38.040830 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-23 21:59:38.040873 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.608839 2026-01-23 21:59:38.046072 | 2026-01-23 21:59:38.046152 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-23 21:59:38.072841 | debian-bookworm | ok 2026-01-23 21:59:38.080869 | debian-bookworm | included: /var/lib/zuul/builds/ccb24a5b5c48463285fc30d3563fbcbe/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-23 21:59:38.099303 | 2026-01-23 21:59:38.099373 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-23 21:59:38.127814 | debian-bookworm | skipping: Conditional result was False 2026-01-23 21:59:38.133097 | 2026-01-23 21:59:38.133183 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-23 21:59:38.915741 | debian-bookworm | changed 2026-01-23 21:59:38.920104 | 2026-01-23 21:59:38.920201 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-23 21:59:39.181151 | debian-bookworm | ok 2026-01-23 21:59:39.186603 | 2026-01-23 21:59:39.186702 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-23 21:59:39.837294 | debian-bookworm | changed 2026-01-23 21:59:39.861385 | 2026-01-23 21:59:39.861500 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-23 21:59:40.542386 | debian-bookworm | changed 2026-01-23 21:59:40.550415 | 2026-01-23 21:59:40.550529 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-23 21:59:40.574460 | debian-bookworm | skipping: Conditional result was False 2026-01-23 21:59:40.582880 | 2026-01-23 21:59:40.582998 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-23 21:59:41.134021 | debian-bookworm -> localhost | changed 2026-01-23 21:59:41.148045 | 2026-01-23 21:59:41.148155 | TASK [add-build-sshkey : Add back temp key] 2026-01-23 21:59:42.005247 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ccb24a5b5c48463285fc30d3563fbcbe/work/ccb24a5b5c48463285fc30d3563fbcbe_id_rsa (zuul-build-sshkey) 2026-01-23 21:59:42.005530 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.041164 2026-01-23 21:59:42.013305 | 2026-01-23 21:59:42.013404 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-23 21:59:42.515973 | debian-bookworm | ok 2026-01-23 21:59:42.520855 | 2026-01-23 21:59:42.520940 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-23 21:59:42.544004 | debian-bookworm | skipping: Conditional result was False 2026-01-23 21:59:42.554192 | 2026-01-23 21:59:42.554285 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-23 21:59:42.988369 | debian-bookworm | ok 2026-01-23 21:59:43.007941 | 2026-01-23 21:59:43.008050 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-23 21:59:43.047438 | debian-bookworm | ok 2026-01-23 21:59:43.052462 | 2026-01-23 21:59:43.052546 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-23 21:59:43.419392 | debian-bookworm -> localhost | ok 2026-01-23 21:59:43.425928 | 2026-01-23 21:59:43.426032 | TASK [validate-host : Collect information about the host] 2026-01-23 21:59:44.565988 | debian-bookworm | ok 2026-01-23 21:59:44.582088 | 2026-01-23 21:59:44.582218 | TASK [validate-host : Sanitize hostname] 2026-01-23 21:59:44.674393 | debian-bookworm | ok 2026-01-23 21:59:44.736382 | 2026-01-23 21:59:44.736507 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-23 21:59:45.369032 | debian-bookworm -> localhost | changed 2026-01-23 21:59:45.375407 | 2026-01-23 21:59:45.375515 | TASK [validate-host : Collect information about zuul worker] 2026-01-23 21:59:45.900146 | debian-bookworm | ok 2026-01-23 21:59:45.905789 | 2026-01-23 21:59:45.905915 | TASK [validate-host : Write out all zuul information for each host] 2026-01-23 21:59:46.817690 | debian-bookworm -> localhost | changed 2026-01-23 21:59:46.853943 | 2026-01-23 21:59:46.854079 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-23 21:59:47.152759 | debian-bookworm | ok 2026-01-23 21:59:47.158260 | 2026-01-23 21:59:47.158358 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-23 21:59:48.560010 | debian-bookworm | changed: 2026-01-23 21:59:48.560269 | debian-bookworm | cd+++++++++ src/ 2026-01-23 21:59:48.560307 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-23 21:59:48.560332 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-23 21:59:48.560354 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-01-23 21:59:48.560374 | debian-bookworm | Containerfile 2026-01-23 21:59:48.560502 | debian-bookworm | Containerfile 2026-01-23 21:59:48.590448 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007079 2026-01-23 22:00:15.927346 | 2026-01-23 22:00:15.927529 | TASK [upload-logs : Upload logs to log server] 2026-01-23 22:00:16.567092 | localhost | Output suppressed because no_log was given 2026-01-23 22:00:16.571090 | 2026-01-23 22:00:16.571284 | LOOP [upload-logs : Compress console log and json output] 2026-01-23 22:00:16.627017 | localhost | skipping: Conditional result was False 2026-01-23 22:00:16.633776 | localhost | skipping: Conditional result was False 2026-01-23 22:00:16.644065 | 2026-01-23 22:00:16.644296 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-23 22:00:16.695888 | localhost | skipping: Conditional result was False 2026-01-23 22:00:16.696556 | 2026-01-23 22:00:16.700362 | localhost | skipping: Conditional result was False 2026-01-23 22:00:16.708554 | 2026-01-23 22:00:16.710399 | LOOP [upload-logs : Upload console log and json output]