2025-09-10 02:55:06.125540 | Job console starting 2025-09-10 02:55:06.153282 | Updating git repos 2025-09-10 02:55:06.195965 | Cloning repos into workspace 2025-09-10 02:55:06.260493 | Restoring repo states 2025-09-10 02:55:06.269439 | Merging changes 2025-09-10 02:55:06.853724 | Checking out repos 2025-09-10 02:55:06.926035 | Preparing playbooks 2025-09-10 02:55:08.520244 | Running Ansible setup 2025-09-10 02:55:14.797400 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-10 02:55:15.487916 | 2025-09-10 02:55:15.488041 | PLAY [Base pre] 2025-09-10 02:55:15.520830 | 2025-09-10 02:55:15.520942 | TASK [Setup log path fact] 2025-09-10 02:55:15.592787 | debian-bookworm | ok 2025-09-10 02:55:15.622508 | 2025-09-10 02:55:15.622654 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-10 02:55:15.670165 | debian-bookworm | ok 2025-09-10 02:55:15.693418 | 2025-09-10 02:55:15.693533 | TASK [emit-job-header : Print job information] 2025-09-10 02:55:15.772945 | # Job Information 2025-09-10 02:55:15.773129 | Ansible Version: 2.16.14 2025-09-10 02:55:15.773163 | Job: python-black 2025-09-10 02:55:15.773196 | Pipeline: check 2025-09-10 02:55:15.773219 | Executor: 521e9411259a 2025-09-10 02:55:15.773240 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/776 2025-09-10 02:55:15.773262 | Event ID: 891b7c40-8df1-11f0-9ab9-a00a1f25549a 2025-09-10 02:55:15.778044 | 2025-09-10 02:55:15.778137 | LOOP [emit-job-header : Print node information] 2025-09-10 02:55:15.978650 | debian-bookworm | ok: 2025-09-10 02:55:15.978870 | debian-bookworm | # Node Information 2025-09-10 02:55:15.978912 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-10 02:55:15.978942 | debian-bookworm | Hostname: debian 2025-09-10 02:55:15.978969 | debian-bookworm | Username: zuul 2025-09-10 02:55:15.978994 | debian-bookworm | Distro: Debian 12.12 2025-09-10 02:55:15.979024 | debian-bookworm | Provider: regiocloud-a 2025-09-10 02:55:15.979051 | debian-bookworm | Region: 2025-09-10 02:55:15.979077 | debian-bookworm | Label: debian-bookworm 2025-09-10 02:55:15.979102 | debian-bookworm | Product Name: OpenStack Nova 2025-09-10 02:55:15.979127 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe92:4bf8 2025-09-10 02:55:15.988886 | 2025-09-10 02:55:15.988996 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-10 02:55:17.203187 | debian-bookworm -> localhost | changed 2025-09-10 02:55:17.209319 | 2025-09-10 02:55:17.209408 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-10 02:55:19.248612 | debian-bookworm -> localhost | changed 2025-09-10 02:55:19.257684 | 2025-09-10 02:55:19.258094 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-10 02:55:19.725379 | debian-bookworm -> localhost | ok 2025-09-10 02:55:19.730613 | 2025-09-10 02:55:19.730708 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-10 02:55:19.758774 | debian-bookworm | ok 2025-09-10 02:55:19.782491 | debian-bookworm | included: /var/lib/zuul/builds/4ce49fae763142709cca818a77b5a381/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-10 02:55:19.794690 | 2025-09-10 02:55:19.794773 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-10 02:55:22.464565 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-10 02:55:22.464762 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4ce49fae763142709cca818a77b5a381/work/4ce49fae763142709cca818a77b5a381_id_rsa 2025-09-10 02:55:22.464800 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4ce49fae763142709cca818a77b5a381/work/4ce49fae763142709cca818a77b5a381_id_rsa.pub 2025-09-10 02:55:22.464825 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-10 02:55:22.464850 | debian-bookworm -> localhost | SHA256:NNLCbTQ42rUtxbSFqX5UFuWZpmrcz7yoM939EnBPRhE zuul-build-sshkey 2025-09-10 02:55:22.464871 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-10 02:55:22.464901 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-10 02:55:22.464923 | debian-bookworm -> localhost | | .oo.ooo.Eo| 2025-09-10 02:55:22.464944 | debian-bookworm -> localhost | | .o+..=oo. o.| 2025-09-10 02:55:22.464964 | debian-bookworm -> localhost | | o+o*=.o =. | 2025-09-10 02:55:22.464984 | debian-bookworm -> localhost | | . .=+.o .o. o| 2025-09-10 02:55:22.465003 | debian-bookworm -> localhost | | .So .o + | 2025-09-10 02:55:22.465029 | debian-bookworm -> localhost | | ...o . .| 2025-09-10 02:55:22.465049 | debian-bookworm -> localhost | | .+... o | 2025-09-10 02:55:22.465068 | debian-bookworm -> localhost | | .o .=o .| 2025-09-10 02:55:22.465088 | debian-bookworm -> localhost | | .+. =oo| 2025-09-10 02:55:22.465108 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-10 02:55:22.465159 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.861241 2025-09-10 02:55:22.471189 | 2025-09-10 02:55:22.471275 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-10 02:55:22.499652 | debian-bookworm | ok 2025-09-10 02:55:22.510227 | debian-bookworm | included: /var/lib/zuul/builds/4ce49fae763142709cca818a77b5a381/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-10 02:55:22.539186 | 2025-09-10 02:55:22.539266 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-10 02:55:22.571966 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:55:22.577517 | 2025-09-10 02:55:22.577602 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-10 02:55:23.349934 | debian-bookworm | changed 2025-09-10 02:55:23.355081 | 2025-09-10 02:55:23.355162 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-10 02:55:23.621172 | debian-bookworm | ok 2025-09-10 02:55:23.625754 | 2025-09-10 02:55:23.625833 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-10 02:55:24.313070 | debian-bookworm | changed 2025-09-10 02:55:24.324128 | 2025-09-10 02:55:24.324296 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-10 02:55:24.954862 | debian-bookworm | changed 2025-09-10 02:55:24.960674 | 2025-09-10 02:55:24.960762 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-10 02:55:24.984269 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:55:24.990032 | 2025-09-10 02:55:24.990109 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-10 02:55:25.391441 | debian-bookworm -> localhost | changed 2025-09-10 02:55:25.402921 | 2025-09-10 02:55:25.403062 | TASK [add-build-sshkey : Add back temp key] 2025-09-10 02:55:25.731193 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4ce49fae763142709cca818a77b5a381/work/4ce49fae763142709cca818a77b5a381_id_rsa (zuul-build-sshkey) 2025-09-10 02:55:25.731363 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026531 2025-09-10 02:55:25.737908 | 2025-09-10 02:55:25.737980 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-10 02:55:26.145609 | debian-bookworm | ok 2025-09-10 02:55:26.151450 | 2025-09-10 02:55:26.151564 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-10 02:55:26.179587 | debian-bookworm | skipping: Conditional result was False 2025-09-10 02:55:26.189889 | 2025-09-10 02:55:26.189980 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-10 02:55:26.725221 | debian-bookworm | ok 2025-09-10 02:55:26.741741 | 2025-09-10 02:55:26.741841 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-10 02:55:26.781263 | debian-bookworm | ok 2025-09-10 02:55:26.786602 | 2025-09-10 02:55:26.786691 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-10 02:55:27.443290 | debian-bookworm -> localhost | ok 2025-09-10 02:55:27.449359 | 2025-09-10 02:55:27.449487 | TASK [validate-host : Collect information about the host] 2025-09-10 02:55:28.577114 | debian-bookworm | ok 2025-09-10 02:55:28.595090 | 2025-09-10 02:55:28.595190 | TASK [validate-host : Sanitize hostname] 2025-09-10 02:55:28.753795 | debian-bookworm | ok 2025-09-10 02:55:28.824697 | 2025-09-10 02:55:28.824798 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-10 02:55:29.768502 | debian-bookworm -> localhost | changed 2025-09-10 02:55:29.774291 | 2025-09-10 02:55:29.774385 | TASK [validate-host : Collect information about zuul worker] 2025-09-10 02:55:30.164825 | debian-bookworm | ok 2025-09-10 02:55:30.169277 | 2025-09-10 02:55:30.169371 | TASK [validate-host : Write out all zuul information for each host] 2025-09-10 02:55:31.135826 | debian-bookworm -> localhost | changed 2025-09-10 02:55:31.152556 | 2025-09-10 02:55:31.152659 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-10 02:55:31.436528 | debian-bookworm | ok 2025-09-10 02:55:31.441610 | 2025-09-10 02:55:31.441699 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-10 02:55:32.560965 | debian-bookworm | changed: 2025-09-10 02:55:32.561135 | debian-bookworm | cd+++++++++ src/ 2025-09-10 02:55:32.561169 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-10 02:55:32.561193 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-10 02:55:32.561215 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-09-10 02:55:32.561236 | debian-bookworm | Containerfile 2025-09-10 02:55:32.561366 | debian-bookworm | localhost | ok: Runtime: 0:00:00.016199 2025-09-10 02:55:58.575304 | 2025-09-10 02:55:58.575424 | TASK [upload-logs : Upload logs to log server] 2025-09-10 02:55:59.104011 | localhost | Output suppressed because no_log was given 2025-09-10 02:55:59.106135 | 2025-09-10 02:55:59.106246 | LOOP [upload-logs : Compress console log and json output] 2025-09-10 02:55:59.157331 | localhost | skipping: Conditional result was False 2025-09-10 02:55:59.164415 | localhost | skipping: Conditional result was False 2025-09-10 02:55:59.173114 | 2025-09-10 02:55:59.173241 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-10 02:55:59.221942 | localhost | skipping: Conditional result was False 2025-09-10 02:55:59.222232 | 2025-09-10 02:55:59.227769 | localhost | skipping: Conditional result was False 2025-09-10 02:55:59.241742 | 2025-09-10 02:55:59.241940 | LOOP [upload-logs : Upload console log and json output]