2025-11-23 11:21:35.295543 | Job console starting 2025-11-23 11:21:35.326637 | Updating git repos 2025-11-23 11:21:35.421711 | Cloning repos into workspace 2025-11-23 11:21:35.505459 | Restoring repo states 2025-11-23 11:21:35.520903 | Merging changes 2025-11-23 11:21:36.164335 | Checking out repos 2025-11-23 11:21:36.221793 | Preparing playbooks 2025-11-23 11:21:37.396498 | Running Ansible setup 2025-11-23 11:21:43.963563 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-23 11:21:45.605909 | 2025-11-23 11:21:45.606095 | PLAY [Base pre] 2025-11-23 11:21:45.631074 | 2025-11-23 11:21:45.631238 | TASK [Setup log path fact] 2025-11-23 11:21:45.666407 | debian-bookworm | ok 2025-11-23 11:21:45.693564 | 2025-11-23 11:21:45.693847 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-23 11:21:45.769623 | debian-bookworm | ok 2025-11-23 11:21:45.792947 | 2025-11-23 11:21:45.793099 | TASK [emit-job-header : Print job information] 2025-11-23 11:21:45.843139 | # Job Information 2025-11-23 11:21:45.843327 | Ansible Version: 2.16.14 2025-11-23 11:21:45.843361 | Job: python-black 2025-11-23 11:21:45.843392 | Pipeline: check 2025-11-23 11:21:45.843415 | Executor: 521e9411259a 2025-11-23 11:21:45.843435 | Triggered by: https://github.com/osism/python-osism/pull/1839 2025-11-23 11:21:45.843457 | Event ID: 8c038f90-c85e-11f0-9efb-94bbbbb3b0e9 2025-11-23 11:21:45.849035 | 2025-11-23 11:21:45.849159 | LOOP [emit-job-header : Print node information] 2025-11-23 11:21:46.015179 | debian-bookworm | ok: 2025-11-23 11:21:46.015434 | debian-bookworm | # Node Information 2025-11-23 11:21:46.015483 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-23 11:21:46.015518 | debian-bookworm | Hostname: debian 2025-11-23 11:21:46.015549 | debian-bookworm | Username: zuul 2025-11-23 11:21:46.015578 | debian-bookworm | Distro: Debian 12.12 2025-11-23 11:21:46.015614 | debian-bookworm | Provider: regiocloud-a 2025-11-23 11:21:46.015661 | debian-bookworm | Region: 2025-11-23 11:21:46.015695 | debian-bookworm | Label: debian-bookworm 2025-11-23 11:21:46.015724 | debian-bookworm | Product Name: OpenStack Nova 2025-11-23 11:21:46.015752 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe16:f10c 2025-11-23 11:21:46.030826 | 2025-11-23 11:21:46.031018 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-23 11:21:47.069153 | debian-bookworm -> localhost | changed 2025-11-23 11:21:47.077579 | 2025-11-23 11:21:47.077727 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-23 11:21:49.092381 | debian-bookworm -> localhost | changed 2025-11-23 11:21:49.106242 | 2025-11-23 11:21:49.109657 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-23 11:21:49.780468 | debian-bookworm -> localhost | ok 2025-11-23 11:21:49.787214 | 2025-11-23 11:21:49.787369 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-23 11:21:49.824279 | debian-bookworm | ok 2025-11-23 11:21:49.847324 | debian-bookworm | included: /var/lib/zuul/builds/913aa9d074af45e6a261e788cc99c701/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-23 11:21:49.853817 | 2025-11-23 11:21:49.853941 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-23 11:21:53.465134 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-23 11:21:53.465370 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/913aa9d074af45e6a261e788cc99c701/work/913aa9d074af45e6a261e788cc99c701_id_rsa 2025-11-23 11:21:53.465411 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/913aa9d074af45e6a261e788cc99c701/work/913aa9d074af45e6a261e788cc99c701_id_rsa.pub 2025-11-23 11:21:53.465440 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-23 11:21:53.465467 | debian-bookworm -> localhost | SHA256:32gqQCaUDqpyZ4+mPmiHyqkd23t9igbC1LOXO1mmvss zuul-build-sshkey 2025-11-23 11:21:53.465490 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-23 11:21:53.465525 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-23 11:21:53.465546 | debian-bookworm -> localhost | | . | 2025-11-23 11:21:53.465568 | debian-bookworm -> localhost | |. o | 2025-11-23 11:21:53.465589 | debian-bookworm -> localhost | |.+ . | 2025-11-23 11:21:53.465609 | debian-bookworm -> localhost | |. + = | 2025-11-23 11:21:53.465629 | debian-bookworm -> localhost | |.o + o .S | 2025-11-23 11:21:53.465681 | debian-bookworm -> localhost | |o + * o o. o | 2025-11-23 11:21:53.465703 | debian-bookworm -> localhost | |.oo+ * B + . | 2025-11-23 11:21:53.465724 | debian-bookworm -> localhost | |o+o=o.X..o. | 2025-11-23 11:21:53.465745 | debian-bookworm -> localhost | |*+*+o=E=oo | 2025-11-23 11:21:53.465765 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-23 11:21:53.465817 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.596341 2025-11-23 11:21:53.472575 | 2025-11-23 11:21:53.472720 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-23 11:21:53.505767 | debian-bookworm | ok 2025-11-23 11:21:53.516759 | debian-bookworm | included: /var/lib/zuul/builds/913aa9d074af45e6a261e788cc99c701/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-23 11:21:53.526225 | 2025-11-23 11:21:53.526344 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-23 11:21:53.550528 | debian-bookworm | skipping: Conditional result was False 2025-11-23 11:21:53.557066 | 2025-11-23 11:21:53.557182 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-23 11:21:54.450226 | debian-bookworm | changed 2025-11-23 11:21:54.467900 | 2025-11-23 11:21:54.468049 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-23 11:21:54.756580 | debian-bookworm | ok 2025-11-23 11:21:54.764132 | 2025-11-23 11:21:54.764251 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-23 11:21:55.446971 | debian-bookworm | changed 2025-11-23 11:21:55.454060 | 2025-11-23 11:21:55.454191 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-23 11:21:56.238870 | debian-bookworm | changed 2025-11-23 11:21:56.244765 | 2025-11-23 11:21:56.244883 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-23 11:21:56.295706 | debian-bookworm | skipping: Conditional result was False 2025-11-23 11:21:56.302965 | 2025-11-23 11:21:56.303105 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-23 11:21:57.087882 | debian-bookworm -> localhost | changed 2025-11-23 11:21:57.099806 | 2025-11-23 11:21:57.099945 | TASK [add-build-sshkey : Add back temp key] 2025-11-23 11:21:57.567397 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/913aa9d074af45e6a261e788cc99c701/work/913aa9d074af45e6a261e788cc99c701_id_rsa (zuul-build-sshkey) 2025-11-23 11:21:57.567721 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013362 2025-11-23 11:21:57.576714 | 2025-11-23 11:21:57.576848 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-23 11:21:58.111146 | debian-bookworm | ok 2025-11-23 11:21:58.116517 | 2025-11-23 11:21:58.116642 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-23 11:21:58.173042 | debian-bookworm | skipping: Conditional result was False 2025-11-23 11:21:58.186422 | 2025-11-23 11:21:58.186571 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-23 11:21:58.657262 | debian-bookworm | ok 2025-11-23 11:21:58.668899 | 2025-11-23 11:21:58.669027 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-23 11:21:58.721735 | debian-bookworm | ok 2025-11-23 11:21:58.727038 | 2025-11-23 11:21:58.727163 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-23 11:21:59.191770 | debian-bookworm -> localhost | ok 2025-11-23 11:21:59.199879 | 2025-11-23 11:21:59.200018 | TASK [validate-host : Collect information about the host] 2025-11-23 11:22:00.443390 | debian-bookworm | ok 2025-11-23 11:22:00.464899 | 2025-11-23 11:22:00.465044 | TASK [validate-host : Sanitize hostname] 2025-11-23 11:22:00.752059 | debian-bookworm | ok 2025-11-23 11:22:00.825505 | 2025-11-23 11:22:00.825678 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-23 11:22:01.758009 | debian-bookworm -> localhost | changed 2025-11-23 11:22:01.764396 | 2025-11-23 11:22:01.764528 | TASK [validate-host : Collect information about zuul worker] 2025-11-23 11:22:02.311618 | debian-bookworm | ok 2025-11-23 11:22:02.316917 | 2025-11-23 11:22:02.317055 | TASK [validate-host : Write out all zuul information for each host] 2025-11-23 11:22:03.101688 | debian-bookworm -> localhost | changed 2025-11-23 11:22:03.112055 | 2025-11-23 11:22:03.112225 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-23 11:22:03.487513 | debian-bookworm | ok 2025-11-23 11:22:03.501757 | 2025-11-23 11:22:03.501899 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-23 11:22:04.809065 | debian-bookworm | changed: 2025-11-23 11:22:04.809414 | debian-bookworm | cd+++++++++ src/ 2025-11-23 11:22:04.809480 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-23 11:22:04.809523 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-23 11:22:04.809562 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-23 11:22:04.809599 | debian-bookworm | Containerfile 2025-11-23 11:22:04.809861 | debian-bookworm | Containerfile 2025-11-23 11:22:04.827329 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008040 2025-11-23 11:22:32.150749 | 2025-11-23 11:22:32.151119 | TASK [upload-logs : Upload logs to log server] 2025-11-23 11:22:32.804127 | localhost | Output suppressed because no_log was given 2025-11-23 11:22:32.805985 | 2025-11-23 11:22:32.806092 | LOOP [upload-logs : Compress console log and json output] 2025-11-23 11:22:32.859943 | localhost | skipping: Conditional result was False 2025-11-23 11:22:32.864830 | localhost | skipping: Conditional result was False 2025-11-23 11:22:32.873428 | 2025-11-23 11:22:32.873543 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-23 11:22:32.925754 | localhost | skipping: Conditional result was False 2025-11-23 11:22:32.926375 | 2025-11-23 11:22:32.929773 | localhost | skipping: Conditional result was False 2025-11-23 11:22:32.949058 | 2025-11-23 11:22:32.949224 | LOOP [upload-logs : Upload console log and json output]