2025-12-30 17:00:27.880334 | Job console starting 2025-12-30 17:00:27.930632 | Updating git repos 2025-12-30 17:00:28.016783 | Cloning repos into workspace 2025-12-30 17:00:28.060298 | Restoring repo states 2025-12-30 17:00:28.074148 | Merging changes 2025-12-30 17:00:28.828541 | Checking out repos 2025-12-30 17:00:28.980255 | Preparing playbooks 2025-12-30 17:00:30.487153 | Running Ansible setup 2025-12-30 17:00:36.562215 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-30 17:00:37.829984 | 2025-12-30 17:00:37.830167 | PLAY [Base pre] 2025-12-30 17:00:37.869605 | 2025-12-30 17:00:37.869769 | TASK [Setup log path fact] 2025-12-30 17:00:37.917004 | debian-bookworm | ok 2025-12-30 17:00:37.948273 | 2025-12-30 17:00:37.948453 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-30 17:00:38.020181 | debian-bookworm | ok 2025-12-30 17:00:38.042456 | 2025-12-30 17:00:38.042601 | TASK [emit-job-header : Print job information] 2025-12-30 17:00:38.109184 | # Job Information 2025-12-30 17:00:38.109378 | Ansible Version: 2.16.14 2025-12-30 17:00:38.109414 | Job: python-black 2025-12-30 17:00:38.109447 | Pipeline: check 2025-12-30 17:00:38.109470 | Executor: 521e9411259a 2025-12-30 17:00:38.109491 | Triggered by: https://github.com/osism/python-osism/pull/1703 2025-12-30 17:00:38.109514 | Event ID: 053c5220-e5a1-11f0-8845-79795924d7e1 2025-12-30 17:00:38.115123 | 2025-12-30 17:00:38.115254 | LOOP [emit-job-header : Print node information] 2025-12-30 17:00:38.359325 | debian-bookworm | ok: 2025-12-30 17:00:38.359623 | debian-bookworm | # Node Information 2025-12-30 17:00:38.359664 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-30 17:00:38.359691 | debian-bookworm | Hostname: debian 2025-12-30 17:00:38.359713 | debian-bookworm | Username: zuul 2025-12-30 17:00:38.359734 | debian-bookworm | Distro: Debian 12.12 2025-12-30 17:00:38.359764 | debian-bookworm | Provider: regiocloud-a 2025-12-30 17:00:38.359789 | debian-bookworm | Region: 2025-12-30 17:00:38.359810 | debian-bookworm | Label: debian-bookworm 2025-12-30 17:00:38.359847 | debian-bookworm | Product Name: OpenStack Nova 2025-12-30 17:00:38.359867 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed8:2be2 2025-12-30 17:00:38.386428 | 2025-12-30 17:00:38.386578 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-30 17:00:39.871454 | debian-bookworm -> localhost | changed 2025-12-30 17:00:39.881988 | 2025-12-30 17:00:39.882140 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-30 17:00:42.455975 | debian-bookworm -> localhost | changed 2025-12-30 17:00:42.474450 | 2025-12-30 17:00:42.474599 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-30 17:00:43.449438 | debian-bookworm -> localhost | ok 2025-12-30 17:00:43.456451 | 2025-12-30 17:00:43.456589 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-30 17:00:43.517397 | debian-bookworm | ok 2025-12-30 17:00:43.562199 | debian-bookworm | included: /var/lib/zuul/builds/a0f6c992028a47e69a1ae69bae357cbf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-30 17:00:43.576754 | 2025-12-30 17:00:43.576913 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-30 17:00:46.176305 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-30 17:00:46.176533 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a0f6c992028a47e69a1ae69bae357cbf/work/a0f6c992028a47e69a1ae69bae357cbf_id_rsa 2025-12-30 17:00:46.176574 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a0f6c992028a47e69a1ae69bae357cbf/work/a0f6c992028a47e69a1ae69bae357cbf_id_rsa.pub 2025-12-30 17:00:46.176603 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-30 17:00:46.176627 | debian-bookworm -> localhost | SHA256:UN53U1Z6GE9I1BLXrgq3tHJ3EItYBUDn1rXpYfRFjPk zuul-build-sshkey 2025-12-30 17:00:46.176650 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-30 17:00:46.176685 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-30 17:00:46.176707 | debian-bookworm -> localhost | | ..o.o+=X%| 2025-12-30 17:00:46.176729 | debian-bookworm -> localhost | | o . o .B@O| 2025-12-30 17:00:46.176749 | debian-bookworm -> localhost | | . . . +.*O+| 2025-12-30 17:00:46.176769 | debian-bookworm -> localhost | | . o..+oE| 2025-12-30 17:00:46.176788 | debian-bookworm -> localhost | | S o . = | 2025-12-30 17:00:46.176813 | debian-bookworm -> localhost | | o + + | 2025-12-30 17:00:46.176853 | debian-bookworm -> localhost | | + + . | 2025-12-30 17:00:46.176873 | debian-bookworm -> localhost | | . = . .| 2025-12-30 17:00:46.176894 | debian-bookworm -> localhost | | o . . | 2025-12-30 17:00:46.176914 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-30 17:00:46.176966 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.214939 2025-12-30 17:00:46.185275 | 2025-12-30 17:00:46.185412 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-30 17:00:46.233748 | debian-bookworm | ok 2025-12-30 17:00:46.255846 | debian-bookworm | included: /var/lib/zuul/builds/a0f6c992028a47e69a1ae69bae357cbf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-30 17:00:46.273099 | 2025-12-30 17:00:46.273232 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-30 17:00:46.317659 | debian-bookworm | skipping: Conditional result was False 2025-12-30 17:00:46.323956 | 2025-12-30 17:00:46.324079 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-30 17:00:47.515680 | debian-bookworm | changed 2025-12-30 17:00:47.521451 | 2025-12-30 17:00:47.521572 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-30 17:00:47.850087 | debian-bookworm | ok 2025-12-30 17:00:47.857136 | 2025-12-30 17:00:47.857277 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-30 17:00:48.803763 | debian-bookworm | changed 2025-12-30 17:00:48.823059 | 2025-12-30 17:00:48.831827 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-30 17:00:49.714579 | debian-bookworm | changed 2025-12-30 17:00:49.726990 | 2025-12-30 17:00:49.727215 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-30 17:00:49.783077 | debian-bookworm | skipping: Conditional result was False 2025-12-30 17:00:49.789697 | 2025-12-30 17:00:49.789888 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-30 17:00:50.566982 | debian-bookworm -> localhost | changed 2025-12-30 17:00:50.578701 | 2025-12-30 17:00:50.578864 | TASK [add-build-sshkey : Add back temp key] 2025-12-30 17:00:51.148733 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a0f6c992028a47e69a1ae69bae357cbf/work/a0f6c992028a47e69a1ae69bae357cbf_id_rsa (zuul-build-sshkey) 2025-12-30 17:00:51.149055 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014175 2025-12-30 17:00:51.166097 | 2025-12-30 17:00:51.166232 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-30 17:00:51.692385 | debian-bookworm | ok 2025-12-30 17:00:51.709008 | 2025-12-30 17:00:51.709240 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-30 17:00:51.747364 | debian-bookworm | skipping: Conditional result was False 2025-12-30 17:00:51.758809 | 2025-12-30 17:00:51.759014 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-30 17:00:52.249231 | debian-bookworm | ok 2025-12-30 17:00:52.264845 | 2025-12-30 17:00:52.265000 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-30 17:00:52.301686 | debian-bookworm | ok 2025-12-30 17:00:52.326693 | 2025-12-30 17:00:52.326960 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-30 17:00:52.883959 | debian-bookworm -> localhost | ok 2025-12-30 17:00:52.892498 | 2025-12-30 17:00:52.892634 | TASK [validate-host : Collect information about the host] 2025-12-30 17:00:54.409306 | debian-bookworm | ok 2025-12-30 17:00:54.433655 | 2025-12-30 17:00:54.433801 | TASK [validate-host : Sanitize hostname] 2025-12-30 17:00:54.743782 | debian-bookworm | ok 2025-12-30 17:00:54.873087 | 2025-12-30 17:00:54.873271 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-30 17:00:55.772242 | debian-bookworm -> localhost | changed 2025-12-30 17:00:55.788677 | 2025-12-30 17:00:55.788858 | TASK [validate-host : Collect information about zuul worker] 2025-12-30 17:00:56.276145 | debian-bookworm | ok 2025-12-30 17:00:56.300334 | 2025-12-30 17:00:56.306139 | TASK [validate-host : Write out all zuul information for each host] 2025-12-30 17:00:57.443363 | debian-bookworm -> localhost | changed 2025-12-30 17:00:57.455906 | 2025-12-30 17:00:57.456042 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-30 17:00:57.745773 | debian-bookworm | ok 2025-12-30 17:00:57.768900 | 2025-12-30 17:00:57.769053 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-30 17:00:58.984671 | debian-bookworm | changed: 2025-12-30 17:00:58.984931 | debian-bookworm | cd+++++++++ src/ 2025-12-30 17:00:58.984975 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-30 17:00:58.985000 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-30 17:00:58.985022 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-30 17:00:58.985042 | debian-bookworm | Containerfile 2025-12-30 17:00:58.985174 | debian-bookworm | Containerfile 2025-12-30 17:00:58.995694 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007980 2025-12-30 17:01:27.635073 | 2025-12-30 17:01:27.635254 | TASK [upload-logs : Upload logs to log server] 2025-12-30 17:01:28.292767 | localhost | Output suppressed because no_log was given 2025-12-30 17:01:28.295472 | 2025-12-30 17:01:28.295608 | LOOP [upload-logs : Compress console log and json output] 2025-12-30 17:01:28.360905 | localhost | skipping: Conditional result was False 2025-12-30 17:01:28.369082 | localhost | skipping: Conditional result was False 2025-12-30 17:01:28.375156 | 2025-12-30 17:01:28.375293 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-30 17:01:28.447660 | localhost | skipping: Conditional result was False 2025-12-30 17:01:28.447999 | 2025-12-30 17:01:28.458654 | localhost | skipping: Conditional result was False 2025-12-30 17:01:28.467270 | 2025-12-30 17:01:28.467431 | LOOP [upload-logs : Upload console log and json output]