2025-05-22 16:44:08.702395 | Job console starting 2025-05-22 16:44:08.719766 | Updating git repos 2025-05-22 16:44:08.756702 | Cloning repos into workspace 2025-05-22 16:44:08.820896 | Restoring repo states 2025-05-22 16:44:08.829045 | Merging changes 2025-05-22 16:44:09.287738 | Checking out repos 2025-05-22 16:44:09.327423 | Preparing playbooks 2025-05-22 16:44:10.104800 | Running Ansible setup 2025-05-22 16:44:15.390307 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-22 16:44:16.213054 | 2025-05-22 16:44:16.213250 | PLAY [Base pre] 2025-05-22 16:44:16.229552 | 2025-05-22 16:44:16.229707 | TASK [Setup log path fact] 2025-05-22 16:44:16.255826 | debian-bookworm | ok 2025-05-22 16:44:16.275646 | 2025-05-22 16:44:16.275814 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-22 16:44:16.306058 | debian-bookworm | ok 2025-05-22 16:44:16.317865 | 2025-05-22 16:44:16.318053 | TASK [emit-job-header : Print job information] 2025-05-22 16:44:16.369726 | # Job Information 2025-05-22 16:44:16.369916 | Ansible Version: 2.16.14 2025-05-22 16:44:16.369952 | Job: python-black 2025-05-22 16:44:16.369985 | Pipeline: check 2025-05-22 16:44:16.370009 | Executor: 521e9411259a 2025-05-22 16:44:16.370030 | Triggered by: https://github.com/osism/testbed/pull/2654 2025-05-22 16:44:16.370053 | Event ID: f5f01a00-372b-11f0-99fe-c59de95fe1bb 2025-05-22 16:44:16.375739 | 2025-05-22 16:44:16.375868 | LOOP [emit-job-header : Print node information] 2025-05-22 16:44:16.542616 | debian-bookworm | ok: 2025-05-22 16:44:16.542952 | debian-bookworm | # Node Information 2025-05-22 16:44:16.542997 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-22 16:44:16.543024 | debian-bookworm | Hostname: debian 2025-05-22 16:44:16.543046 | debian-bookworm | Username: zuul 2025-05-22 16:44:16.543068 | debian-bookworm | Distro: Debian 12.11 2025-05-22 16:44:16.543098 | debian-bookworm | Provider: regiocloud-a 2025-05-22 16:44:16.543124 | debian-bookworm | Region: 2025-05-22 16:44:16.543145 | debian-bookworm | Label: debian-bookworm 2025-05-22 16:44:16.543165 | debian-bookworm | Product Name: OpenStack Nova 2025-05-22 16:44:16.543200 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe60:9de4 2025-05-22 16:44:16.563635 | 2025-05-22 16:44:16.563777 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-22 16:44:17.105647 | debian-bookworm -> localhost | changed 2025-05-22 16:44:17.127368 | 2025-05-22 16:44:17.127580 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-22 16:44:18.349223 | debian-bookworm -> localhost | changed 2025-05-22 16:44:18.363072 | 2025-05-22 16:44:18.363226 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-22 16:44:18.723732 | debian-bookworm -> localhost | ok 2025-05-22 16:44:18.730260 | 2025-05-22 16:44:18.730388 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-22 16:44:18.759155 | debian-bookworm | ok 2025-05-22 16:44:18.777220 | debian-bookworm | included: /var/lib/zuul/builds/3f51a2cb511942d394805c65a9d652da/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-22 16:44:18.785347 | 2025-05-22 16:44:18.785459 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-22 16:44:19.840315 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-22 16:44:19.840581 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3f51a2cb511942d394805c65a9d652da/work/3f51a2cb511942d394805c65a9d652da_id_rsa 2025-05-22 16:44:19.840623 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3f51a2cb511942d394805c65a9d652da/work/3f51a2cb511942d394805c65a9d652da_id_rsa.pub 2025-05-22 16:44:19.840650 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-22 16:44:19.840677 | debian-bookworm -> localhost | SHA256:bQd83BEantVJ0FrxvTwMybYuhK9SNnFbaOgI7wE05Gc zuul-build-sshkey 2025-05-22 16:44:19.840701 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-22 16:44:19.840739 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-22 16:44:19.840761 | debian-bookworm -> localhost | | .. ..B=o| 2025-05-22 16:44:19.840783 | debian-bookworm -> localhost | | .o . o.*.=+| 2025-05-22 16:44:19.840804 | debian-bookworm -> localhost | | ...E + B=+ o| 2025-05-22 16:44:19.840824 | debian-bookworm -> localhost | | oo +.*.o= .| 2025-05-22 16:44:19.840845 | debian-bookworm -> localhost | | + S.*.+. = | 2025-05-22 16:44:19.840870 | debian-bookworm -> localhost | | + *oo. .| 2025-05-22 16:44:19.840891 | debian-bookworm -> localhost | | . + .o . | 2025-05-22 16:44:19.840910 | debian-bookworm -> localhost | | o . . | 2025-05-22 16:44:19.840930 | debian-bookworm -> localhost | | .. | 2025-05-22 16:44:19.840951 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-22 16:44:19.841003 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.521596 2025-05-22 16:44:19.847696 | 2025-05-22 16:44:19.847808 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-22 16:44:19.876773 | debian-bookworm | ok 2025-05-22 16:44:19.886099 | debian-bookworm | included: /var/lib/zuul/builds/3f51a2cb511942d394805c65a9d652da/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-22 16:44:19.895007 | 2025-05-22 16:44:19.895103 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-22 16:44:19.919222 | debian-bookworm | skipping: Conditional result was False 2025-05-22 16:44:19.924955 | 2025-05-22 16:44:19.925055 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-22 16:44:20.561923 | debian-bookworm | changed 2025-05-22 16:44:20.573796 | 2025-05-22 16:44:20.574019 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-22 16:44:20.829299 | debian-bookworm | ok 2025-05-22 16:44:20.835435 | 2025-05-22 16:44:20.835585 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-22 16:44:21.528726 | debian-bookworm | changed 2025-05-22 16:44:21.538658 | 2025-05-22 16:44:21.538801 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-22 16:44:22.227993 | debian-bookworm | changed 2025-05-22 16:44:22.236073 | 2025-05-22 16:44:22.236260 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-22 16:44:22.262311 | debian-bookworm | skipping: Conditional result was False 2025-05-22 16:44:22.269738 | 2025-05-22 16:44:22.269903 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-22 16:44:22.776786 | debian-bookworm -> localhost | changed 2025-05-22 16:44:22.788029 | 2025-05-22 16:44:22.788157 | TASK [add-build-sshkey : Add back temp key] 2025-05-22 16:44:23.178419 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3f51a2cb511942d394805c65a9d652da/work/3f51a2cb511942d394805c65a9d652da_id_rsa (zuul-build-sshkey) 2025-05-22 16:44:23.178722 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019160 2025-05-22 16:44:23.187998 | 2025-05-22 16:44:23.188138 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-22 16:44:23.605391 | debian-bookworm | ok 2025-05-22 16:44:23.613363 | 2025-05-22 16:44:23.613495 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-22 16:44:23.637829 | debian-bookworm | skipping: Conditional result was False 2025-05-22 16:44:23.648764 | 2025-05-22 16:44:23.648887 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-22 16:44:24.108732 | debian-bookworm | ok 2025-05-22 16:44:24.128512 | 2025-05-22 16:44:24.128658 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-22 16:44:24.177146 | debian-bookworm | ok 2025-05-22 16:44:24.191082 | 2025-05-22 16:44:24.191353 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-22 16:44:24.513225 | debian-bookworm -> localhost | ok 2025-05-22 16:44:24.521069 | 2025-05-22 16:44:24.521210 | TASK [validate-host : Collect information about the host] 2025-05-22 16:44:25.709828 | debian-bookworm | ok 2025-05-22 16:44:25.724716 | 2025-05-22 16:44:25.724856 | TASK [validate-host : Sanitize hostname] 2025-05-22 16:44:25.855240 | debian-bookworm | ok 2025-05-22 16:44:25.927376 | 2025-05-22 16:44:25.927617 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-22 16:44:26.595163 | debian-bookworm -> localhost | changed 2025-05-22 16:44:26.612784 | 2025-05-22 16:44:26.613994 | TASK [validate-host : Collect information about zuul worker] 2025-05-22 16:44:27.115467 | debian-bookworm | ok 2025-05-22 16:44:27.120842 | 2025-05-22 16:44:27.120971 | TASK [validate-host : Write out all zuul information for each host] 2025-05-22 16:44:27.941931 | debian-bookworm -> localhost | changed 2025-05-22 16:44:27.958151 | 2025-05-22 16:44:27.958719 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-22 16:44:28.261825 | debian-bookworm | ok 2025-05-22 16:44:28.271145 | 2025-05-22 16:44:28.271459 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-22 16:44:29.906242 | debian-bookworm | changed: 2025-05-22 16:44:29.906584 | debian-bookworm | cd+++++++++ src/ 2025-05-22 16:44:29.906630 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-22 16:44:29.906655 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-22 16:44:29.906678 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-05-22 16:44:29.906699 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004829 2025-05-22 16:44:56.106505 | 2025-05-22 16:44:56.106635 | TASK [upload-logs : Upload logs to log server] 2025-05-22 16:44:56.765613 | localhost | Output suppressed because no_log was given 2025-05-22 16:44:56.769634 | 2025-05-22 16:44:56.769790 | LOOP [upload-logs : Compress console log and json output] 2025-05-22 16:44:56.825471 | localhost | skipping: Conditional result was False 2025-05-22 16:44:56.833638 | localhost | skipping: Conditional result was False 2025-05-22 16:44:56.842380 | 2025-05-22 16:44:56.842546 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-22 16:44:56.933958 | localhost | skipping: Conditional result was False 2025-05-22 16:44:56.934278 | 2025-05-22 16:44:56.943842 | localhost | skipping: Conditional result was False 2025-05-22 16:44:56.952941 | 2025-05-22 16:44:56.953116 | LOOP [upload-logs : Upload console log and json output]