2025-05-20 23:55:33.129190 | Job console starting 2025-05-20 23:55:33.138932 | Updating git repos 2025-05-20 23:55:33.508874 | Cloning repos into workspace 2025-05-20 23:55:33.575855 | Restoring repo states 2025-05-20 23:55:33.589084 | Merging changes 2025-05-20 23:55:34.166972 | Checking out repos 2025-05-20 23:55:34.224251 | Preparing playbooks 2025-05-20 23:55:35.270133 | Running Ansible setup 2025-05-20 23:55:41.197277 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-20 23:55:44.128830 | 2025-05-20 23:55:44.129025 | PLAY [Base pre] 2025-05-20 23:55:44.186608 | 2025-05-20 23:55:44.186825 | TASK [Setup log path fact] 2025-05-20 23:55:44.226599 | debian-bookworm | ok 2025-05-20 23:55:44.295680 | 2025-05-20 23:55:44.295883 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-20 23:55:44.339524 | debian-bookworm | ok 2025-05-20 23:55:44.354381 | 2025-05-20 23:55:44.354522 | TASK [emit-job-header : Print job information] 2025-05-20 23:55:44.460718 | # Job Information 2025-05-20 23:55:44.461030 | Ansible Version: 2.16.14 2025-05-20 23:55:44.461075 | Job: python-black 2025-05-20 23:55:44.461140 | Pipeline: check 2025-05-20 23:55:44.461219 | Executor: 521e9411259a 2025-05-20 23:55:44.461245 | Triggered by: https://github.com/osism/testbed/pull/2699 2025-05-20 23:55:44.461271 | Event ID: e5fe9ba0-35d5-11f0-8f94-d5d58781e3a6 2025-05-20 23:55:44.471736 | 2025-05-20 23:55:44.472537 | LOOP [emit-job-header : Print node information] 2025-05-20 23:55:44.705136 | debian-bookworm | ok: 2025-05-20 23:55:44.705440 | debian-bookworm | # Node Information 2025-05-20 23:55:44.705494 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-20 23:55:44.705532 | debian-bookworm | Hostname: debian 2025-05-20 23:55:44.705562 | debian-bookworm | Username: zuul 2025-05-20 23:55:44.705590 | debian-bookworm | Distro: Debian 12.11 2025-05-20 23:55:44.705623 | debian-bookworm | Provider: regiocloud-a 2025-05-20 23:55:44.705672 | debian-bookworm | Region: 2025-05-20 23:55:44.705700 | debian-bookworm | Label: debian-bookworm 2025-05-20 23:55:44.705727 | debian-bookworm | Product Name: OpenStack Nova 2025-05-20 23:55:44.706973 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7f:d60d 2025-05-20 23:55:44.751012 | 2025-05-20 23:55:44.751336 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-20 23:55:46.195377 | debian-bookworm -> localhost | changed 2025-05-20 23:55:46.203101 | 2025-05-20 23:55:46.203240 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-20 23:55:49.523381 | debian-bookworm -> localhost | changed 2025-05-20 23:55:49.540732 | 2025-05-20 23:55:49.540885 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-20 23:55:50.525253 | debian-bookworm -> localhost | ok 2025-05-20 23:55:50.534441 | 2025-05-20 23:55:50.534721 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-20 23:55:50.569222 | debian-bookworm | ok 2025-05-20 23:55:50.603370 | debian-bookworm | included: /var/lib/zuul/builds/c011a2ff065c48e4b82ca460f580e995/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-20 23:55:50.613764 | 2025-05-20 23:55:50.613902 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-20 23:55:54.540595 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-20 23:55:54.540817 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c011a2ff065c48e4b82ca460f580e995/work/c011a2ff065c48e4b82ca460f580e995_id_rsa 2025-05-20 23:55:54.540856 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c011a2ff065c48e4b82ca460f580e995/work/c011a2ff065c48e4b82ca460f580e995_id_rsa.pub 2025-05-20 23:55:54.540882 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-20 23:55:54.540907 | debian-bookworm -> localhost | SHA256:RZS93jr+t99WhRZdZ1MaambigJEjh/bu6MwbIx4U60c zuul-build-sshkey 2025-05-20 23:55:54.540929 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-20 23:55:54.540960 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-20 23:55:54.540982 | debian-bookworm -> localhost | | ... .oo .oB| 2025-05-20 23:55:54.541003 | debian-bookworm -> localhost | | + +o .. ...++| 2025-05-20 23:55:54.541024 | debian-bookworm -> localhost | | .. +... o =..o | 2025-05-20 23:55:54.541044 | debian-bookworm -> localhost | | o . + =. o .| 2025-05-20 23:55:54.541065 | debian-bookworm -> localhost | | o E. S .. o .| 2025-05-20 23:55:54.541087 | debian-bookworm -> localhost | | o . . . . .| 2025-05-20 23:55:54.541108 | debian-bookworm -> localhost | | + +o . .| 2025-05-20 23:55:54.541128 | debian-bookworm -> localhost | | . *.o. o +| 2025-05-20 23:55:54.541148 | debian-bookworm -> localhost | | ..=. ..o.+=| 2025-05-20 23:55:54.541169 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-20 23:55:54.541221 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.198740 2025-05-20 23:55:54.547218 | 2025-05-20 23:55:54.547304 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-20 23:55:54.574467 | debian-bookworm | ok 2025-05-20 23:55:54.583447 | debian-bookworm | included: /var/lib/zuul/builds/c011a2ff065c48e4b82ca460f580e995/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-20 23:55:54.593906 | 2025-05-20 23:55:54.593985 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-20 23:55:54.607110 | debian-bookworm | skipping: Conditional result was False 2025-05-20 23:55:54.611847 | 2025-05-20 23:55:54.611923 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-20 23:55:55.225517 | debian-bookworm | changed 2025-05-20 23:55:55.233858 | 2025-05-20 23:55:55.233950 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-20 23:55:55.528410 | debian-bookworm | ok 2025-05-20 23:55:55.533167 | 2025-05-20 23:55:55.533247 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-20 23:55:56.200494 | debian-bookworm | changed 2025-05-20 23:55:56.205890 | 2025-05-20 23:55:56.205976 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-20 23:55:56.922780 | debian-bookworm | changed 2025-05-20 23:55:56.927218 | 2025-05-20 23:55:56.927294 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-20 23:55:56.971553 | debian-bookworm | skipping: Conditional result was False 2025-05-20 23:55:56.977304 | 2025-05-20 23:55:56.977398 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-20 23:55:58.032877 | debian-bookworm -> localhost | changed 2025-05-20 23:55:58.046948 | 2025-05-20 23:55:58.048890 | TASK [add-build-sshkey : Add back temp key] 2025-05-20 23:55:58.493842 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c011a2ff065c48e4b82ca460f580e995/work/c011a2ff065c48e4b82ca460f580e995_id_rsa (zuul-build-sshkey) 2025-05-20 23:55:58.494037 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011182 2025-05-20 23:55:58.500321 | 2025-05-20 23:55:58.500407 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-20 23:55:58.912854 | debian-bookworm | ok 2025-05-20 23:55:58.916955 | 2025-05-20 23:55:58.917033 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-20 23:55:58.954877 | debian-bookworm | skipping: Conditional result was False 2025-05-20 23:55:58.963282 | 2025-05-20 23:55:58.963364 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-20 23:55:59.426240 | debian-bookworm | ok 2025-05-20 23:55:59.439488 | 2025-05-20 23:55:59.439596 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-20 23:55:59.466564 | debian-bookworm | ok 2025-05-20 23:55:59.471059 | 2025-05-20 23:55:59.471131 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-20 23:55:59.766290 | debian-bookworm -> localhost | ok 2025-05-20 23:55:59.771354 | 2025-05-20 23:55:59.771432 | TASK [validate-host : Collect information about the host] 2025-05-20 23:56:00.855691 | debian-bookworm | ok 2025-05-20 23:56:00.873647 | 2025-05-20 23:56:00.873753 | TASK [validate-host : Sanitize hostname] 2025-05-20 23:56:01.048399 | debian-bookworm | ok 2025-05-20 23:56:01.110277 | 2025-05-20 23:56:01.110389 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-20 23:56:02.160653 | debian-bookworm -> localhost | changed 2025-05-20 23:56:02.166717 | 2025-05-20 23:56:02.166897 | TASK [validate-host : Collect information about zuul worker] 2025-05-20 23:56:02.815970 | debian-bookworm | ok 2025-05-20 23:56:02.825117 | 2025-05-20 23:56:02.825242 | TASK [validate-host : Write out all zuul information for each host] 2025-05-20 23:56:03.623189 | debian-bookworm -> localhost | changed 2025-05-20 23:56:03.652384 | 2025-05-20 23:56:03.652527 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-20 23:56:03.934899 | debian-bookworm | ok 2025-05-20 23:56:03.940848 | 2025-05-20 23:56:03.940972 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-20 23:56:05.465390 | debian-bookworm | changed: 2025-05-20 23:56:05.465646 | debian-bookworm | cd+++++++++ src/ 2025-05-20 23:56:05.465689 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-20 23:56:05.465713 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-20 23:56:05.465735 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-05-20 23:56:05.465755 | debian-bookworm | localhost | ok: Runtime: 0:00:00.015937 2025-05-20 23:56:34.028035 | 2025-05-20 23:56:34.028155 | TASK [upload-logs : Upload logs to log server] 2025-05-20 23:56:34.979402 | localhost | Output suppressed because no_log was given 2025-05-20 23:56:34.982122 | 2025-05-20 23:56:34.982253 | LOOP [upload-logs : Compress console log and json output] 2025-05-20 23:56:35.060529 | localhost | skipping: Conditional result was False 2025-05-20 23:56:35.067520 | localhost | skipping: Conditional result was False 2025-05-20 23:56:35.080511 | 2025-05-20 23:56:35.080691 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-20 23:56:35.160132 | localhost | skipping: Conditional result was False 2025-05-20 23:56:35.160448 | 2025-05-20 23:56:35.177717 | localhost | skipping: Conditional result was False 2025-05-20 23:56:35.191559 | 2025-05-20 23:56:35.191732 | LOOP [upload-logs : Upload console log and json output]