2025-06-17 21:00:19.485954 | Job console starting 2025-06-17 21:00:19.507395 | Updating git repos 2025-06-17 21:00:19.557157 | Cloning repos into workspace 2025-06-17 21:00:19.638390 | Restoring repo states 2025-06-17 21:00:19.660821 | Merging changes 2025-06-17 21:00:20.263701 | Checking out repos 2025-06-17 21:00:20.355535 | Preparing playbooks 2025-06-17 21:00:21.796472 | Running Ansible setup 2025-06-17 21:00:29.036581 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-17 21:00:30.125827 | 2025-06-17 21:00:30.125944 | PLAY [Base pre] 2025-06-17 21:00:30.152083 | 2025-06-17 21:00:30.152189 | TASK [Setup log path fact] 2025-06-17 21:00:30.178973 | debian-bookworm | ok 2025-06-17 21:00:30.190648 | 2025-06-17 21:00:30.190756 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-17 21:00:30.250441 | debian-bookworm | ok 2025-06-17 21:00:30.258284 | 2025-06-17 21:00:30.258370 | TASK [emit-job-header : Print job information] 2025-06-17 21:00:30.315589 | # Job Information 2025-06-17 21:00:30.315784 | Ansible Version: 2.16.14 2025-06-17 21:00:30.315816 | Job: python-black 2025-06-17 21:00:30.315843 | Pipeline: check 2025-06-17 21:00:30.315862 | Executor: 521e9411259a 2025-06-17 21:00:30.315879 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/760 2025-06-17 21:00:30.315897 | Event ID: 0e9a2d60-4bbe-11f0-9cd8-969ca9f90d1c 2025-06-17 21:00:30.320016 | 2025-06-17 21:00:30.320107 | LOOP [emit-job-header : Print node information] 2025-06-17 21:00:30.439048 | debian-bookworm | ok: 2025-06-17 21:00:30.439262 | debian-bookworm | # Node Information 2025-06-17 21:00:30.439295 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-17 21:00:30.439316 | debian-bookworm | Hostname: debian 2025-06-17 21:00:30.439334 | debian-bookworm | Username: zuul 2025-06-17 21:00:30.439351 | debian-bookworm | Distro: Debian 12.11 2025-06-17 21:00:30.439373 | debian-bookworm | Provider: regiocloud-a 2025-06-17 21:00:30.439391 | debian-bookworm | Region: 2025-06-17 21:00:30.439409 | debian-bookworm | Label: debian-bookworm 2025-06-17 21:00:30.439425 | debian-bookworm | Product Name: OpenStack Nova 2025-06-17 21:00:30.439441 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe15:5e 2025-06-17 21:00:30.465018 | 2025-06-17 21:00:30.465133 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-17 21:00:31.438306 | debian-bookworm -> localhost | changed 2025-06-17 21:00:31.445123 | 2025-06-17 21:00:31.445235 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-17 21:00:33.237976 | debian-bookworm -> localhost | changed 2025-06-17 21:00:33.250370 | 2025-06-17 21:00:33.250467 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-17 21:00:33.949057 | debian-bookworm -> localhost | ok 2025-06-17 21:00:33.955333 | 2025-06-17 21:00:33.955446 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-17 21:00:34.025351 | debian-bookworm | ok 2025-06-17 21:00:34.067100 | debian-bookworm | included: /var/lib/zuul/builds/fb0ec05ba5f0462a9ef6053c672dbf33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-17 21:00:34.078967 | 2025-06-17 21:00:34.079073 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-17 21:00:35.827929 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-17 21:00:35.828090 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb0ec05ba5f0462a9ef6053c672dbf33/work/fb0ec05ba5f0462a9ef6053c672dbf33_id_rsa 2025-06-17 21:00:35.828121 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb0ec05ba5f0462a9ef6053c672dbf33/work/fb0ec05ba5f0462a9ef6053c672dbf33_id_rsa.pub 2025-06-17 21:00:35.828142 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-17 21:00:35.828162 | debian-bookworm -> localhost | SHA256:54hFFlS4G+xQwihn7X9rCwLb+sdhNHWdK+b066Cc7FE zuul-build-sshkey 2025-06-17 21:00:35.828181 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-17 21:00:35.828205 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-17 21:00:35.828223 | debian-bookworm -> localhost | | + .oo. . . | 2025-06-17 21:00:35.828241 | debian-bookworm -> localhost | | . + + o.. . o | 2025-06-17 21:00:35.828258 | debian-bookworm -> localhost | | + . +oo . . | 2025-06-17 21:00:35.828274 | debian-bookworm -> localhost | | oo* + . | 2025-06-17 21:00:35.828290 | debian-bookworm -> localhost | | . =S+.+Eo | 2025-06-17 21:00:35.828310 | debian-bookworm -> localhost | | + o*+... . | 2025-06-17 21:00:35.828327 | debian-bookworm -> localhost | | . +oooo.. . | 2025-06-17 21:00:35.828343 | debian-bookworm -> localhost | | . .o+o+ .. | 2025-06-17 21:00:35.828360 | debian-bookworm -> localhost | | .... oB. .. | 2025-06-17 21:00:35.828376 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-17 21:00:35.828420 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.873237 2025-06-17 21:00:35.836814 | 2025-06-17 21:00:35.836897 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-17 21:00:35.904973 | debian-bookworm | ok 2025-06-17 21:00:35.912408 | debian-bookworm | included: /var/lib/zuul/builds/fb0ec05ba5f0462a9ef6053c672dbf33/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-17 21:00:35.929812 | 2025-06-17 21:00:35.929905 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-17 21:00:35.972643 | debian-bookworm | skipping: Conditional result was False 2025-06-17 21:00:35.977540 | 2025-06-17 21:00:35.977621 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-17 21:00:36.793829 | debian-bookworm | changed 2025-06-17 21:00:36.798197 | 2025-06-17 21:00:36.798276 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-17 21:00:37.088719 | debian-bookworm | ok 2025-06-17 21:00:37.093447 | 2025-06-17 21:00:37.093524 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-17 21:00:37.798727 | debian-bookworm | changed 2025-06-17 21:00:37.805966 | 2025-06-17 21:00:37.806058 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-17 21:00:38.395853 | debian-bookworm | changed 2025-06-17 21:00:38.400245 | 2025-06-17 21:00:38.400323 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-17 21:00:38.425934 | debian-bookworm | skipping: Conditional result was False 2025-06-17 21:00:38.433038 | 2025-06-17 21:00:38.433141 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-17 21:00:38.850595 | debian-bookworm -> localhost | changed 2025-06-17 21:00:38.860724 | 2025-06-17 21:00:38.860815 | TASK [add-build-sshkey : Add back temp key] 2025-06-17 21:00:39.251689 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fb0ec05ba5f0462a9ef6053c672dbf33/work/fb0ec05ba5f0462a9ef6053c672dbf33_id_rsa (zuul-build-sshkey) 2025-06-17 21:00:39.251878 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019099 2025-06-17 21:00:39.258404 | 2025-06-17 21:00:39.258486 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-17 21:00:39.622893 | debian-bookworm | ok 2025-06-17 21:00:39.627711 | 2025-06-17 21:00:39.627800 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-17 21:00:39.650823 | debian-bookworm | skipping: Conditional result was False 2025-06-17 21:00:39.660798 | 2025-06-17 21:00:39.660903 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-17 21:00:40.136053 | debian-bookworm | ok 2025-06-17 21:00:40.157763 | 2025-06-17 21:00:40.157874 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-17 21:00:40.206343 | debian-bookworm | ok 2025-06-17 21:00:40.211557 | 2025-06-17 21:00:40.211680 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-17 21:00:40.665985 | debian-bookworm -> localhost | ok 2025-06-17 21:00:40.672226 | 2025-06-17 21:00:40.672324 | TASK [validate-host : Collect information about the host] 2025-06-17 21:00:42.114439 | debian-bookworm | ok 2025-06-17 21:00:42.125398 | 2025-06-17 21:00:42.125492 | TASK [validate-host : Sanitize hostname] 2025-06-17 21:00:42.233719 | debian-bookworm | ok 2025-06-17 21:00:42.316091 | 2025-06-17 21:00:42.316185 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-17 21:00:43.476044 | debian-bookworm -> localhost | changed 2025-06-17 21:00:43.480535 | 2025-06-17 21:00:43.480621 | TASK [validate-host : Collect information about zuul worker] 2025-06-17 21:00:43.922338 | debian-bookworm | ok 2025-06-17 21:00:43.926380 | 2025-06-17 21:00:43.926506 | TASK [validate-host : Write out all zuul information for each host] 2025-06-17 21:00:44.636722 | debian-bookworm -> localhost | changed 2025-06-17 21:00:44.645579 | 2025-06-17 21:00:44.645700 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-17 21:00:44.935072 | debian-bookworm | ok 2025-06-17 21:00:44.940668 | 2025-06-17 21:00:44.940764 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-17 21:00:46.339796 | debian-bookworm | changed: 2025-06-17 21:00:46.339968 | debian-bookworm | cd+++++++++ src/ 2025-06-17 21:00:46.340002 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-17 21:00:46.340026 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-17 21:00:46.340048 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-06-17 21:00:46.340068 | debian-bookworm | Containerfile 2025-06-17 21:00:46.340200 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009995 2025-06-17 21:01:12.090711 | 2025-06-17 21:01:12.091706 | TASK [upload-logs : Upload logs to log server] 2025-06-17 21:01:12.657292 | localhost | Output suppressed because no_log was given 2025-06-17 21:01:12.659353 | 2025-06-17 21:01:12.659464 | LOOP [upload-logs : Compress console log and json output] 2025-06-17 21:01:12.706510 | localhost | skipping: Conditional result was False 2025-06-17 21:01:12.712507 | localhost | skipping: Conditional result was False 2025-06-17 21:01:12.715959 | 2025-06-17 21:01:12.716065 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-17 21:01:12.762161 | localhost | skipping: Conditional result was False 2025-06-17 21:01:12.762486 | 2025-06-17 21:01:12.767149 | localhost | skipping: Conditional result was False 2025-06-17 21:01:12.772371 | 2025-06-17 21:01:12.772480 | LOOP [upload-logs : Upload console log and json output]