2026-02-03 22:40:25.324556 | Job console starting 2026-02-03 22:40:25.338692 | Updating git repos 2026-02-03 22:40:25.394279 | Cloning repos into workspace 2026-02-03 22:40:25.453237 | Restoring repo states 2026-02-03 22:40:25.462925 | Merging changes 2026-02-03 22:40:26.038134 | Checking out repos 2026-02-03 22:40:26.118876 | Preparing playbooks 2026-02-03 22:40:27.182672 | Running Ansible setup 2026-02-03 22:40:33.883907 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-02-03 22:40:35.400536 | 2026-02-03 22:40:35.400662 | PLAY [Base pre] 2026-02-03 22:40:35.418305 | 2026-02-03 22:40:35.418428 | TASK [Setup log path fact] 2026-02-03 22:40:35.436264 | debian-bookworm | ok 2026-02-03 22:40:35.462588 | 2026-02-03 22:40:35.462735 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-03 22:40:35.559338 | debian-bookworm | ok 2026-02-03 22:40:35.575281 | 2026-02-03 22:40:35.575398 | TASK [emit-job-header : Print job information] 2026-02-03 22:40:35.645740 | # Job Information 2026-02-03 22:40:35.645898 | Ansible Version: 2.16.14 2026-02-03 22:40:35.645933 | Job: python-black 2026-02-03 22:40:35.645966 | Pipeline: check 2026-02-03 22:40:35.645989 | Executor: 521e9411259a 2026-02-03 22:40:35.646009 | Triggered by: https://github.com/osism/python-osism/pull/1977 2026-02-03 22:40:35.646032 | Event ID: 4ea23cb0-0151-11f1-8778-9a64b8acf3fd 2026-02-03 22:40:35.651138 | 2026-02-03 22:40:35.651249 | LOOP [emit-job-header : Print node information] 2026-02-03 22:40:35.752690 | debian-bookworm | ok: 2026-02-03 22:40:35.752856 | debian-bookworm | # Node Information 2026-02-03 22:40:35.752889 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-02-03 22:40:35.752914 | debian-bookworm | Hostname: debian 2026-02-03 22:40:35.752936 | debian-bookworm | Username: zuul 2026-02-03 22:40:35.752956 | debian-bookworm | Distro: Debian 12.13 2026-02-03 22:40:35.752980 | debian-bookworm | Provider: regiocloud-a 2026-02-03 22:40:35.753000 | debian-bookworm | Region: 2026-02-03 22:40:35.753020 | debian-bookworm | Label: debian-bookworm 2026-02-03 22:40:35.753040 | debian-bookworm | Product Name: OpenStack Nova 2026-02-03 22:40:35.753058 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe34:6acb 2026-02-03 22:40:35.771518 | 2026-02-03 22:40:35.771630 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-03 22:40:36.330640 | debian-bookworm -> localhost | changed 2026-02-03 22:40:36.337461 | 2026-02-03 22:40:36.337585 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-03 22:40:38.527113 | debian-bookworm -> localhost | changed 2026-02-03 22:40:38.537154 | 2026-02-03 22:40:38.537245 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-03 22:40:39.095709 | debian-bookworm -> localhost | ok 2026-02-03 22:40:39.100707 | 2026-02-03 22:40:39.100799 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-03 22:40:39.145000 | debian-bookworm | ok 2026-02-03 22:40:39.212119 | debian-bookworm | included: /var/lib/zuul/builds/7fe77507b9cc4f7abbe9395edbc61b39/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-03 22:40:39.227391 | 2026-02-03 22:40:39.227498 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-03 22:40:41.956391 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-02-03 22:40:41.956578 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7fe77507b9cc4f7abbe9395edbc61b39/work/7fe77507b9cc4f7abbe9395edbc61b39_id_rsa 2026-02-03 22:40:41.956609 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7fe77507b9cc4f7abbe9395edbc61b39/work/7fe77507b9cc4f7abbe9395edbc61b39_id_rsa.pub 2026-02-03 22:40:41.956631 | debian-bookworm -> localhost | The key fingerprint is: 2026-02-03 22:40:41.956652 | debian-bookworm -> localhost | SHA256:M8dE1rTPISr9tfFco+7/2981jK3dQLkLuQGkARkazw8 zuul-build-sshkey 2026-02-03 22:40:41.956671 | debian-bookworm -> localhost | The key's randomart image is: 2026-02-03 22:40:41.956698 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-02-03 22:40:41.956717 | debian-bookworm -> localhost | | . oo oo. | 2026-02-03 22:40:41.956734 | debian-bookworm -> localhost | | =.. o .. | 2026-02-03 22:40:41.956751 | debian-bookworm -> localhost | | . E . o o . | 2026-02-03 22:40:41.956766 | debian-bookworm -> localhost | | o B . + o | 2026-02-03 22:40:41.956782 | debian-bookworm -> localhost | | S * B..| 2026-02-03 22:40:41.956801 | debian-bookworm -> localhost | | = o +=*o| 2026-02-03 22:40:41.956817 | debian-bookworm -> localhost | | =o+++| 2026-02-03 22:40:41.956834 | debian-bookworm -> localhost | | .+oo*| 2026-02-03 22:40:41.956936 | debian-bookworm -> localhost | | o+o+X| 2026-02-03 22:40:41.956960 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-02-03 22:40:41.957027 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.312464 2026-02-03 22:40:41.969218 | 2026-02-03 22:40:41.969309 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-03 22:40:42.009179 | debian-bookworm | ok 2026-02-03 22:40:42.020814 | debian-bookworm | included: /var/lib/zuul/builds/7fe77507b9cc4f7abbe9395edbc61b39/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-03 22:40:42.042095 | 2026-02-03 22:40:42.042196 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-03 22:40:42.097970 | debian-bookworm | skipping: Conditional result was False 2026-02-03 22:40:42.102948 | 2026-02-03 22:40:42.103032 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-03 22:40:42.765049 | debian-bookworm | changed 2026-02-03 22:40:42.769427 | 2026-02-03 22:40:42.769514 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-03 22:40:43.002357 | debian-bookworm | ok 2026-02-03 22:40:43.007870 | 2026-02-03 22:40:43.007953 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-03 22:40:43.678725 | debian-bookworm | changed 2026-02-03 22:40:43.688099 | 2026-02-03 22:40:43.688221 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-03 22:40:44.427677 | debian-bookworm | changed 2026-02-03 22:40:44.433331 | 2026-02-03 22:40:44.433433 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-03 22:40:44.466995 | debian-bookworm | skipping: Conditional result was False 2026-02-03 22:40:44.474857 | 2026-02-03 22:40:44.474977 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-03 22:40:45.463871 | debian-bookworm -> localhost | changed 2026-02-03 22:40:45.474759 | 2026-02-03 22:40:45.474891 | TASK [add-build-sshkey : Add back temp key] 2026-02-03 22:40:45.923780 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7fe77507b9cc4f7abbe9395edbc61b39/work/7fe77507b9cc4f7abbe9395edbc61b39_id_rsa (zuul-build-sshkey) 2026-02-03 22:40:45.923974 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.008109 2026-02-03 22:40:45.930174 | 2026-02-03 22:40:45.930263 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-03 22:40:46.401589 | debian-bookworm | ok 2026-02-03 22:40:46.410328 | 2026-02-03 22:40:46.410426 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-03 22:40:46.477270 | debian-bookworm | skipping: Conditional result was False 2026-02-03 22:40:46.489473 | 2026-02-03 22:40:46.489574 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-03 22:40:47.077823 | debian-bookworm | ok 2026-02-03 22:40:47.100814 | 2026-02-03 22:40:47.102281 | TASK [validate-host : Define zuul_info_dir fact] 2026-02-03 22:40:47.155382 | debian-bookworm | ok 2026-02-03 22:40:47.162469 | 2026-02-03 22:40:47.162572 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-02-03 22:40:47.660326 | debian-bookworm -> localhost | ok 2026-02-03 22:40:47.666414 | 2026-02-03 22:40:47.666571 | TASK [validate-host : Collect information about the host] 2026-02-03 22:40:48.734115 | debian-bookworm | ok 2026-02-03 22:40:48.771961 | 2026-02-03 22:40:48.772070 | TASK [validate-host : Sanitize hostname] 2026-02-03 22:40:48.893434 | debian-bookworm | ok 2026-02-03 22:40:48.943744 | 2026-02-03 22:40:48.943846 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-02-03 22:40:49.534289 | debian-bookworm -> localhost | changed 2026-02-03 22:40:49.538968 | 2026-02-03 22:40:49.539064 | TASK [validate-host : Collect information about zuul worker] 2026-02-03 22:40:49.930253 | debian-bookworm | ok 2026-02-03 22:40:49.934712 | 2026-02-03 22:40:49.934803 | TASK [validate-host : Write out all zuul information for each host] 2026-02-03 22:40:50.562643 | debian-bookworm -> localhost | changed 2026-02-03 22:40:50.570166 | 2026-02-03 22:40:50.570252 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-02-03 22:40:50.850688 | debian-bookworm | ok 2026-02-03 22:40:50.859413 | 2026-02-03 22:40:50.859574 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-02-03 22:40:51.908149 | debian-bookworm | changed: 2026-02-03 22:40:51.908369 | debian-bookworm | cd+++++++++ src/ 2026-02-03 22:40:51.908402 | debian-bookworm | cd+++++++++ src/github.com/ 2026-02-03 22:40:51.908422 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-02-03 22:40:51.908440 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2026-02-03 22:40:51.908456 | debian-bookworm | Containerfile 2026-02-03 22:40:51.908599 | debian-bookworm | Containerfile 2026-02-03 22:40:51.917144 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007502 2026-02-03 22:41:19.866512 | 2026-02-03 22:41:19.866640 | TASK [upload-logs : Upload logs to log server] 2026-02-03 22:41:20.462019 | localhost | Output suppressed because no_log was given 2026-02-03 22:41:20.463990 | 2026-02-03 22:41:20.464104 | LOOP [upload-logs : Compress console log and json output] 2026-02-03 22:41:20.532541 | localhost | skipping: Conditional result was False 2026-02-03 22:41:20.549216 | localhost | skipping: Conditional result was False 2026-02-03 22:41:20.555784 | 2026-02-03 22:41:20.555915 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-03 22:41:20.610224 | localhost | skipping: Conditional result was False 2026-02-03 22:41:20.610570 | 2026-02-03 22:41:20.617544 | localhost | skipping: Conditional result was False 2026-02-03 22:41:20.624797 | 2026-02-03 22:41:20.624908 | LOOP [upload-logs : Upload console log and json output]