2025-10-10 09:09:23.315220 | Job console starting 2025-10-10 09:09:23.376532 | Updating git repos 2025-10-10 09:09:23.462024 | Cloning repos into workspace 2025-10-10 09:09:23.591547 | Restoring repo states 2025-10-10 09:09:23.632185 | Merging changes 2025-10-10 09:09:24.191893 | Checking out repos 2025-10-10 09:09:24.247723 | Preparing playbooks 2025-10-10 09:09:25.498321 | Running Ansible setup 2025-10-10 09:09:30.335003 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-10 09:09:31.186645 | 2025-10-10 09:09:31.186766 | PLAY [Base pre] 2025-10-10 09:09:31.201137 | 2025-10-10 09:09:31.201243 | TASK [Setup log path fact] 2025-10-10 09:09:31.218687 | debian-bookworm | ok 2025-10-10 09:09:31.243042 | 2025-10-10 09:09:31.243165 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-10 09:09:31.289101 | debian-bookworm | ok 2025-10-10 09:09:31.309247 | 2025-10-10 09:09:31.309356 | TASK [emit-job-header : Print job information] 2025-10-10 09:09:31.359659 | # Job Information 2025-10-10 09:09:31.359809 | Ansible Version: 2.16.14 2025-10-10 09:09:31.359844 | Job: python-black 2025-10-10 09:09:31.359876 | Pipeline: check 2025-10-10 09:09:31.359899 | Executor: 521e9411259a 2025-10-10 09:09:31.359919 | Triggered by: https://github.com/osism/python-osism/pull/1745 2025-10-10 09:09:31.359994 | Event ID: c9d6abe0-a5b8-11f0-9ae7-cec516d507c7 2025-10-10 09:09:31.364827 | 2025-10-10 09:09:31.364922 | LOOP [emit-job-header : Print node information] 2025-10-10 09:09:31.591398 | debian-bookworm | ok: 2025-10-10 09:09:31.591629 | debian-bookworm | # Node Information 2025-10-10 09:09:31.591665 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-10 09:09:31.591689 | debian-bookworm | Hostname: debian 2025-10-10 09:09:31.591710 | debian-bookworm | Username: zuul 2025-10-10 09:09:31.591730 | debian-bookworm | Distro: Debian 12.12 2025-10-10 09:09:31.591752 | debian-bookworm | Provider: regiocloud-a 2025-10-10 09:09:31.591773 | debian-bookworm | Region: 2025-10-10 09:09:31.591793 | debian-bookworm | Label: debian-bookworm 2025-10-10 09:09:31.591812 | debian-bookworm | Product Name: OpenStack Nova 2025-10-10 09:09:31.591831 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe24:30be 2025-10-10 09:09:31.604290 | 2025-10-10 09:09:31.604388 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-10 09:09:32.105377 | debian-bookworm -> localhost | changed 2025-10-10 09:09:32.112122 | 2025-10-10 09:09:32.112231 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-10 09:09:33.489807 | debian-bookworm -> localhost | changed 2025-10-10 09:09:33.498922 | 2025-10-10 09:09:33.499023 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-10 09:09:34.066946 | debian-bookworm -> localhost | ok 2025-10-10 09:09:34.071746 | 2025-10-10 09:09:34.071832 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-10 09:09:34.111550 | debian-bookworm | ok 2025-10-10 09:09:34.130352 | debian-bookworm | included: /var/lib/zuul/builds/3098a43cdb8441a6916dc00a8cb1a630/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-10 09:09:34.144138 | 2025-10-10 09:09:34.144214 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-10 09:09:35.069430 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-10 09:09:35.069615 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3098a43cdb8441a6916dc00a8cb1a630/work/3098a43cdb8441a6916dc00a8cb1a630_id_rsa 2025-10-10 09:09:35.069647 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3098a43cdb8441a6916dc00a8cb1a630/work/3098a43cdb8441a6916dc00a8cb1a630_id_rsa.pub 2025-10-10 09:09:35.069669 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-10 09:09:35.069689 | debian-bookworm -> localhost | SHA256:4MthHJoKoB9MEB2FCyWGd3dq1Kc+qEj8eXMpYlQBOwg zuul-build-sshkey 2025-10-10 09:09:35.069707 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-10 09:09:35.069731 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-10 09:09:35.069749 | debian-bookworm -> localhost | |E=o+o. . | 2025-10-10 09:09:35.069767 | debian-bookworm -> localhost | |+++...+ o . | 2025-10-10 09:09:35.069783 | debian-bookworm -> localhost | |.oooooo+ o | 2025-10-10 09:09:35.069799 | debian-bookworm -> localhost | |oo. *+o. | 2025-10-10 09:09:35.069815 | debian-bookworm -> localhost | |o.o oo=oS | 2025-10-10 09:09:35.069836 | debian-bookworm -> localhost | | ooo.o.oo | 2025-10-10 09:09:35.069852 | debian-bookworm -> localhost | | .o+ oo o | 2025-10-10 09:09:35.069868 | debian-bookworm -> localhost | | . * + o | 2025-10-10 09:09:35.069886 | debian-bookworm -> localhost | | . o + | 2025-10-10 09:09:35.069902 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-10 09:09:35.069945 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.408714 2025-10-10 09:09:35.074937 | 2025-10-10 09:09:35.075019 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-10 09:09:35.090986 | debian-bookworm | ok 2025-10-10 09:09:35.098113 | debian-bookworm | included: /var/lib/zuul/builds/3098a43cdb8441a6916dc00a8cb1a630/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-10 09:09:35.105180 | 2025-10-10 09:09:35.105248 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-10 09:09:35.117465 | debian-bookworm | skipping: Conditional result was False 2025-10-10 09:09:35.121844 | 2025-10-10 09:09:35.121913 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-10 09:09:35.711738 | debian-bookworm | changed 2025-10-10 09:09:35.716275 | 2025-10-10 09:09:35.716356 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-10 09:09:35.991827 | debian-bookworm | ok 2025-10-10 09:09:35.996266 | 2025-10-10 09:09:35.996339 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-10 09:09:36.610116 | debian-bookworm | changed 2025-10-10 09:09:36.619560 | 2025-10-10 09:09:36.619667 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-10 09:09:37.260697 | debian-bookworm | changed 2025-10-10 09:09:37.265931 | 2025-10-10 09:09:37.266015 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-10 09:09:37.288731 | debian-bookworm | skipping: Conditional result was False 2025-10-10 09:09:37.294291 | 2025-10-10 09:09:37.294375 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-10 09:09:37.704488 | debian-bookworm -> localhost | changed 2025-10-10 09:09:37.715010 | 2025-10-10 09:09:37.715110 | TASK [add-build-sshkey : Add back temp key] 2025-10-10 09:09:37.992204 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3098a43cdb8441a6916dc00a8cb1a630/work/3098a43cdb8441a6916dc00a8cb1a630_id_rsa (zuul-build-sshkey) 2025-10-10 09:09:37.992467 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014746 2025-10-10 09:09:38.003956 | 2025-10-10 09:09:38.004236 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-10 09:09:38.387688 | debian-bookworm | ok 2025-10-10 09:09:38.391711 | 2025-10-10 09:09:38.391786 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-10 09:09:38.408215 | debian-bookworm | skipping: Conditional result was False 2025-10-10 09:09:38.416224 | 2025-10-10 09:09:38.416301 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-10 09:09:38.795993 | debian-bookworm | ok 2025-10-10 09:09:38.804469 | 2025-10-10 09:09:38.804554 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-10 09:09:38.846712 | debian-bookworm | ok 2025-10-10 09:09:38.850704 | 2025-10-10 09:09:38.850774 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-10 09:09:39.285585 | debian-bookworm -> localhost | ok 2025-10-10 09:09:39.297992 | 2025-10-10 09:09:39.298136 | TASK [validate-host : Collect information about the host] 2025-10-10 09:09:40.279810 | debian-bookworm | ok 2025-10-10 09:09:40.288782 | 2025-10-10 09:09:40.288863 | TASK [validate-host : Sanitize hostname] 2025-10-10 09:09:40.366986 | debian-bookworm | ok 2025-10-10 09:09:40.397393 | 2025-10-10 09:09:40.397517 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-10 09:09:41.022342 | debian-bookworm -> localhost | changed 2025-10-10 09:09:41.027646 | 2025-10-10 09:09:41.027730 | TASK [validate-host : Collect information about zuul worker] 2025-10-10 09:09:41.402253 | debian-bookworm | ok 2025-10-10 09:09:41.407105 | 2025-10-10 09:09:41.407197 | TASK [validate-host : Write out all zuul information for each host] 2025-10-10 09:09:42.178291 | debian-bookworm -> localhost | changed 2025-10-10 09:09:42.193400 | 2025-10-10 09:09:42.193516 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-10 09:09:42.442001 | debian-bookworm | ok 2025-10-10 09:09:42.449796 | 2025-10-10 09:09:42.449906 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-10 09:09:43.437468 | debian-bookworm | changed: 2025-10-10 09:09:43.437639 | debian-bookworm | cd+++++++++ src/ 2025-10-10 09:09:43.437674 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-10 09:09:43.437698 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-10 09:09:43.437719 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-10-10 09:09:43.437739 | debian-bookworm | Containerfile 2025-10-10 09:09:43.437852 | debian-bookworm | Containerfile 2025-10-10 09:09:43.464149 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007218 2025-10-10 09:10:09.059166 | 2025-10-10 09:10:09.059361 | TASK [upload-logs : Upload logs to log server] 2025-10-10 09:10:09.604104 | localhost | Output suppressed because no_log was given 2025-10-10 09:10:09.605978 | 2025-10-10 09:10:09.606088 | LOOP [upload-logs : Compress console log and json output] 2025-10-10 09:10:09.656255 | localhost | skipping: Conditional result was False 2025-10-10 09:10:09.662327 | localhost | skipping: Conditional result was False 2025-10-10 09:10:09.673582 | 2025-10-10 09:10:09.673713 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-10 09:10:09.715759 | localhost | skipping: Conditional result was False 2025-10-10 09:10:09.715992 | 2025-10-10 09:10:09.720660 | localhost | skipping: Conditional result was False 2025-10-10 09:10:09.731460 | 2025-10-10 09:10:09.731611 | LOOP [upload-logs : Upload console log and json output]