2025-11-21 21:41:43.714093 | Job console starting 2025-11-21 21:41:43.738355 | Updating git repos 2025-11-21 21:41:43.850654 | Cloning repos into workspace 2025-11-21 21:41:43.925398 | Restoring repo states 2025-11-21 21:41:43.954489 | Merging changes 2025-11-21 21:41:45.813283 | Checking out repos 2025-11-21 21:41:45.912997 | Preparing playbooks 2025-11-21 21:41:47.203375 | Running Ansible setup 2025-11-21 21:41:52.639554 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-21 21:41:54.280147 | 2025-11-21 21:41:54.280334 | PLAY [Base pre] 2025-11-21 21:41:54.323671 | 2025-11-21 21:41:54.323993 | TASK [Setup log path fact] 2025-11-21 21:41:54.366249 | debian-bookworm | ok 2025-11-21 21:41:54.397940 | 2025-11-21 21:41:54.398124 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-21 21:41:54.460811 | debian-bookworm | ok 2025-11-21 21:41:54.481766 | 2025-11-21 21:41:54.481928 | TASK [emit-job-header : Print job information] 2025-11-21 21:41:54.572468 | # Job Information 2025-11-21 21:41:54.572666 | Ansible Version: 2.16.14 2025-11-21 21:41:54.572715 | Job: python-black 2025-11-21 21:41:54.572749 | Pipeline: check 2025-11-21 21:41:54.572772 | Executor: 521e9411259a 2025-11-21 21:41:54.572793 | Triggered by: https://github.com/osism/python-osism/pull/1825 2025-11-21 21:41:54.572816 | Event ID: da69aee0-c722-11f0-9a2f-ced33cd28a75 2025-11-21 21:41:54.578025 | 2025-11-21 21:41:54.578158 | LOOP [emit-job-header : Print node information] 2025-11-21 21:41:54.719416 | debian-bookworm | ok: 2025-11-21 21:41:54.721868 | debian-bookworm | # Node Information 2025-11-21 21:41:54.721967 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-21 21:41:54.721998 | debian-bookworm | Hostname: debian 2025-11-21 21:41:54.722022 | debian-bookworm | Username: zuul 2025-11-21 21:41:54.722043 | debian-bookworm | Distro: Debian 12.12 2025-11-21 21:41:54.722068 | debian-bookworm | Provider: regiocloud-a 2025-11-21 21:41:54.722089 | debian-bookworm | Region: 2025-11-21 21:41:54.722110 | debian-bookworm | Label: debian-bookworm 2025-11-21 21:41:54.722131 | debian-bookworm | Product Name: OpenStack Nova 2025-11-21 21:41:54.722151 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec5:5715 2025-11-21 21:41:54.743904 | 2025-11-21 21:41:54.744062 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-21 21:41:55.676052 | debian-bookworm -> localhost | changed 2025-11-21 21:41:55.687430 | 2025-11-21 21:41:55.687589 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-21 21:41:57.267671 | debian-bookworm -> localhost | changed 2025-11-21 21:41:57.280810 | 2025-11-21 21:41:57.280943 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-21 21:41:58.037548 | debian-bookworm -> localhost | ok 2025-11-21 21:41:58.044393 | 2025-11-21 21:41:58.044520 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-21 21:41:58.085991 | debian-bookworm | ok 2025-11-21 21:41:58.124798 | debian-bookworm | included: /var/lib/zuul/builds/0bbc05d0805b49bbaf297267369e47eb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-21 21:41:58.142351 | 2025-11-21 21:41:58.142488 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-21 21:42:00.386783 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-21 21:42:00.387041 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0bbc05d0805b49bbaf297267369e47eb/work/0bbc05d0805b49bbaf297267369e47eb_id_rsa 2025-11-21 21:42:00.387081 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0bbc05d0805b49bbaf297267369e47eb/work/0bbc05d0805b49bbaf297267369e47eb_id_rsa.pub 2025-11-21 21:42:00.387108 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-21 21:42:00.387133 | debian-bookworm -> localhost | SHA256:WeKJJTc3gkdlLD45gy6njMkINTHuoqWRwrK7ZNXbSuw zuul-build-sshkey 2025-11-21 21:42:00.387156 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-21 21:42:00.387191 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-21 21:42:00.387214 | debian-bookworm -> localhost | | .oo | 2025-11-21 21:42:00.387236 | debian-bookworm -> localhost | | o o... | 2025-11-21 21:42:00.387256 | debian-bookworm -> localhost | | . o ooBo+ | 2025-11-21 21:42:00.387282 | debian-bookworm -> localhost | | + . .B*O . | 2025-11-21 21:42:00.387302 | debian-bookworm -> localhost | |.+ o o. S+ | 2025-11-21 21:42:00.387328 | debian-bookworm -> localhost | |B.+ o = | 2025-11-21 21:42:00.387349 | debian-bookworm -> localhost | |=@ + B . | 2025-11-21 21:42:00.387369 | debian-bookworm -> localhost | |B + = . | 2025-11-21 21:42:00.387390 | debian-bookworm -> localhost | |oo E | 2025-11-21 21:42:00.387410 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-21 21:42:00.387463 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.288913 2025-11-21 21:42:00.394331 | 2025-11-21 21:42:00.394459 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-21 21:42:00.425856 | debian-bookworm | ok 2025-11-21 21:42:00.435618 | debian-bookworm | included: /var/lib/zuul/builds/0bbc05d0805b49bbaf297267369e47eb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-21 21:42:00.454661 | 2025-11-21 21:42:00.454804 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-21 21:42:00.499167 | debian-bookworm | skipping: Conditional result was False 2025-11-21 21:42:00.505830 | 2025-11-21 21:42:00.505965 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-21 21:42:01.232650 | debian-bookworm | changed 2025-11-21 21:42:01.241491 | 2025-11-21 21:42:01.241627 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-21 21:42:01.532097 | debian-bookworm | ok 2025-11-21 21:42:01.539086 | 2025-11-21 21:42:01.539211 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-21 21:42:02.262584 | debian-bookworm | changed 2025-11-21 21:42:02.269841 | 2025-11-21 21:42:02.269973 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-21 21:42:02.956589 | debian-bookworm | changed 2025-11-21 21:42:02.966913 | 2025-11-21 21:42:02.967054 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-21 21:42:03.035922 | debian-bookworm | skipping: Conditional result was False 2025-11-21 21:42:03.042979 | 2025-11-21 21:42:03.043123 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-21 21:42:03.714860 | debian-bookworm -> localhost | changed 2025-11-21 21:42:03.726233 | 2025-11-21 21:42:03.726371 | TASK [add-build-sshkey : Add back temp key] 2025-11-21 21:42:04.166789 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0bbc05d0805b49bbaf297267369e47eb/work/0bbc05d0805b49bbaf297267369e47eb_id_rsa (zuul-build-sshkey) 2025-11-21 21:42:04.167184 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012446 2025-11-21 21:42:04.175494 | 2025-11-21 21:42:04.175620 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-21 21:42:04.656848 | debian-bookworm | ok 2025-11-21 21:42:04.662132 | 2025-11-21 21:42:04.662260 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-21 21:42:04.700213 | debian-bookworm | skipping: Conditional result was False 2025-11-21 21:42:04.711726 | 2025-11-21 21:42:04.711867 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-21 21:42:05.249525 | debian-bookworm | ok 2025-11-21 21:42:05.261604 | 2025-11-21 21:42:05.261825 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-21 21:42:05.291204 | debian-bookworm | ok 2025-11-21 21:42:05.296821 | 2025-11-21 21:42:05.296941 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-21 21:42:05.618288 | debian-bookworm -> localhost | ok 2025-11-21 21:42:05.625443 | 2025-11-21 21:42:05.625578 | TASK [validate-host : Collect information about the host] 2025-11-21 21:42:07.077428 | debian-bookworm | ok 2025-11-21 21:42:07.098429 | 2025-11-21 21:42:07.098570 | TASK [validate-host : Sanitize hostname] 2025-11-21 21:42:07.260713 | debian-bookworm | ok 2025-11-21 21:42:07.318037 | 2025-11-21 21:42:07.318182 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-21 21:42:08.288341 | debian-bookworm -> localhost | changed 2025-11-21 21:42:08.295649 | 2025-11-21 21:42:08.295819 | TASK [validate-host : Collect information about zuul worker] 2025-11-21 21:42:08.707068 | debian-bookworm | ok 2025-11-21 21:42:08.711959 | 2025-11-21 21:42:08.712080 | TASK [validate-host : Write out all zuul information for each host] 2025-11-21 21:42:09.563230 | debian-bookworm -> localhost | changed 2025-11-21 21:42:09.574463 | 2025-11-21 21:42:09.574602 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-21 21:42:09.889095 | debian-bookworm | ok 2025-11-21 21:42:09.895972 | 2025-11-21 21:42:09.896100 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-21 21:42:11.551919 | debian-bookworm | changed: 2025-11-21 21:42:11.552120 | debian-bookworm | cd+++++++++ src/ 2025-11-21 21:42:11.552154 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-21 21:42:11.552178 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-21 21:42:11.552199 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-21 21:42:11.552220 | debian-bookworm | Containerfile 2025-11-21 21:42:11.552333 | debian-bookworm | Containerfile 2025-11-21 21:42:11.559956 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007296 2025-11-21 21:42:38.988291 | 2025-11-21 21:42:38.988409 | TASK [upload-logs : Upload logs to log server] 2025-11-21 21:42:39.574524 | localhost | Output suppressed because no_log was given 2025-11-21 21:42:39.576776 | 2025-11-21 21:42:39.576895 | LOOP [upload-logs : Compress console log and json output] 2025-11-21 21:42:39.634897 | localhost | skipping: Conditional result was False 2025-11-21 21:42:39.639782 | localhost | skipping: Conditional result was False 2025-11-21 21:42:39.644756 | 2025-11-21 21:42:39.644890 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-21 21:42:39.691959 | localhost | skipping: Conditional result was False 2025-11-21 21:42:39.692307 | 2025-11-21 21:42:39.697417 | localhost | skipping: Conditional result was False 2025-11-21 21:42:39.704613 | 2025-11-21 21:42:39.704871 | LOOP [upload-logs : Upload console log and json output]