2025-09-25 19:56:02.141457 | Job console starting 2025-09-25 19:56:02.150729 | Updating git repos 2025-09-25 19:56:02.190731 | Cloning repos into workspace 2025-09-25 19:56:02.254065 | Restoring repo states 2025-09-25 19:56:02.260331 | Merging changes 2025-09-25 19:56:02.729477 | Checking out repos 2025-09-25 19:56:02.755893 | Preparing playbooks 2025-09-25 19:56:03.542022 | Running Ansible setup 2025-09-25 19:56:08.674694 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-25 19:56:09.677067 | 2025-09-25 19:56:09.677223 | PLAY [Base pre] 2025-09-25 19:56:09.697327 | 2025-09-25 19:56:09.697465 | TASK [Setup log path fact] 2025-09-25 19:56:09.728049 | debian-bookworm | ok 2025-09-25 19:56:09.743462 | 2025-09-25 19:56:09.743608 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-25 19:56:09.773941 | debian-bookworm | ok 2025-09-25 19:56:09.783637 | 2025-09-25 19:56:09.783783 | TASK [emit-job-header : Print job information] 2025-09-25 19:56:09.832893 | # Job Information 2025-09-25 19:56:09.833079 | Ansible Version: 2.16.14 2025-09-25 19:56:09.833113 | Job: python-black 2025-09-25 19:56:09.833145 | Pipeline: check 2025-09-25 19:56:09.833167 | Executor: 521e9411259a 2025-09-25 19:56:09.833188 | Triggered by: https://github.com/osism/openstack-image-manager/pull/944 2025-09-25 19:56:09.833210 | Event ID: a4694d60-9a49-11f0-9a83-331a5412c3fd 2025-09-25 19:56:09.838150 | 2025-09-25 19:56:09.838262 | LOOP [emit-job-header : Print node information] 2025-09-25 19:56:09.950610 | debian-bookworm | ok: 2025-09-25 19:56:09.950957 | debian-bookworm | # Node Information 2025-09-25 19:56:09.951000 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-25 19:56:09.951026 | debian-bookworm | Hostname: debian 2025-09-25 19:56:09.951048 | debian-bookworm | Username: zuul 2025-09-25 19:56:09.951069 | debian-bookworm | Distro: Debian 12.12 2025-09-25 19:56:09.951102 | debian-bookworm | Provider: regiocloud-a 2025-09-25 19:56:09.951129 | debian-bookworm | Region: 2025-09-25 19:56:09.951150 | debian-bookworm | Label: debian-bookworm 2025-09-25 19:56:09.951171 | debian-bookworm | Product Name: OpenStack Nova 2025-09-25 19:56:09.951191 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fee6:9548 2025-09-25 19:56:09.980308 | 2025-09-25 19:56:09.980447 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-25 19:56:10.578747 | debian-bookworm -> localhost | changed 2025-09-25 19:56:10.586342 | 2025-09-25 19:56:10.586486 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-25 19:56:11.911421 | debian-bookworm -> localhost | changed 2025-09-25 19:56:11.923552 | 2025-09-25 19:56:11.923709 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-25 19:56:12.170944 | debian-bookworm -> localhost | ok 2025-09-25 19:56:12.175705 | 2025-09-25 19:56:12.175797 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-25 19:56:12.191710 | debian-bookworm | ok 2025-09-25 19:56:12.205465 | debian-bookworm | included: /var/lib/zuul/builds/e49e88118ea34e9bb202e0d1f56ef63f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-25 19:56:12.210124 | 2025-09-25 19:56:12.210193 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-25 19:56:13.121981 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-25 19:56:13.122142 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e49e88118ea34e9bb202e0d1f56ef63f/work/e49e88118ea34e9bb202e0d1f56ef63f_id_rsa 2025-09-25 19:56:13.122172 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e49e88118ea34e9bb202e0d1f56ef63f/work/e49e88118ea34e9bb202e0d1f56ef63f_id_rsa.pub 2025-09-25 19:56:13.122195 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-25 19:56:13.122215 | debian-bookworm -> localhost | SHA256:nawZLkhbZstRR4IHMO429g+rNwg2Q1mj5UBQhhw5UrM zuul-build-sshkey 2025-09-25 19:56:13.122233 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-25 19:56:13.122260 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-25 19:56:13.122279 | debian-bookworm -> localhost | |oBO o..o. . | 2025-09-25 19:56:13.122298 | debian-bookworm -> localhost | |o=.++.. .o | 2025-09-25 19:56:13.122315 | debian-bookworm -> localhost | |. EB.. .. . | 2025-09-25 19:56:13.122331 | debian-bookworm -> localhost | | +.. . + . | 2025-09-25 19:56:13.122348 | debian-bookworm -> localhost | | . * = S + | 2025-09-25 19:56:13.122367 | debian-bookworm -> localhost | | =+ X + + | 2025-09-25 19:56:13.122384 | debian-bookworm -> localhost | | . +o.* + | 2025-09-25 19:56:13.122401 | debian-bookworm -> localhost | | . o= | 2025-09-25 19:56:13.122419 | debian-bookworm -> localhost | | .o... | 2025-09-25 19:56:13.122437 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-25 19:56:13.122479 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.374172 2025-09-25 19:56:13.127467 | 2025-09-25 19:56:13.127543 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-25 19:56:13.143198 | debian-bookworm | ok 2025-09-25 19:56:13.150201 | debian-bookworm | included: /var/lib/zuul/builds/e49e88118ea34e9bb202e0d1f56ef63f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-25 19:56:13.169009 | 2025-09-25 19:56:13.169075 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-25 19:56:13.201219 | debian-bookworm | skipping: Conditional result was False 2025-09-25 19:56:13.205560 | 2025-09-25 19:56:13.205625 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-25 19:56:13.825311 | debian-bookworm | changed 2025-09-25 19:56:13.829754 | 2025-09-25 19:56:13.829840 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-25 19:56:14.105779 | debian-bookworm | ok 2025-09-25 19:56:14.113683 | 2025-09-25 19:56:14.113829 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-25 19:56:14.791239 | debian-bookworm | changed 2025-09-25 19:56:14.801935 | 2025-09-25 19:56:14.802060 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-25 19:56:15.501234 | debian-bookworm | changed 2025-09-25 19:56:15.509694 | 2025-09-25 19:56:15.509850 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-25 19:56:15.534134 | debian-bookworm | skipping: Conditional result was False 2025-09-25 19:56:15.540948 | 2025-09-25 19:56:15.541083 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-25 19:56:15.978075 | debian-bookworm -> localhost | changed 2025-09-25 19:56:15.988456 | 2025-09-25 19:56:15.988565 | TASK [add-build-sshkey : Add back temp key] 2025-09-25 19:56:16.295352 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e49e88118ea34e9bb202e0d1f56ef63f/work/e49e88118ea34e9bb202e0d1f56ef63f_id_rsa (zuul-build-sshkey) 2025-09-25 19:56:16.295558 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013842 2025-09-25 19:56:16.312431 | 2025-09-25 19:56:16.312527 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-25 19:56:16.687120 | debian-bookworm | ok 2025-09-25 19:56:16.692052 | 2025-09-25 19:56:16.692153 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-25 19:56:16.726089 | debian-bookworm | skipping: Conditional result was False 2025-09-25 19:56:16.736146 | 2025-09-25 19:56:16.736245 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-25 19:56:17.157475 | debian-bookworm | ok 2025-09-25 19:56:17.173350 | 2025-09-25 19:56:17.173455 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-25 19:56:17.211082 | debian-bookworm | ok 2025-09-25 19:56:17.215942 | 2025-09-25 19:56:17.216033 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-25 19:56:17.462018 | debian-bookworm -> localhost | ok 2025-09-25 19:56:17.476020 | 2025-09-25 19:56:17.476164 | TASK [validate-host : Collect information about the host] 2025-09-25 19:56:18.631740 | debian-bookworm | ok 2025-09-25 19:56:18.645188 | 2025-09-25 19:56:18.645284 | TASK [validate-host : Sanitize hostname] 2025-09-25 19:56:18.742085 | debian-bookworm | ok 2025-09-25 19:56:18.772301 | 2025-09-25 19:56:18.772401 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-25 19:56:19.280929 | debian-bookworm -> localhost | changed 2025-09-25 19:56:19.286168 | 2025-09-25 19:56:19.286254 | TASK [validate-host : Collect information about zuul worker] 2025-09-25 19:56:19.666725 | debian-bookworm | ok 2025-09-25 19:56:19.671698 | 2025-09-25 19:56:19.671811 | TASK [validate-host : Write out all zuul information for each host] 2025-09-25 19:56:20.261852 | debian-bookworm -> localhost | changed 2025-09-25 19:56:20.272140 | 2025-09-25 19:56:20.272259 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-25 19:56:20.545754 | debian-bookworm | ok 2025-09-25 19:56:20.551802 | 2025-09-25 19:56:20.551926 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-25 19:56:21.872669 | debian-bookworm | changed: 2025-09-25 19:56:21.872915 | debian-bookworm | cd+++++++++ src/ 2025-09-25 19:56:21.872952 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-25 19:56:21.872976 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-25 19:56:21.872998 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-25 19:56:21.873018 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007283 2025-09-25 19:56:47.077719 | 2025-09-25 19:56:47.077866 | TASK [upload-logs : Upload logs to log server] 2025-09-25 19:56:47.684628 | localhost | Output suppressed because no_log was given 2025-09-25 19:56:47.686494 | 2025-09-25 19:56:47.686595 | LOOP [upload-logs : Compress console log and json output] 2025-09-25 19:56:47.731495 | localhost | skipping: Conditional result was False 2025-09-25 19:56:47.737356 | localhost | skipping: Conditional result was False 2025-09-25 19:56:47.744381 | 2025-09-25 19:56:47.744490 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-25 19:56:47.803883 | localhost | skipping: Conditional result was False 2025-09-25 19:56:47.804158 | 2025-09-25 19:56:47.808953 | localhost | skipping: Conditional result was False 2025-09-25 19:56:47.821764 | 2025-09-25 19:56:47.821930 | LOOP [upload-logs : Upload console log and json output]