2025-11-24 22:02:12.868886 | Job console starting 2025-11-24 22:02:12.910680 | Updating git repos 2025-11-24 22:02:12.980995 | Cloning repos into workspace 2025-11-24 22:02:13.068174 | Restoring repo states 2025-11-24 22:02:13.083276 | Merging changes 2025-11-24 22:02:13.791630 | Checking out repos 2025-11-24 22:02:13.886804 | Preparing playbooks 2025-11-24 22:02:14.955237 | Running Ansible setup 2025-11-24 22:02:20.465459 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-24 22:02:21.586437 | 2025-11-24 22:02:21.588042 | PLAY [Base pre] 2025-11-24 22:02:21.633951 | 2025-11-24 22:02:21.634117 | TASK [Setup log path fact] 2025-11-24 22:02:21.674261 | debian-bookworm | ok 2025-11-24 22:02:21.696649 | 2025-11-24 22:02:21.696825 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-24 22:02:21.760538 | debian-bookworm | ok 2025-11-24 22:02:21.773715 | 2025-11-24 22:02:21.773873 | TASK [emit-job-header : Print job information] 2025-11-24 22:02:21.842263 | # Job Information 2025-11-24 22:02:21.842475 | Ansible Version: 2.16.14 2025-11-24 22:02:21.842513 | Job: python-black 2025-11-24 22:02:21.842545 | Pipeline: check 2025-11-24 22:02:21.842568 | Executor: 521e9411259a 2025-11-24 22:02:21.842588 | Triggered by: https://github.com/osism/python-osism/pull/1850 2025-11-24 22:02:21.842610 | Event ID: 35cfcb60-c981-11f0-8231-dcde56a30c26 2025-11-24 22:02:21.848440 | 2025-11-24 22:02:21.848578 | LOOP [emit-job-header : Print node information] 2025-11-24 22:02:22.134422 | debian-bookworm | ok: 2025-11-24 22:02:22.134618 | debian-bookworm | # Node Information 2025-11-24 22:02:22.134653 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-24 22:02:22.134678 | debian-bookworm | Hostname: debian 2025-11-24 22:02:22.134700 | debian-bookworm | Username: zuul 2025-11-24 22:02:22.134720 | debian-bookworm | Distro: Debian 12.12 2025-11-24 22:02:22.134745 | debian-bookworm | Provider: regiocloud-a 2025-11-24 22:02:22.134765 | debian-bookworm | Region: 2025-11-24 22:02:22.134786 | debian-bookworm | Label: debian-bookworm 2025-11-24 22:02:22.134805 | debian-bookworm | Product Name: OpenStack Nova 2025-11-24 22:02:22.134825 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe94:dc83 2025-11-24 22:02:22.193018 | 2025-11-24 22:02:22.193380 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-24 22:02:23.098305 | debian-bookworm -> localhost | changed 2025-11-24 22:02:23.105917 | 2025-11-24 22:02:23.106049 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-24 22:02:24.865963 | debian-bookworm -> localhost | changed 2025-11-24 22:02:24.885632 | 2025-11-24 22:02:24.885743 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-24 22:02:25.331150 | debian-bookworm -> localhost | ok 2025-11-24 22:02:25.341089 | 2025-11-24 22:02:25.341200 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-24 22:02:25.386867 | debian-bookworm | ok 2025-11-24 22:02:25.427339 | debian-bookworm | included: /var/lib/zuul/builds/ddfbbf7b61fb486ba7abfc176d76daaa/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-24 22:02:25.433312 | 2025-11-24 22:02:25.433408 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-24 22:02:27.484883 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-24 22:02:27.485076 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ddfbbf7b61fb486ba7abfc176d76daaa/work/ddfbbf7b61fb486ba7abfc176d76daaa_id_rsa 2025-11-24 22:02:27.485112 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ddfbbf7b61fb486ba7abfc176d76daaa/work/ddfbbf7b61fb486ba7abfc176d76daaa_id_rsa.pub 2025-11-24 22:02:27.485138 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-24 22:02:27.485163 | debian-bookworm -> localhost | SHA256:3h6x4pR0xrNgtsmLdjxVVkDRdZ95zEpFGXTkk8I1l4I zuul-build-sshkey 2025-11-24 22:02:27.485186 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-24 22:02:27.485254 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-24 22:02:27.485281 | debian-bookworm -> localhost | | .=+.O%| 2025-11-24 22:02:27.485304 | debian-bookworm -> localhost | | E..+BX| 2025-11-24 22:02:27.485324 | debian-bookworm -> localhost | | +o=*| 2025-11-24 22:02:27.485345 | debian-bookworm -> localhost | | . o...o| 2025-11-24 22:02:27.485365 | debian-bookworm -> localhost | | S *o . | 2025-11-24 22:02:27.485386 | debian-bookworm -> localhost | | * O.= | 2025-11-24 22:02:27.485406 | debian-bookworm -> localhost | | .O.= | 2025-11-24 22:02:27.485426 | debian-bookworm -> localhost | | .+++ . | 2025-11-24 22:02:27.485447 | debian-bookworm -> localhost | | ...o.. | 2025-11-24 22:02:27.485467 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-24 22:02:27.485519 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.241097 2025-11-24 22:02:27.491745 | 2025-11-24 22:02:27.491838 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-24 22:02:27.529275 | debian-bookworm | ok 2025-11-24 22:02:27.538034 | debian-bookworm | included: /var/lib/zuul/builds/ddfbbf7b61fb486ba7abfc176d76daaa/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-24 22:02:27.563680 | 2025-11-24 22:02:27.563765 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-24 22:02:27.586686 | debian-bookworm | skipping: Conditional result was False 2025-11-24 22:02:27.592292 | 2025-11-24 22:02:27.592377 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-24 22:02:28.396736 | debian-bookworm | changed 2025-11-24 22:02:28.401929 | 2025-11-24 22:02:28.402015 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-24 22:02:28.709172 | debian-bookworm | ok 2025-11-24 22:02:28.716810 | 2025-11-24 22:02:28.716902 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-24 22:02:29.422353 | debian-bookworm | changed 2025-11-24 22:02:29.442367 | 2025-11-24 22:02:29.442515 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-24 22:02:30.148835 | debian-bookworm | changed 2025-11-24 22:02:30.165395 | 2025-11-24 22:02:30.165548 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-24 22:02:30.190198 | debian-bookworm | skipping: Conditional result was False 2025-11-24 22:02:30.198681 | 2025-11-24 22:02:30.198897 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-24 22:02:30.715482 | debian-bookworm -> localhost | changed 2025-11-24 22:02:30.730504 | 2025-11-24 22:02:30.730648 | TASK [add-build-sshkey : Add back temp key] 2025-11-24 22:02:31.232261 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ddfbbf7b61fb486ba7abfc176d76daaa/work/ddfbbf7b61fb486ba7abfc176d76daaa_id_rsa (zuul-build-sshkey) 2025-11-24 22:02:31.232523 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032981 2025-11-24 22:02:31.241565 | 2025-11-24 22:02:31.241696 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-24 22:02:31.673657 | debian-bookworm | ok 2025-11-24 22:02:31.683947 | 2025-11-24 22:02:31.684133 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-24 22:02:31.723060 | debian-bookworm | skipping: Conditional result was False 2025-11-24 22:02:31.735807 | 2025-11-24 22:02:31.735933 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-24 22:02:32.245564 | debian-bookworm | ok 2025-11-24 22:02:32.269018 | 2025-11-24 22:02:32.269168 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-24 22:02:32.323776 | debian-bookworm | ok 2025-11-24 22:02:32.329942 | 2025-11-24 22:02:32.330064 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-24 22:02:32.833207 | debian-bookworm -> localhost | ok 2025-11-24 22:02:32.840069 | 2025-11-24 22:02:32.840198 | TASK [validate-host : Collect information about the host] 2025-11-24 22:02:34.055521 | debian-bookworm | ok 2025-11-24 22:02:34.083213 | 2025-11-24 22:02:34.083398 | TASK [validate-host : Sanitize hostname] 2025-11-24 22:02:34.199477 | debian-bookworm | ok 2025-11-24 22:02:34.247158 | 2025-11-24 22:02:34.247333 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-24 22:02:35.103995 | debian-bookworm -> localhost | changed 2025-11-24 22:02:35.110113 | 2025-11-24 22:02:35.110254 | TASK [validate-host : Collect information about zuul worker] 2025-11-24 22:02:35.549277 | debian-bookworm | ok 2025-11-24 22:02:35.554263 | 2025-11-24 22:02:35.554389 | TASK [validate-host : Write out all zuul information for each host] 2025-11-24 22:02:36.337276 | debian-bookworm -> localhost | changed 2025-11-24 22:02:36.351713 | 2025-11-24 22:02:36.351844 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-24 22:02:36.633791 | debian-bookworm | ok 2025-11-24 22:02:36.639965 | 2025-11-24 22:02:36.640098 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-24 22:02:37.880478 | debian-bookworm | changed: 2025-11-24 22:02:37.880751 | debian-bookworm | cd+++++++++ src/ 2025-11-24 22:02:37.880799 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-24 22:02:37.880825 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-24 22:02:37.880847 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-11-24 22:02:37.880867 | debian-bookworm | Containerfile 2025-11-24 22:02:37.880979 | debian-bookworm | Containerfile 2025-11-24 22:02:37.914602 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008464 2025-11-24 22:03:05.810193 | 2025-11-24 22:03:05.810391 | TASK [upload-logs : Upload logs to log server] 2025-11-24 22:03:06.418454 | localhost | Output suppressed because no_log was given 2025-11-24 22:03:06.423203 | 2025-11-24 22:03:06.423420 | LOOP [upload-logs : Compress console log and json output] 2025-11-24 22:03:06.490777 | localhost | skipping: Conditional result was False 2025-11-24 22:03:06.498216 | localhost | skipping: Conditional result was False 2025-11-24 22:03:06.507959 | 2025-11-24 22:03:06.508182 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-24 22:03:06.556642 | localhost | skipping: Conditional result was False 2025-11-24 22:03:06.557479 | 2025-11-24 22:03:06.560796 | localhost | skipping: Conditional result was False 2025-11-24 22:03:06.573093 | 2025-11-24 22:03:06.573343 | LOOP [upload-logs : Upload console log and json output]