2025-08-19 18:53:09.939366 | Job console starting 2025-08-19 18:53:09.977490 | Updating git repos 2025-08-19 18:53:10.009322 | Cloning repos into workspace 2025-08-19 18:53:10.058649 | Restoring repo states 2025-08-19 18:53:10.067066 | Merging changes 2025-08-19 18:53:10.725003 | Checking out repos 2025-08-19 18:53:10.811366 | Preparing playbooks 2025-08-19 18:53:11.978372 | Running Ansible setup 2025-08-19 18:53:18.691746 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-19 18:53:20.216980 | 2025-08-19 18:53:20.217110 | PLAY [Base pre] 2025-08-19 18:53:20.257017 | 2025-08-19 18:53:20.257140 | TASK [Setup log path fact] 2025-08-19 18:53:20.286008 | debian-bookworm | ok 2025-08-19 18:53:20.316815 | 2025-08-19 18:53:20.316997 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-19 18:53:20.366138 | debian-bookworm | ok 2025-08-19 18:53:20.382478 | 2025-08-19 18:53:20.382584 | TASK [emit-job-header : Print job information] 2025-08-19 18:53:20.431713 | # Job Information 2025-08-19 18:53:20.431866 | Ansible Version: 2.16.14 2025-08-19 18:53:20.431899 | Job: python-black 2025-08-19 18:53:20.431932 | Pipeline: check 2025-08-19 18:53:20.431955 | Executor: 521e9411259a 2025-08-19 18:53:20.431976 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/773 2025-08-19 18:53:20.431999 | Event ID: baa9b5d0-7d2d-11f0-878a-fa955de82623 2025-08-19 18:53:20.436714 | 2025-08-19 18:53:20.436816 | LOOP [emit-job-header : Print node information] 2025-08-19 18:53:20.756274 | debian-bookworm | ok: 2025-08-19 18:53:20.756455 | debian-bookworm | # Node Information 2025-08-19 18:53:20.756489 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-19 18:53:20.756514 | debian-bookworm | Hostname: debian 2025-08-19 18:53:20.756536 | debian-bookworm | Username: zuul 2025-08-19 18:53:20.756557 | debian-bookworm | Distro: Debian 12.11 2025-08-19 18:53:20.756581 | debian-bookworm | Provider: regiocloud-a 2025-08-19 18:53:20.756602 | debian-bookworm | Region: 2025-08-19 18:53:20.756623 | debian-bookworm | Label: debian-bookworm 2025-08-19 18:53:20.756642 | debian-bookworm | Product Name: OpenStack Nova 2025-08-19 18:53:20.756662 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe28:2d4e 2025-08-19 18:53:20.779869 | 2025-08-19 18:53:20.779993 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-19 18:53:21.968113 | debian-bookworm -> localhost | changed 2025-08-19 18:53:21.975604 | 2025-08-19 18:53:21.975741 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-19 18:53:24.259785 | debian-bookworm -> localhost | changed 2025-08-19 18:53:24.278073 | 2025-08-19 18:53:24.278179 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-19 18:53:25.009089 | debian-bookworm -> localhost | ok 2025-08-19 18:53:25.014814 | 2025-08-19 18:53:25.014936 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-19 18:53:25.071140 | debian-bookworm | ok 2025-08-19 18:53:25.124869 | debian-bookworm | included: /var/lib/zuul/builds/5da10fa922aa4bfc80e5a951099ab9e8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-19 18:53:25.149366 | 2025-08-19 18:53:25.149483 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-19 18:53:26.772579 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-19 18:53:26.772769 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/5da10fa922aa4bfc80e5a951099ab9e8/work/5da10fa922aa4bfc80e5a951099ab9e8_id_rsa 2025-08-19 18:53:26.772807 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/5da10fa922aa4bfc80e5a951099ab9e8/work/5da10fa922aa4bfc80e5a951099ab9e8_id_rsa.pub 2025-08-19 18:53:26.772832 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-19 18:53:26.772855 | debian-bookworm -> localhost | SHA256:LdrVT1QurZt5QE6gx3u3Y0hJUfZg+qI03ISrtLyY3DE zuul-build-sshkey 2025-08-19 18:53:26.772877 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-19 18:53:26.772907 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-19 18:53:26.772929 | debian-bookworm -> localhost | | ..+o.| 2025-08-19 18:53:26.772951 | debian-bookworm -> localhost | | + +o=.| 2025-08-19 18:53:26.772972 | debian-bookworm -> localhost | | o =.= +| 2025-08-19 18:53:26.772992 | debian-bookworm -> localhost | | o *.B.o | 2025-08-19 18:53:26.773011 | debian-bookworm -> localhost | | S B =oB .| 2025-08-19 18:53:26.773035 | debian-bookworm -> localhost | | = * o.=.*.| 2025-08-19 18:53:26.773055 | debian-bookworm -> localhost | | . E . .=+.| 2025-08-19 18:53:26.773074 | debian-bookworm -> localhost | | . + + ...| 2025-08-19 18:53:26.773094 | debian-bookworm -> localhost | | + o | 2025-08-19 18:53:26.773114 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-19 18:53:26.773165 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.649564 2025-08-19 18:53:26.779290 | 2025-08-19 18:53:26.779402 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-19 18:53:26.810141 | debian-bookworm | ok 2025-08-19 18:53:26.823389 | debian-bookworm | included: /var/lib/zuul/builds/5da10fa922aa4bfc80e5a951099ab9e8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-19 18:53:26.845260 | 2025-08-19 18:53:26.845343 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-19 18:53:26.894536 | debian-bookworm | skipping: Conditional result was False 2025-08-19 18:53:26.899611 | 2025-08-19 18:53:26.899692 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-19 18:53:27.465876 | debian-bookworm | changed 2025-08-19 18:53:27.471267 | 2025-08-19 18:53:27.471381 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-19 18:53:27.761926 | debian-bookworm | ok 2025-08-19 18:53:27.771139 | 2025-08-19 18:53:27.771267 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-19 18:53:28.443749 | debian-bookworm | changed 2025-08-19 18:53:28.450520 | 2025-08-19 18:53:28.450618 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-19 18:53:29.087307 | debian-bookworm | changed 2025-08-19 18:53:29.092527 | 2025-08-19 18:53:29.092629 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-19 18:53:29.122720 | debian-bookworm | skipping: Conditional result was False 2025-08-19 18:53:29.128412 | 2025-08-19 18:53:29.128515 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-19 18:53:29.644930 | debian-bookworm -> localhost | changed 2025-08-19 18:53:29.667072 | 2025-08-19 18:53:29.667172 | TASK [add-build-sshkey : Add back temp key] 2025-08-19 18:53:30.220663 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/5da10fa922aa4bfc80e5a951099ab9e8/work/5da10fa922aa4bfc80e5a951099ab9e8_id_rsa (zuul-build-sshkey) 2025-08-19 18:53:30.220888 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021680 2025-08-19 18:53:30.230479 | 2025-08-19 18:53:30.230584 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-19 18:53:30.725474 | debian-bookworm | ok 2025-08-19 18:53:30.730353 | 2025-08-19 18:53:30.730465 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-19 18:53:30.767256 | debian-bookworm | skipping: Conditional result was False 2025-08-19 18:53:30.777440 | 2025-08-19 18:53:30.777544 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-19 18:53:31.221685 | debian-bookworm | ok 2025-08-19 18:53:31.242876 | 2025-08-19 18:53:31.242980 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-19 18:53:31.270620 | debian-bookworm | ok 2025-08-19 18:53:31.275809 | 2025-08-19 18:53:31.275894 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-19 18:53:31.598387 | debian-bookworm -> localhost | ok 2025-08-19 18:53:31.604532 | 2025-08-19 18:53:31.604625 | TASK [validate-host : Collect information about the host] 2025-08-19 18:53:33.047745 | debian-bookworm | ok 2025-08-19 18:53:33.062915 | 2025-08-19 18:53:33.063023 | TASK [validate-host : Sanitize hostname] 2025-08-19 18:53:33.156769 | debian-bookworm | ok 2025-08-19 18:53:33.191291 | 2025-08-19 18:53:33.191428 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-19 18:53:34.172694 | debian-bookworm -> localhost | changed 2025-08-19 18:53:34.177930 | 2025-08-19 18:53:34.178024 | TASK [validate-host : Collect information about zuul worker] 2025-08-19 18:53:34.683457 | debian-bookworm | ok 2025-08-19 18:53:34.687959 | 2025-08-19 18:53:34.688048 | TASK [validate-host : Write out all zuul information for each host] 2025-08-19 18:53:35.380959 | debian-bookworm -> localhost | changed 2025-08-19 18:53:35.391044 | 2025-08-19 18:53:35.391139 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-19 18:53:35.672365 | debian-bookworm | ok 2025-08-19 18:53:35.678010 | 2025-08-19 18:53:35.683166 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-19 18:53:36.764364 | debian-bookworm | changed: 2025-08-19 18:53:36.764542 | debian-bookworm | cd+++++++++ src/ 2025-08-19 18:53:36.764576 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-19 18:53:36.764599 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-19 18:53:36.764620 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-08-19 18:53:36.764640 | debian-bookworm | Containerfile 2025-08-19 18:53:36.764767 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006496 2025-08-19 18:54:02.188175 | 2025-08-19 18:54:02.188314 | TASK [upload-logs : Upload logs to log server] 2025-08-19 18:54:02.804390 | localhost | Output suppressed because no_log was given 2025-08-19 18:54:02.807342 | 2025-08-19 18:54:02.807475 | LOOP [upload-logs : Compress console log and json output] 2025-08-19 18:54:02.862961 | localhost | skipping: Conditional result was False 2025-08-19 18:54:02.871243 | localhost | skipping: Conditional result was False 2025-08-19 18:54:02.877845 | 2025-08-19 18:54:02.877958 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-19 18:54:02.924533 | localhost | skipping: Conditional result was False 2025-08-19 18:54:02.924920 | 2025-08-19 18:54:02.931725 | localhost | skipping: Conditional result was False 2025-08-19 18:54:02.937764 | 2025-08-19 18:54:02.937875 | LOOP [upload-logs : Upload console log and json output]