2025-09-19 03:06:13.795627 | Job console starting 2025-09-19 03:06:13.817946 | Updating git repos 2025-09-19 03:06:13.855168 | Cloning repos into workspace 2025-09-19 03:06:13.948672 | Restoring repo states 2025-09-19 03:06:13.967496 | Merging changes 2025-09-19 03:06:13.967517 | Checking out repos 2025-09-19 03:06:14.078762 | Preparing playbooks 2025-09-19 03:06:15.062995 | Running Ansible setup 2025-09-19 03:06:20.642010 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-19 03:06:21.760091 | 2025-09-19 03:06:21.760212 | PLAY [Base pre] 2025-09-19 03:06:21.774479 | 2025-09-19 03:06:21.774587 | TASK [Setup log path fact] 2025-09-19 03:06:21.792434 | debian-bookworm | ok 2025-09-19 03:06:21.808045 | 2025-09-19 03:06:21.808169 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-19 03:06:21.836869 | debian-bookworm | ok 2025-09-19 03:06:21.851104 | 2025-09-19 03:06:21.851210 | TASK [emit-job-header : Print job information] 2025-09-19 03:06:21.890059 | # Job Information 2025-09-19 03:06:21.890212 | Ansible Version: 2.16.14 2025-09-19 03:06:21.890246 | Job: python-black 2025-09-19 03:06:21.890278 | Pipeline: periodic-daily 2025-09-19 03:06:21.890300 | Executor: 521e9411259a 2025-09-19 03:06:21.890321 | Triggered by: https://github.com/osism/openstack-sandbox-manager 2025-09-19 03:06:21.890342 | Event ID: 966f7a5c6e794acbaa22fc6b94a5e2d6 2025-09-19 03:06:21.895040 | 2025-09-19 03:06:21.895135 | LOOP [emit-job-header : Print node information] 2025-09-19 03:06:22.001984 | debian-bookworm | ok: 2025-09-19 03:06:22.002243 | debian-bookworm | # Node Information 2025-09-19 03:06:22.002281 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-19 03:06:22.002307 | debian-bookworm | Hostname: debian 2025-09-19 03:06:22.002329 | debian-bookworm | Username: zuul 2025-09-19 03:06:22.002350 | debian-bookworm | Distro: Debian 12.12 2025-09-19 03:06:22.002372 | debian-bookworm | Provider: regiocloud-a 2025-09-19 03:06:22.002393 | debian-bookworm | Region: 2025-09-19 03:06:22.002413 | debian-bookworm | Label: debian-bookworm 2025-09-19 03:06:22.002433 | debian-bookworm | Product Name: OpenStack Nova 2025-09-19 03:06:22.002452 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe42:a123 2025-09-19 03:06:22.022203 | 2025-09-19 03:06:22.022307 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-19 03:06:22.516037 | debian-bookworm -> localhost | changed 2025-09-19 03:06:22.524807 | 2025-09-19 03:06:22.524920 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-19 03:06:23.540360 | debian-bookworm -> localhost | changed 2025-09-19 03:06:23.554999 | 2025-09-19 03:06:23.555300 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-19 03:06:23.871061 | debian-bookworm -> localhost | ok 2025-09-19 03:06:23.876023 | 2025-09-19 03:06:23.876118 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-19 03:06:23.892457 | debian-bookworm | ok 2025-09-19 03:06:23.905948 | debian-bookworm | included: /var/lib/zuul/builds/9c7ba481286b41afa6943914ba4acd0c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-19 03:06:23.910689 | 2025-09-19 03:06:23.910827 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-19 03:06:25.050702 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-19 03:06:25.050982 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9c7ba481286b41afa6943914ba4acd0c/work/9c7ba481286b41afa6943914ba4acd0c_id_rsa 2025-09-19 03:06:25.051035 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9c7ba481286b41afa6943914ba4acd0c/work/9c7ba481286b41afa6943914ba4acd0c_id_rsa.pub 2025-09-19 03:06:25.051071 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-19 03:06:25.051105 | debian-bookworm -> localhost | SHA256:4ANGqDjcpaIPp+NKWWFH1kcWRkCujE1ss0jDlHHSEhU zuul-build-sshkey 2025-09-19 03:06:25.051136 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-19 03:06:25.051177 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-19 03:06:25.051208 | debian-bookworm -> localhost | | *BE+o+*. | 2025-09-19 03:06:25.051237 | debian-bookworm -> localhost | | ++*o..o. | 2025-09-19 03:06:25.051265 | debian-bookworm -> localhost | |o..***... | 2025-09-19 03:06:25.051291 | debian-bookworm -> localhost | |+oo+@o+. | 2025-09-19 03:06:25.051317 | debian-bookworm -> localhost | |...+ =o S | 2025-09-19 03:06:25.051355 | debian-bookworm -> localhost | |o + . | 2025-09-19 03:06:25.051383 | debian-bookworm -> localhost | | B | 2025-09-19 03:06:25.051411 | debian-bookworm -> localhost | |+ . | 2025-09-19 03:06:25.051445 | debian-bookworm -> localhost | |+o | 2025-09-19 03:06:25.051491 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-19 03:06:25.051558 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.632629 2025-09-19 03:06:25.066778 | 2025-09-19 03:06:25.066897 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-19 03:06:25.091219 | debian-bookworm | ok 2025-09-19 03:06:25.100017 | debian-bookworm | included: /var/lib/zuul/builds/9c7ba481286b41afa6943914ba4acd0c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-19 03:06:25.109088 | 2025-09-19 03:06:25.109169 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-19 03:06:25.124215 | debian-bookworm | skipping: Conditional result was False 2025-09-19 03:06:25.129563 | 2025-09-19 03:06:25.129645 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-19 03:06:25.774544 | debian-bookworm | changed 2025-09-19 03:06:25.786605 | 2025-09-19 03:06:25.786783 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-19 03:06:26.057681 | debian-bookworm | ok 2025-09-19 03:06:26.063013 | 2025-09-19 03:06:26.063101 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-19 03:06:26.735405 | debian-bookworm | changed 2025-09-19 03:06:26.742362 | 2025-09-19 03:06:26.742465 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-19 03:06:27.386352 | debian-bookworm | changed 2025-09-19 03:06:27.395114 | 2025-09-19 03:06:27.395242 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-19 03:06:27.419128 | debian-bookworm | skipping: Conditional result was False 2025-09-19 03:06:27.425863 | 2025-09-19 03:06:27.425964 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-19 03:06:27.804312 | debian-bookworm -> localhost | changed 2025-09-19 03:06:27.822586 | 2025-09-19 03:06:27.822703 | TASK [add-build-sshkey : Add back temp key] 2025-09-19 03:06:28.182006 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9c7ba481286b41afa6943914ba4acd0c/work/9c7ba481286b41afa6943914ba4acd0c_id_rsa (zuul-build-sshkey) 2025-09-19 03:06:28.182263 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013499 2025-09-19 03:06:28.191154 | 2025-09-19 03:06:28.191296 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-19 03:06:28.604229 | debian-bookworm | ok 2025-09-19 03:06:28.609887 | 2025-09-19 03:06:28.610009 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-19 03:06:28.633935 | debian-bookworm | skipping: Conditional result was False 2025-09-19 03:06:28.644796 | 2025-09-19 03:06:28.644914 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-19 03:06:29.130525 | debian-bookworm | ok 2025-09-19 03:06:29.149226 | 2025-09-19 03:06:29.149371 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-19 03:06:29.194371 | debian-bookworm | ok 2025-09-19 03:06:29.203039 | 2025-09-19 03:06:29.203206 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-19 03:06:29.502124 | debian-bookworm -> localhost | ok 2025-09-19 03:06:29.510242 | 2025-09-19 03:06:29.510593 | TASK [validate-host : Collect information about the host] 2025-09-19 03:06:30.882728 | debian-bookworm | ok 2025-09-19 03:06:30.900119 | 2025-09-19 03:06:30.900255 | TASK [validate-host : Sanitize hostname] 2025-09-19 03:06:31.025066 | debian-bookworm | ok 2025-09-19 03:06:31.075127 | 2025-09-19 03:06:31.075271 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-19 03:06:32.045440 | debian-bookworm -> localhost | changed 2025-09-19 03:06:32.052109 | 2025-09-19 03:06:32.052242 | TASK [validate-host : Collect information about zuul worker] 2025-09-19 03:06:32.671265 | debian-bookworm | ok 2025-09-19 03:06:32.676289 | 2025-09-19 03:06:32.676413 | TASK [validate-host : Write out all zuul information for each host] 2025-09-19 03:06:33.415119 | debian-bookworm -> localhost | changed 2025-09-19 03:06:33.431550 | 2025-09-19 03:06:33.431747 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-19 03:06:33.703775 | debian-bookworm | ok 2025-09-19 03:06:33.709721 | 2025-09-19 03:06:33.709844 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-19 03:06:34.759640 | debian-bookworm | changed: 2025-09-19 03:06:34.759874 | debian-bookworm | cd+++++++++ src/ 2025-09-19 03:06:34.759908 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-19 03:06:34.759932 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-19 03:06:34.759954 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-sandbox-manager/ 2025-09-19 03:06:34.759974 | debian-bookworm | localhost | ok: Runtime: 0:00:00.027707 2025-09-19 03:07:03.088924 | 2025-09-19 03:07:03.089006 | TASK [upload-logs : Upload logs to log server] 2025-09-19 03:07:04.068851 | localhost | Output suppressed because no_log was given 2025-09-19 03:07:04.070202 | 2025-09-19 03:07:04.070274 | LOOP [upload-logs : Compress console log and json output] 2025-09-19 03:07:04.123831 | localhost | skipping: Conditional result was False 2025-09-19 03:07:04.136491 | localhost | skipping: Conditional result was False 2025-09-19 03:07:04.146231 | 2025-09-19 03:07:04.146327 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-19 03:07:04.181001 | localhost | skipping: Conditional result was False 2025-09-19 03:07:04.181267 | 2025-09-19 03:07:04.184921 | localhost | skipping: Conditional result was False 2025-09-19 03:07:04.190793 | 2025-09-19 03:07:04.190893 | LOOP [upload-logs : Upload console log and json output]