2026-02-04 14:51:31.833514 | Job console starting 2026-02-04 14:51:31.847713 | Updating git repos 2026-02-04 14:51:31.891808 | Cloning repos into workspace 2026-02-04 14:51:31.978136 | Restoring repo states 2026-02-04 14:51:31.996879 | Merging changes 2026-02-04 14:51:32.527276 | Checking out repos 2026-02-04 14:51:32.630224 | Preparing playbooks 2026-02-04 14:51:33.203516 | Running Ansible setup 2026-02-04 14:51:37.904990 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-04 14:51:38.905171 | 2026-02-04 14:51:38.905360 | PLAY [Base pre] 2026-02-04 14:51:38.922220 | 2026-02-04 14:51:38.922403 | TASK [Setup log path fact] 2026-02-04 14:51:38.941993 | debian-bookworm | ok 2026-02-04 14:51:38.961723 | 2026-02-04 14:51:38.961886 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-04 14:51:38.993989 | debian-bookworm | ok 2026-02-04 14:51:39.004939 | 2026-02-04 14:51:39.005069 | TASK [emit-job-header : Print job information] 2026-02-04 14:51:39.044995 | # Job Information 2026-02-04 14:51:39.045198 | Ansible Version: 2.16.14 2026-02-04 14:51:39.045234 | Job: python-black 2026-02-04 14:51:39.045269 | Pipeline: check 2026-02-04 14:51:39.045330 | Executor: 521e9411259a 2026-02-04 14:51:39.045354 | Triggered by: https://github.com/osism/python-osism/pull/1917 2026-02-04 14:51:39.045377 | Event ID: d521c580-01d8-11f1-81cd-feb0871e710e 2026-02-04 14:51:39.050574 | 2026-02-04 14:51:39.050692 | LOOP [emit-job-header : Print node information] 2026-02-04 14:51:39.178521 | debian-bookworm | ok: 2026-02-04 14:51:39.178801 | debian-bookworm | # Node Information 2026-02-04 14:51:39.178871 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-04 14:51:39.178899 | debian-bookworm | Hostname: debian 2026-02-04 14:51:39.178922 | debian-bookworm | Username: zuul 2026-02-04 14:51:39.178943 | debian-bookworm | Distro: Debian 12.13 2026-02-04 14:51:39.178968 | debian-bookworm | Provider: regiocloud-a 2026-02-04 14:51:39.178990 | debian-bookworm | Region: 2026-02-04 14:51:39.179011 | debian-bookworm | Label: debian-bookworm 2026-02-04 14:51:39.179031 | debian-bookworm | Product Name: OpenStack Nova 2026-02-04 14:51:39.179051 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe80:8526 2026-02-04 14:51:39.198481 | 2026-02-04 14:51:39.198627 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-04 14:51:39.759079 | debian-bookworm -> localhost | changed 2026-02-04 14:51:39.766463 | 2026-02-04 14:51:39.766588 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-04 14:51:40.919294 | debian-bookworm -> localhost | changed 2026-02-04 14:51:40.930473 | 2026-02-04 14:51:40.930600 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-04 14:51:41.291400 | debian-bookworm -> localhost | ok 2026-02-04 14:51:41.300180 | 2026-02-04 14:51:41.300346 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-04 14:51:41.360125 | debian-bookworm | ok 2026-02-04 14:51:41.384257 | debian-bookworm | included: /var/lib/zuul/builds/c5bb9c22a73d4b14aa0962da06fd7bc7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-04 14:51:41.395709 | 2026-02-04 14:51:41.395845 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-04 14:51:42.585304 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-04 14:51:42.585547 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c5bb9c22a73d4b14aa0962da06fd7bc7/work/c5bb9c22a73d4b14aa0962da06fd7bc7_id_rsa 2026-02-04 14:51:42.585588 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c5bb9c22a73d4b14aa0962da06fd7bc7/work/c5bb9c22a73d4b14aa0962da06fd7bc7_id_rsa.pub 2026-02-04 14:51:42.585615 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-04 14:51:42.585640 | debian-bookworm -> localhost | SHA256:IlfxrP0pcY5XnVnUl4HwUm2z/FB0kKlWoc3CNqd+BXA zuul-build-sshkey 2026-02-04 14:51:42.585664 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-04 14:51:42.585704 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-04 14:51:42.585728 | debian-bookworm -> localhost | | . .o.EBB| 2026-02-04 14:51:42.585750 | debian-bookworm -> localhost | | + .oB+*=| 2026-02-04 14:51:42.585772 | debian-bookworm -> localhost | | . o.*+B.=| 2026-02-04 14:51:42.585792 | debian-bookworm -> localhost | | . o .+=.=+| 2026-02-04 14:51:42.585813 | debian-bookworm -> localhost | | . o S o.o .++| 2026-02-04 14:51:42.585834 | debian-bookworm -> localhost | | o . B o ..| 2026-02-04 14:51:42.585855 | debian-bookworm -> localhost | | o * . | 2026-02-04 14:51:42.585876 | debian-bookworm -> localhost | | o . | 2026-02-04 14:51:42.585898 | debian-bookworm -> localhost | | | 2026-02-04 14:51:42.585919 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-04 14:51:42.585975 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.539095 2026-02-04 14:51:42.592796 | 2026-02-04 14:51:42.592916 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-04 14:51:42.631448 | debian-bookworm | ok 2026-02-04 14:51:42.648123 | debian-bookworm | included: /var/lib/zuul/builds/c5bb9c22a73d4b14aa0962da06fd7bc7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-04 14:51:42.657989 | 2026-02-04 14:51:42.658134 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-04 14:51:42.682302 | debian-bookworm | skipping: Conditional result was False 2026-02-04 14:51:42.688575 | 2026-02-04 14:51:42.688690 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-04 14:51:43.392109 | debian-bookworm | changed 2026-02-04 14:51:43.400790 | 2026-02-04 14:51:43.400936 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-04 14:51:43.671883 | debian-bookworm | ok 2026-02-04 14:51:43.678116 | 2026-02-04 14:51:43.678240 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-04 14:51:44.343855 | debian-bookworm | changed 2026-02-04 14:51:44.370827 | 2026-02-04 14:51:44.370983 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-04 14:51:45.057094 | debian-bookworm | changed 2026-02-04 14:51:45.062959 | 2026-02-04 14:51:45.063077 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-04 14:51:45.086993 | debian-bookworm | skipping: Conditional result was False 2026-02-04 14:51:45.093485 | 2026-02-04 14:51:45.093598 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-04 14:51:45.572777 | debian-bookworm -> localhost | changed 2026-02-04 14:51:45.585581 | 2026-02-04 14:51:45.585706 | TASK [add-build-sshkey : Add back temp key] 2026-02-04 14:51:46.000684 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c5bb9c22a73d4b14aa0962da06fd7bc7/work/c5bb9c22a73d4b14aa0962da06fd7bc7_id_rsa (zuul-build-sshkey) 2026-02-04 14:51:46.000931 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027246 2026-02-04 14:51:46.009625 | 2026-02-04 14:51:46.009743 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-04 14:51:46.532041 | debian-bookworm | ok 2026-02-04 14:51:46.537484 | 2026-02-04 14:51:46.537599 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-04 14:51:46.582385 | debian-bookworm | skipping: Conditional result was False 2026-02-04 14:51:46.614177 | 2026-02-04 14:51:46.614338 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-04 14:51:47.058148 | debian-bookworm | ok 2026-02-04 14:51:47.077355 | 2026-02-04 14:51:47.077486 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-04 14:51:47.116664 | debian-bookworm | ok 2026-02-04 14:51:47.121833 | 2026-02-04 14:51:47.121936 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-04 14:51:47.520825 | debian-bookworm -> localhost | ok 2026-02-04 14:51:47.527755 | 2026-02-04 14:51:47.527872 | TASK [validate-host : Collect information about the host] 2026-02-04 14:51:48.670983 | debian-bookworm | ok 2026-02-04 14:51:48.690752 | 2026-02-04 14:51:48.691011 | TASK [validate-host : Sanitize hostname] 2026-02-04 14:51:48.824056 | debian-bookworm | ok 2026-02-04 14:51:48.865979 | 2026-02-04 14:51:48.866113 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-04 14:51:49.475215 | debian-bookworm -> localhost | changed 2026-02-04 14:51:49.484816 | 2026-02-04 14:51:49.484963 | TASK [validate-host : Collect information about zuul worker] 2026-02-04 14:51:49.901272 | debian-bookworm | ok 2026-02-04 14:51:49.907784 | 2026-02-04 14:51:49.907919 | TASK [validate-host : Write out all zuul information for each host] 2026-02-04 14:51:50.459090 | debian-bookworm -> localhost | changed 2026-02-04 14:51:50.472146 | 2026-02-04 14:51:50.472301 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-04 14:51:50.758469 | debian-bookworm | ok 2026-02-04 14:51:50.767774 | 2026-02-04 14:51:50.767921 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-04 14:51:51.826514 | debian-bookworm | changed: 2026-02-04 14:51:51.826744 | debian-bookworm | cd+++++++++ src/ 2026-02-04 14:51:51.826780 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-04 14:51:51.826804 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-04 14:51:51.826826 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-02-04 14:51:51.826910 | debian-bookworm | Containerfile 2026-02-04 14:51:51.827044 | debian-bookworm | Containerfile 2026-02-04 14:51:51.837218 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004506 2026-02-04 14:52:19.304631 | 2026-02-04 14:52:19.304757 | TASK [upload-logs : Upload logs to log server] 2026-02-04 14:52:19.879981 | localhost | Output suppressed because no_log was given 2026-02-04 14:52:19.883200 | 2026-02-04 14:52:19.883391 | LOOP [upload-logs : Compress console log and json output] 2026-02-04 14:52:19.936367 | localhost | skipping: Conditional result was False 2026-02-04 14:52:19.941347 | localhost | skipping: Conditional result was False 2026-02-04 14:52:19.950000 | 2026-02-04 14:52:19.950246 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-04 14:52:19.998643 | localhost | skipping: Conditional result was False 2026-02-04 14:52:19.999368 | 2026-02-04 14:52:20.002482 | localhost | skipping: Conditional result was False 2026-02-04 14:52:20.016753 | 2026-02-04 14:52:20.016976 | LOOP [upload-logs : Upload console log and json output]