2025-09-09 10:35:31.801777 | Job console starting 2025-09-09 10:35:31.833856 | Updating git repos 2025-09-09 10:35:31.884346 | Cloning repos into workspace 2025-09-09 10:35:31.981677 | Restoring repo states 2025-09-09 10:35:31.997313 | Merging changes 2025-09-09 10:35:32.612919 | Checking out repos 2025-09-09 10:35:32.679560 | Preparing playbooks 2025-09-09 10:35:33.718049 | Running Ansible setup 2025-09-09 10:35:39.467373 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-09 10:35:40.788685 | 2025-09-09 10:35:40.788864 | PLAY [Base pre] 2025-09-09 10:35:40.825560 | 2025-09-09 10:35:40.825740 | TASK [Setup log path fact] 2025-09-09 10:35:40.857735 | debian-bookworm | ok 2025-09-09 10:35:40.897084 | 2025-09-09 10:35:40.897261 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-09 10:35:40.958108 | debian-bookworm | ok 2025-09-09 10:35:40.968847 | 2025-09-09 10:35:40.968994 | TASK [emit-job-header : Print job information] 2025-09-09 10:35:41.051236 | # Job Information 2025-09-09 10:35:41.051459 | Ansible Version: 2.16.14 2025-09-09 10:35:41.051498 | Job: python-black 2025-09-09 10:35:41.051531 | Pipeline: check 2025-09-09 10:35:41.051554 | Executor: 521e9411259a 2025-09-09 10:35:41.051575 | Triggered by: https://github.com/osism/python-osism/pull/1714 2025-09-09 10:35:41.051596 | Event ID: affaf4a0-8d68-11f0-8ee9-3be3871a7854 2025-09-09 10:35:41.056759 | 2025-09-09 10:35:41.056890 | LOOP [emit-job-header : Print node information] 2025-09-09 10:35:41.262063 | debian-bookworm | ok: 2025-09-09 10:35:41.262345 | debian-bookworm | # Node Information 2025-09-09 10:35:41.262384 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-09 10:35:41.262409 | debian-bookworm | Hostname: debian 2025-09-09 10:35:41.262452 | debian-bookworm | Username: zuul 2025-09-09 10:35:41.262474 | debian-bookworm | Distro: Debian 12.12 2025-09-09 10:35:41.262512 | debian-bookworm | Provider: regiocloud-a 2025-09-09 10:35:41.262541 | debian-bookworm | Region: 2025-09-09 10:35:41.262569 | debian-bookworm | Label: debian-bookworm 2025-09-09 10:35:41.262595 | debian-bookworm | Product Name: OpenStack Nova 2025-09-09 10:35:41.262621 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe13:8cf9 2025-09-09 10:35:41.284620 | 2025-09-09 10:35:41.284767 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-09 10:35:42.040696 | debian-bookworm -> localhost | changed 2025-09-09 10:35:42.049546 | 2025-09-09 10:35:42.049695 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-09 10:35:43.956756 | debian-bookworm -> localhost | changed 2025-09-09 10:35:43.966976 | 2025-09-09 10:35:43.967075 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-09 10:35:44.387871 | debian-bookworm -> localhost | ok 2025-09-09 10:35:44.393666 | 2025-09-09 10:35:44.393759 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-09 10:35:44.431584 | debian-bookworm | ok 2025-09-09 10:35:44.448533 | debian-bookworm | included: /var/lib/zuul/builds/5507d6491c56418d9b71eb50f5518e6a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-09 10:35:44.454546 | 2025-09-09 10:35:44.454631 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-09 10:35:45.682463 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-09 10:35:45.682661 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5507d6491c56418d9b71eb50f5518e6a/work/5507d6491c56418d9b71eb50f5518e6a_id_rsa 2025-09-09 10:35:45.682700 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5507d6491c56418d9b71eb50f5518e6a/work/5507d6491c56418d9b71eb50f5518e6a_id_rsa.pub 2025-09-09 10:35:45.682726 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-09 10:35:45.682751 | debian-bookworm -> localhost | SHA256:eTNvdinJhpxPPjev9n8bpwDWByxUmNJmbC2x1ZtA/44 zuul-build-sshkey 2025-09-09 10:35:45.682774 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-09 10:35:45.682806 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-09 10:35:45.682828 | debian-bookworm -> localhost | | ooB+. | 2025-09-09 10:35:45.682867 | debian-bookworm -> localhost | | ..X+o.. | 2025-09-09 10:35:45.682888 | debian-bookworm -> localhost | | =o.o..o | 2025-09-09 10:35:45.682908 | debian-bookworm -> localhost | | . o .o. | 2025-09-09 10:35:45.682927 | debian-bookworm -> localhost | | S * . . .| 2025-09-09 10:35:45.682952 | debian-bookworm -> localhost | | + O o + | 2025-09-09 10:35:45.682973 | debian-bookworm -> localhost | | + @ E.o| 2025-09-09 10:35:45.682992 | debian-bookworm -> localhost | | B.++.+| 2025-09-09 10:35:45.683013 | debian-bookworm -> localhost | | o+o*B| 2025-09-09 10:35:45.683033 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-09 10:35:45.683078 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.455671 2025-09-09 10:35:45.689110 | 2025-09-09 10:35:45.689196 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-09 10:35:45.716856 | debian-bookworm | ok 2025-09-09 10:35:45.731219 | debian-bookworm | included: /var/lib/zuul/builds/5507d6491c56418d9b71eb50f5518e6a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-09 10:35:45.750026 | 2025-09-09 10:35:45.750115 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-09 10:35:45.783409 | debian-bookworm | skipping: Conditional result was False 2025-09-09 10:35:45.788986 | 2025-09-09 10:35:45.789077 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-09 10:35:46.685149 | debian-bookworm | changed 2025-09-09 10:35:46.690258 | 2025-09-09 10:35:46.690341 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-09 10:35:47.002407 | debian-bookworm | ok 2025-09-09 10:35:47.007814 | 2025-09-09 10:35:47.007900 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-09 10:35:47.692767 | debian-bookworm | changed 2025-09-09 10:35:47.699137 | 2025-09-09 10:35:47.699227 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-09 10:35:48.409593 | debian-bookworm | changed 2025-09-09 10:35:48.414816 | 2025-09-09 10:35:48.414985 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-09 10:35:48.427837 | debian-bookworm | skipping: Conditional result was False 2025-09-09 10:35:48.433787 | 2025-09-09 10:35:48.433871 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-09 10:35:48.855262 | debian-bookworm -> localhost | changed 2025-09-09 10:35:48.866971 | 2025-09-09 10:35:48.867065 | TASK [add-build-sshkey : Add back temp key] 2025-09-09 10:35:49.248466 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5507d6491c56418d9b71eb50f5518e6a/work/5507d6491c56418d9b71eb50f5518e6a_id_rsa (zuul-build-sshkey) 2025-09-09 10:35:49.248677 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013334 2025-09-09 10:35:49.256856 | 2025-09-09 10:35:49.256949 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-09 10:35:49.640747 | debian-bookworm | ok 2025-09-09 10:35:49.645522 | 2025-09-09 10:35:49.645610 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-09 10:35:49.672465 | debian-bookworm | skipping: Conditional result was False 2025-09-09 10:35:49.682540 | 2025-09-09 10:35:49.682648 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-09 10:35:50.096778 | debian-bookworm | ok 2025-09-09 10:35:50.112189 | 2025-09-09 10:35:50.112300 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-09 10:35:50.169976 | debian-bookworm | ok 2025-09-09 10:35:50.178241 | 2025-09-09 10:35:50.178360 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-09 10:35:50.585489 | debian-bookworm -> localhost | ok 2025-09-09 10:35:50.591627 | 2025-09-09 10:35:50.591728 | TASK [validate-host : Collect information about the host] 2025-09-09 10:35:51.686098 | debian-bookworm | ok 2025-09-09 10:35:51.712099 | 2025-09-09 10:35:51.712213 | TASK [validate-host : Sanitize hostname] 2025-09-09 10:35:51.803255 | debian-bookworm | ok 2025-09-09 10:35:51.832841 | 2025-09-09 10:35:51.832941 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-09 10:35:52.451342 | debian-bookworm -> localhost | changed 2025-09-09 10:35:52.456666 | 2025-09-09 10:35:52.456757 | TASK [validate-host : Collect information about zuul worker] 2025-09-09 10:35:52.837595 | debian-bookworm | ok 2025-09-09 10:35:52.842408 | 2025-09-09 10:35:52.842522 | TASK [validate-host : Write out all zuul information for each host] 2025-09-09 10:35:53.570249 | debian-bookworm -> localhost | changed 2025-09-09 10:35:53.580101 | 2025-09-09 10:35:53.580218 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-09 10:35:53.889178 | debian-bookworm | ok 2025-09-09 10:35:53.896886 | 2025-09-09 10:35:53.897028 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-09 10:35:55.146525 | debian-bookworm | changed: 2025-09-09 10:35:55.146767 | debian-bookworm | cd+++++++++ src/ 2025-09-09 10:35:55.146807 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-09 10:35:55.146855 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-09 10:35:55.146879 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-09-09 10:35:55.146899 | debian-bookworm | Containerfile 2025-09-09 10:35:55.147015 | debian-bookworm | Containerfile 2025-09-09 10:35:55.165452 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007940 2025-09-09 10:36:23.826344 | 2025-09-09 10:36:23.826682 | TASK [upload-logs : Upload logs to log server] 2025-09-09 10:36:24.394962 | localhost | Output suppressed because no_log was given 2025-09-09 10:36:24.399319 | 2025-09-09 10:36:24.399532 | LOOP [upload-logs : Compress console log and json output] 2025-09-09 10:36:24.462301 | localhost | skipping: Conditional result was False 2025-09-09 10:36:24.468454 | localhost | skipping: Conditional result was False 2025-09-09 10:36:24.479910 | 2025-09-09 10:36:24.480015 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-09 10:36:24.526216 | localhost | skipping: Conditional result was False 2025-09-09 10:36:24.526890 | 2025-09-09 10:36:24.530264 | localhost | skipping: Conditional result was False 2025-09-09 10:36:24.544188 | 2025-09-09 10:36:24.544418 | LOOP [upload-logs : Upload console log and json output]