2025-05-27 11:32:53.595188 | Job console starting 2025-05-27 11:32:53.628416 | Updating git repos 2025-05-27 11:32:53.671910 | Cloning repos into workspace 2025-05-27 11:32:53.743016 | Restoring repo states 2025-05-27 11:32:53.758193 | Merging changes 2025-05-27 11:32:54.270638 | Checking out repos 2025-05-27 11:32:54.320393 | Preparing playbooks 2025-05-27 11:32:55.132916 | Running Ansible setup 2025-05-27 11:32:59.739655 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-27 11:33:00.652207 | 2025-05-27 11:33:00.652379 | PLAY [Base pre] 2025-05-27 11:33:00.669353 | 2025-05-27 11:33:00.669510 | TASK [Setup log path fact] 2025-05-27 11:33:00.709608 | debian-bookworm | ok 2025-05-27 11:33:00.731899 | 2025-05-27 11:33:00.732073 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-27 11:33:00.782578 | debian-bookworm | ok 2025-05-27 11:33:00.797911 | 2025-05-27 11:33:00.798066 | TASK [emit-job-header : Print job information] 2025-05-27 11:33:00.839059 | # Job Information 2025-05-27 11:33:00.839252 | Ansible Version: 2.16.14 2025-05-27 11:33:00.839288 | Job: python-black 2025-05-27 11:33:00.839320 | Pipeline: check 2025-05-27 11:33:00.839342 | Executor: 521e9411259a 2025-05-27 11:33:00.839363 | Triggered by: https://github.com/osism/testbed/pull/2701 2025-05-27 11:33:00.839387 | Event ID: 4f0fd330-3aee-11f0-9e7e-a31146724ca1 2025-05-27 11:33:00.844428 | 2025-05-27 11:33:00.844542 | LOOP [emit-job-header : Print node information] 2025-05-27 11:33:00.952003 | debian-bookworm | ok: 2025-05-27 11:33:00.952277 | debian-bookworm | # Node Information 2025-05-27 11:33:00.952315 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-27 11:33:00.952340 | debian-bookworm | Hostname: debian 2025-05-27 11:33:00.952362 | debian-bookworm | Username: zuul 2025-05-27 11:33:00.952383 | debian-bookworm | Distro: Debian 12.11 2025-05-27 11:33:00.952405 | debian-bookworm | Provider: regiocloud-a 2025-05-27 11:33:00.952426 | debian-bookworm | Region: 2025-05-27 11:33:00.952447 | debian-bookworm | Label: debian-bookworm 2025-05-27 11:33:00.952466 | debian-bookworm | Product Name: OpenStack Nova 2025-05-27 11:33:00.952485 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec1:c07e 2025-05-27 11:33:00.971271 | 2025-05-27 11:33:00.971410 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-27 11:33:01.484300 | debian-bookworm -> localhost | changed 2025-05-27 11:33:01.492119 | 2025-05-27 11:33:01.492258 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-27 11:33:02.645828 | debian-bookworm -> localhost | changed 2025-05-27 11:33:02.660292 | 2025-05-27 11:33:02.660425 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-27 11:33:02.960242 | debian-bookworm -> localhost | ok 2025-05-27 11:33:02.969341 | 2025-05-27 11:33:02.969497 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-27 11:33:03.010320 | debian-bookworm | ok 2025-05-27 11:33:03.057252 | debian-bookworm | included: /var/lib/zuul/builds/54471d0cbfd4490f917e89751e8e02cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-27 11:33:03.069841 | 2025-05-27 11:33:03.069974 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-27 11:33:06.187535 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-27 11:33:06.188055 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/54471d0cbfd4490f917e89751e8e02cf/work/54471d0cbfd4490f917e89751e8e02cf_id_rsa 2025-05-27 11:33:06.188170 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/54471d0cbfd4490f917e89751e8e02cf/work/54471d0cbfd4490f917e89751e8e02cf_id_rsa.pub 2025-05-27 11:33:06.188250 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-27 11:33:06.188321 | debian-bookworm -> localhost | SHA256:asjNC4r42zIniGkWI4CXcvOj9JX/D6vumPDr7F0LKkA zuul-build-sshkey 2025-05-27 11:33:06.188386 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-27 11:33:06.188477 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-27 11:33:06.188545 | debian-bookworm -> localhost | | | 2025-05-27 11:33:06.188612 | debian-bookworm -> localhost | | | 2025-05-27 11:33:06.188674 | debian-bookworm -> localhost | |. . | 2025-05-27 11:33:06.188732 | debian-bookworm -> localhost | |+ E | 2025-05-27 11:33:06.188821 | debian-bookworm -> localhost | |.= o .S | 2025-05-27 11:33:06.188898 | debian-bookworm -> localhost | |.oo.o+o. | 2025-05-27 11:33:06.188957 | debian-bookworm -> localhost | |o+o+=o=.. o | 2025-05-27 11:33:06.189014 | debian-bookworm -> localhost | |=+=o+* *.o + | 2025-05-27 11:33:06.189074 | debian-bookworm -> localhost | |=.+*.+@+=o+.. | 2025-05-27 11:33:06.189131 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-27 11:33:06.189266 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.615035 2025-05-27 11:33:06.203465 | 2025-05-27 11:33:06.203644 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-27 11:33:06.236470 | debian-bookworm | ok 2025-05-27 11:33:06.247680 | debian-bookworm | included: /var/lib/zuul/builds/54471d0cbfd4490f917e89751e8e02cf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-27 11:33:06.256847 | 2025-05-27 11:33:06.256962 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-27 11:33:06.281017 | debian-bookworm | skipping: Conditional result was False 2025-05-27 11:33:06.289055 | 2025-05-27 11:33:06.289195 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-27 11:33:06.989493 | debian-bookworm | changed 2025-05-27 11:33:06.995207 | 2025-05-27 11:33:06.995328 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-27 11:33:07.274445 | debian-bookworm | ok 2025-05-27 11:33:07.280191 | 2025-05-27 11:33:07.280313 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-27 11:33:07.999243 | debian-bookworm | changed 2025-05-27 11:33:08.006491 | 2025-05-27 11:33:08.006612 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-27 11:33:08.779205 | debian-bookworm | changed 2025-05-27 11:33:08.785294 | 2025-05-27 11:33:08.785418 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-27 11:33:08.810119 | debian-bookworm | skipping: Conditional result was False 2025-05-27 11:33:08.816603 | 2025-05-27 11:33:08.816737 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-27 11:33:09.327027 | debian-bookworm -> localhost | changed 2025-05-27 11:33:09.339019 | 2025-05-27 11:33:09.339171 | TASK [add-build-sshkey : Add back temp key] 2025-05-27 11:33:09.698353 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/54471d0cbfd4490f917e89751e8e02cf/work/54471d0cbfd4490f917e89751e8e02cf_id_rsa (zuul-build-sshkey) 2025-05-27 11:33:09.698671 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019657 2025-05-27 11:33:09.707720 | 2025-05-27 11:33:09.707900 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-27 11:33:10.151807 | debian-bookworm | ok 2025-05-27 11:33:10.161677 | 2025-05-27 11:33:10.161882 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-27 11:33:10.189601 | debian-bookworm | skipping: Conditional result was False 2025-05-27 11:33:10.210685 | 2025-05-27 11:33:10.210907 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-27 11:33:10.719373 | debian-bookworm | ok 2025-05-27 11:33:10.744073 | 2025-05-27 11:33:10.744215 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-27 11:33:10.788702 | debian-bookworm | ok 2025-05-27 11:33:10.799619 | 2025-05-27 11:33:10.799956 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-27 11:33:11.149364 | debian-bookworm -> localhost | ok 2025-05-27 11:33:11.157024 | 2025-05-27 11:33:11.157175 | TASK [validate-host : Collect information about the host] 2025-05-27 11:33:12.327596 | debian-bookworm | ok 2025-05-27 11:33:12.337946 | 2025-05-27 11:33:12.338057 | TASK [validate-host : Sanitize hostname] 2025-05-27 11:33:12.461189 | debian-bookworm | ok 2025-05-27 11:33:12.560223 | 2025-05-27 11:33:12.560376 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-27 11:33:13.235728 | debian-bookworm -> localhost | changed 2025-05-27 11:33:13.242308 | 2025-05-27 11:33:13.242432 | TASK [validate-host : Collect information about zuul worker] 2025-05-27 11:33:13.741784 | debian-bookworm | ok 2025-05-27 11:33:13.747615 | 2025-05-27 11:33:13.747793 | TASK [validate-host : Write out all zuul information for each host] 2025-05-27 11:33:14.429192 | debian-bookworm -> localhost | changed 2025-05-27 11:33:14.441223 | 2025-05-27 11:33:14.441425 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-27 11:33:14.739219 | debian-bookworm | ok 2025-05-27 11:33:14.755165 | 2025-05-27 11:33:14.755315 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-27 11:33:15.965181 | debian-bookworm | changed: 2025-05-27 11:33:15.965421 | debian-bookworm | cd+++++++++ src/ 2025-05-27 11:33:15.965455 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-27 11:33:15.965480 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-27 11:33:15.965500 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-05-27 11:33:15.965521 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005973 2025-05-27 11:33:43.122798 | 2025-05-27 11:33:43.123150 | TASK [upload-logs : Upload logs to log server] 2025-05-27 11:33:43.746816 | localhost | Output suppressed because no_log was given 2025-05-27 11:33:43.749866 | 2025-05-27 11:33:43.750018 | LOOP [upload-logs : Compress console log and json output] 2025-05-27 11:33:43.812337 | localhost | skipping: Conditional result was False 2025-05-27 11:33:43.818045 | localhost | skipping: Conditional result was False 2025-05-27 11:33:43.832648 | 2025-05-27 11:33:43.832881 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-27 11:33:43.885671 | localhost | skipping: Conditional result was False 2025-05-27 11:33:43.886415 | 2025-05-27 11:33:43.890195 | localhost | skipping: Conditional result was False 2025-05-27 11:33:43.899860 | 2025-05-27 11:33:43.900016 | LOOP [upload-logs : Upload console log and json output]